builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-062 starttime: 1462790484.75 results: success (0) buildid: 20160509021943 builduid: dd03919b53644c46859a963eee0d3790 revision: 748b70bcdbc95a4f3e72ca53a23c8f766049d011 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 03:41:24.747834) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 03:41:24.748267) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 03:41:24.748558) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 03:41:24.764452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:41:24.764743) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 03:41:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-05-09 03:41:25 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081851 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:41:24.859227) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:41:24.859547) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020930 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:41:24.909171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:41:24.909544) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 748b70bcdbc95a4f3e72ca53a23c8f766049d011 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 748b70bcdbc95a4f3e72ca53a23c8f766049d011 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 03:41:25,656 truncating revision to first 12 chars 2016-05-09 03:41:25,656 Setting DEBUG logging. 2016-05-09 03:41:25,656 attempt 1/10 2016-05-09 03:41:25,656 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/748b70bcdbc9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 03:41:25,917 unpacking tar archive at: mozilla-central-748b70bcdbc9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.566151 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:41:25.488313) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 03:41:25.488641) ========= script_repo_revision: 748b70bcdbc95a4f3e72ca53a23c8f766049d011 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 03:41:25.489012) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 03:41:25.489272) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 03:41:25.497949) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-09 03:41:25.498212) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:41:26 INFO - MultiFileLogger online at 20160509 03:41:26 in /builds/slave/test 03:41:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:41:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:41:26 INFO - {'append_to_log': False, 03:41:26 INFO - 'base_work_dir': '/builds/slave/test', 03:41:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:41:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:41:26 INFO - 'branch': 'Firefox-Non-PGO', 03:41:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:41:26 INFO - 'config_files': ('talos/linux_config.py',), 03:41:26 INFO - 'default_actions': ('clobber', 03:41:26 INFO - 'read-buildbot-config', 03:41:26 INFO - 'download-and-extract', 03:41:26 INFO - 'populate-webroot', 03:41:26 INFO - 'create-virtualenv', 03:41:26 INFO - 'install', 03:41:26 INFO - 'run-tests'), 03:41:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:41:26 INFO - 'download_minidump_stackwalk': True, 03:41:26 INFO - 'download_symbols': 'ondemand', 03:41:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:41:26 INFO - 'tooltool.py': '/tools/tooltool.py', 03:41:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:41:26 INFO - '/tools/misc-python/virtualenv.py')}, 03:41:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:41:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:41:26 INFO - 'installer_path': 'installer.exe', 03:41:26 INFO - 'log_level': 'info', 03:41:26 INFO - 'log_name': 'talos', 03:41:26 INFO - 'log_to_console': True, 03:41:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:41:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:41:26 INFO - 'opt_config_files': (), 03:41:26 INFO - 'pip_index': False, 03:41:26 INFO - 'sps_profile': False, 03:41:26 INFO - 'sps_profile_interval': 0, 03:41:26 INFO - 'suite': 'dromaeojs-e10s', 03:41:26 INFO - 'system_bits': '32', 03:41:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:41:26 INFO - 'title': 'talos-linux64-ix-062', 03:41:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:41:26 INFO - 'use_talos_json': True, 03:41:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:41:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:41:26 INFO - 'work_dir': 'build'} 03:41:26 INFO - ##### 03:41:26 INFO - ##### Running clobber step. 03:41:26 INFO - ##### 03:41:26 INFO - Running pre-action listener: _resource_record_pre_action 03:41:26 INFO - Running main action method: clobber 03:41:26 INFO - rmtree: /builds/slave/test/build 03:41:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:41:27 INFO - Running post-action listener: _resource_record_post_action 03:41:27 INFO - ##### 03:41:27 INFO - ##### Finished clobber step (success) 03:41:27 INFO - ##### 03:41:27 INFO - ##### 03:41:27 INFO - ##### Running read-buildbot-config step. 03:41:27 INFO - ##### 03:41:27 INFO - Running pre-action listener: _resource_record_pre_action 03:41:27 INFO - Running main action method: read_buildbot_config 03:41:27 INFO - Using buildbot properties: 03:41:27 INFO - { 03:41:27 INFO - "project": "", 03:41:27 INFO - "product": "firefox", 03:41:27 INFO - "script_repo_revision": "production", 03:41:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:41:27 INFO - "repository": "", 03:41:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:41:27 INFO - "buildid": "20160509021943", 03:41:27 INFO - "pgo_build": "False", 03:41:27 INFO - "basedir": "/builds/slave/test", 03:41:27 INFO - "buildnumber": 50, 03:41:27 INFO - "slavename": "talos-linux64-ix-062", 03:41:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:41:27 INFO - "platform": "ubuntu64_hw", 03:41:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:41:27 INFO - "branch": "mozilla-central", 03:41:27 INFO - "repo_path": "mozilla-central", 03:41:27 INFO - "revision": "748b70bcdbc95a4f3e72ca53a23c8f766049d011", 03:41:27 INFO - "stage_platform": "linux64", 03:41:27 INFO - "builduid": "dd03919b53644c46859a963eee0d3790", 03:41:27 INFO - "slavebuilddir": "test" 03:41:27 INFO - } 03:41:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 03:41:27 INFO - Running post-action listener: _resource_record_post_action 03:41:27 INFO - ##### 03:41:27 INFO - ##### Finished read-buildbot-config step (success) 03:41:27 INFO - ##### 03:41:27 INFO - ##### 03:41:27 INFO - ##### Running download-and-extract step. 03:41:27 INFO - ##### 03:41:27 INFO - Running pre-action listener: _resource_record_pre_action 03:41:27 INFO - Running main action method: download_and_extract 03:41:27 INFO - mkdir: /builds/slave/test/build/tests 03:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:27 INFO - https://queue.taskcluster.net/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:41:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:41:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:41:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:41:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:41:28 INFO - Downloaded 1361 bytes. 03:41:28 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:41:28 INFO - Using the following test package requirements: 03:41:28 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:41:28 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:41:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:41:28 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:41:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:41:28 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:41:28 INFO - u'jsshell-linux-x86_64.zip'], 03:41:28 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:41:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:41:28 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:41:28 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:41:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:41:28 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:41:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:41:28 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:41:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:41:28 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:41:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:41:28 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:41:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:28 INFO - https://queue.taskcluster.net/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:41:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:41:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:41:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:41:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:41:29 INFO - Downloaded 22322613 bytes. 03:41:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:41:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:41:30 INFO - Return code: 0 03:41:30 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:30 INFO - https://queue.taskcluster.net/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:41:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:41:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:41:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:41:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:41:31 INFO - Downloaded 22322613 bytes. 03:41:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:41:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:41:32 INFO - Return code: 0 03:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:32 INFO - https://queue.taskcluster.net/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:41:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:41:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:41:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:41:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:41:33 INFO - Downloaded 10840152 bytes. 03:41:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:41:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:41:33 INFO - Return code: 0 03:41:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:33 INFO - https://queue.taskcluster.net/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:41:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:41:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:41:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:41:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:41:35 INFO - Downloaded 54858849 bytes. 03:41:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:41:35 INFO - mkdir: /builds/slave/test/properties 03:41:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:41:35 INFO - Writing to file /builds/slave/test/properties/build_url 03:41:35 INFO - Contents: 03:41:35 INFO - build_url:https://queue.taskcluster.net/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:41:36 INFO - Running post-action listener: _resource_record_post_action 03:41:36 INFO - Running post-action listener: set_extra_try_arguments 03:41:36 INFO - ##### 03:41:36 INFO - ##### Finished download-and-extract step (success) 03:41:36 INFO - ##### 03:41:36 INFO - ##### 03:41:36 INFO - ##### Running populate-webroot step. 03:41:36 INFO - ##### 03:41:36 INFO - Running pre-action listener: _resource_record_pre_action 03:41:36 INFO - Running main action method: populate_webroot 03:41:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:41:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:41:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:41:36 INFO - '--tppagecycles', 03:41:36 INFO - '7'], 03:41:36 INFO - 'tests': ['tsvgm']}}, 03:41:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:41:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:41:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:41:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:41:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:41:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:41:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:36 INFO - 'talos_options': ['--disable-e10s'], 03:41:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:41:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:41:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:36 INFO - 'talos_options': ['--disable-e10s'], 03:41:36 INFO - 'tests': ['damp', 'tps']}, 03:41:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:36 INFO - 'tests': ['damp', 'tps']}, 03:41:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:41:36 INFO - 'tests': ['dromaeo_dom']}, 03:41:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:41:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:41:36 INFO - 'tests': ['a11yr', 03:41:36 INFO - 'ts_paint', 03:41:36 INFO - 'tpaint', 03:41:36 INFO - 'sessionrestore', 03:41:36 INFO - 'sessionrestore_no_auto_restore', 03:41:36 INFO - 'tabpaint']}, 03:41:36 INFO - 'other-e10s': {'tests': ['a11yr', 03:41:36 INFO - 'ts_paint', 03:41:36 INFO - 'tpaint', 03:41:36 INFO - 'sessionrestore', 03:41:36 INFO - 'sessionrestore_no_auto_restore', 03:41:36 INFO - 'tabpaint']}, 03:41:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:41:36 INFO - 'ts_paint', 03:41:36 INFO - 'tpaint', 03:41:36 INFO - 'sessionrestore', 03:41:36 INFO - 'sessionrestore_no_auto_restore', 03:41:36 INFO - 'tabpaint']}, 03:41:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:41:36 INFO - 'ts_paint', 03:41:36 INFO - 'tpaint', 03:41:36 INFO - 'sessionrestore', 03:41:36 INFO - 'sessionrestore_no_auto_restore', 03:41:36 INFO - 'tabpaint']}, 03:41:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:41:36 INFO - 'tests': ['a11yr', 03:41:36 INFO - 'ts_paint', 03:41:36 INFO - 'tpaint', 03:41:36 INFO - 'sessionrestore', 03:41:36 INFO - 'sessionrestore_no_auto_restore', 03:41:36 INFO - 'tabpaint']}, 03:41:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:41:36 INFO - 'tests': ['a11yr', 03:41:36 INFO - 'ts_paint', 03:41:36 INFO - 'tpaint', 03:41:36 INFO - 'sessionrestore', 03:41:36 INFO - 'sessionrestore_no_auto_restore', 03:41:36 INFO - 'tabpaint']}, 03:41:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:41:36 INFO - 'tests': ['tsvgx', 03:41:36 INFO - 'tsvgr_opacity', 03:41:36 INFO - 'tart', 03:41:36 INFO - 'tscrollx', 03:41:36 INFO - 'cart']}, 03:41:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:41:36 INFO - 'tsvgr_opacity', 03:41:36 INFO - 'tart', 03:41:36 INFO - 'tscrollx', 03:41:36 INFO - 'cart']}, 03:41:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:36 INFO - 'talos_options': ['--disable-e10s'], 03:41:36 INFO - 'tests': ['tp5o']}, 03:41:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:36 INFO - 'tests': ['tp5o']}, 03:41:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:36 INFO - 'talos_options': ['--disable-e10s', 03:41:36 INFO - '--xperf_path', 03:41:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:41:36 INFO - 'tests': ['tp5n']}, 03:41:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:41:36 INFO - 'talos_options': ['--xperf_path', 03:41:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:41:36 INFO - 'tests': ['tp5n']}}, 03:41:36 INFO - 'talos.zip': {'path': '', 03:41:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:41:36 INFO - Running post-action listener: _resource_record_post_action 03:41:36 INFO - ##### 03:41:36 INFO - ##### Finished populate-webroot step (success) 03:41:36 INFO - ##### 03:41:36 INFO - ##### 03:41:36 INFO - ##### Running create-virtualenv step. 03:41:36 INFO - ##### 03:41:36 INFO - Running pre-action listener: _resource_record_pre_action 03:41:36 INFO - Running main action method: create_virtualenv 03:41:36 INFO - Creating virtualenv /builds/slave/test/build/venv 03:41:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:41:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:41:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:41:36 INFO - Using real prefix '/usr' 03:41:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:41:37 INFO - Installing distribute.............................................................................................................................................................................................done. 03:41:39 INFO - Installing pip.................done. 03:41:39 INFO - Return code: 0 03:41:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f728baaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe35770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec49c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:41:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:41:39 INFO - Using env: {'DISPLAY': ':0', 03:41:39 INFO - 'HOME': '/home/cltbld', 03:41:39 INFO - 'LANG': 'en_US.UTF-8', 03:41:39 INFO - 'LANGUAGE': 'en_US:en', 03:41:39 INFO - 'LOGNAME': 'cltbld', 03:41:39 INFO - 'MAIL': '/var/mail/cltbld', 03:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:39 INFO - 'MOZ_NO_REMOTE': '1', 03:41:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:39 INFO - 'NO_EM_RESTART': '1', 03:41:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:39 INFO - 'PWD': '/builds/slave/test', 03:41:39 INFO - 'SHELL': '/bin/bash', 03:41:39 INFO - 'SHLVL': '1', 03:41:39 INFO - 'TERM': 'linux', 03:41:39 INFO - 'TMOUT': '86400', 03:41:39 INFO - 'USER': 'cltbld', 03:41:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281', 03:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:39 INFO - '_': '/tools/buildbot/bin/python'} 03:41:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:41:39 INFO - Cleaning up... 03:41:39 INFO - Return code: 0 03:41:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f728baaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe35770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec49c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:41:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:41:39 INFO - Using env: {'DISPLAY': ':0', 03:41:39 INFO - 'HOME': '/home/cltbld', 03:41:39 INFO - 'LANG': 'en_US.UTF-8', 03:41:39 INFO - 'LANGUAGE': 'en_US:en', 03:41:39 INFO - 'LOGNAME': 'cltbld', 03:41:39 INFO - 'MAIL': '/var/mail/cltbld', 03:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:39 INFO - 'MOZ_NO_REMOTE': '1', 03:41:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:39 INFO - 'NO_EM_RESTART': '1', 03:41:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:39 INFO - 'PWD': '/builds/slave/test', 03:41:39 INFO - 'SHELL': '/bin/bash', 03:41:39 INFO - 'SHLVL': '1', 03:41:39 INFO - 'TERM': 'linux', 03:41:39 INFO - 'TMOUT': '86400', 03:41:39 INFO - 'USER': 'cltbld', 03:41:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281', 03:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:39 INFO - '_': '/tools/buildbot/bin/python'} 03:41:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:39 INFO - Downloading/unpacking psutil>=0.7.1 03:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:41:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:41 INFO - Installing collected packages: psutil 03:41:41 INFO - Running setup.py install for psutil 03:41:41 INFO - building 'psutil._psutil_linux' extension 03:41:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:41:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:41:41 INFO - building 'psutil._psutil_posix' extension 03:41:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:41:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:41:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:41:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:41:42 INFO - Successfully installed psutil 03:41:42 INFO - Cleaning up... 03:41:42 INFO - Return code: 0 03:41:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f728baaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe35770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec49c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:41:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:41:42 INFO - Using env: {'DISPLAY': ':0', 03:41:42 INFO - 'HOME': '/home/cltbld', 03:41:42 INFO - 'LANG': 'en_US.UTF-8', 03:41:42 INFO - 'LANGUAGE': 'en_US:en', 03:41:42 INFO - 'LOGNAME': 'cltbld', 03:41:42 INFO - 'MAIL': '/var/mail/cltbld', 03:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:42 INFO - 'MOZ_NO_REMOTE': '1', 03:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:42 INFO - 'NO_EM_RESTART': '1', 03:41:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:42 INFO - 'PWD': '/builds/slave/test', 03:41:42 INFO - 'SHELL': '/bin/bash', 03:41:42 INFO - 'SHLVL': '1', 03:41:42 INFO - 'TERM': 'linux', 03:41:42 INFO - 'TMOUT': '86400', 03:41:42 INFO - 'USER': 'cltbld', 03:41:42 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281', 03:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:42 INFO - '_': '/tools/buildbot/bin/python'} 03:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:41:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:41:44 INFO - Installing collected packages: mozsystemmonitor 03:41:44 INFO - Running setup.py install for mozsystemmonitor 03:41:44 INFO - Successfully installed mozsystemmonitor 03:41:44 INFO - Cleaning up... 03:41:44 INFO - Return code: 0 03:41:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f728baaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe35770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec49c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:41:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:41:44 INFO - Using env: {'DISPLAY': ':0', 03:41:44 INFO - 'HOME': '/home/cltbld', 03:41:44 INFO - 'LANG': 'en_US.UTF-8', 03:41:44 INFO - 'LANGUAGE': 'en_US:en', 03:41:44 INFO - 'LOGNAME': 'cltbld', 03:41:44 INFO - 'MAIL': '/var/mail/cltbld', 03:41:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:44 INFO - 'MOZ_NO_REMOTE': '1', 03:41:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:44 INFO - 'NO_EM_RESTART': '1', 03:41:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:44 INFO - 'PWD': '/builds/slave/test', 03:41:44 INFO - 'SHELL': '/bin/bash', 03:41:44 INFO - 'SHLVL': '1', 03:41:44 INFO - 'TERM': 'linux', 03:41:44 INFO - 'TMOUT': '86400', 03:41:44 INFO - 'USER': 'cltbld', 03:41:44 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281', 03:41:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:44 INFO - '_': '/tools/buildbot/bin/python'} 03:41:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:44 INFO - Downloading/unpacking blobuploader==1.2.4 03:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:46 INFO - Downloading blobuploader-1.2.4.tar.gz 03:41:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:41:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:41:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:47 INFO - Downloading docopt-0.6.1.tar.gz 03:41:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:41:47 INFO - Installing collected packages: blobuploader, requests, docopt 03:41:47 INFO - Running setup.py install for blobuploader 03:41:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:41:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:41:47 INFO - Running setup.py install for requests 03:41:47 INFO - Running setup.py install for docopt 03:41:47 INFO - Successfully installed blobuploader requests docopt 03:41:47 INFO - Cleaning up... 03:41:47 INFO - Return code: 0 03:41:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f728baaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe35770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec49c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:41:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:47 INFO - Using env: {'DISPLAY': ':0', 03:41:47 INFO - 'HOME': '/home/cltbld', 03:41:47 INFO - 'LANG': 'en_US.UTF-8', 03:41:47 INFO - 'LANGUAGE': 'en_US:en', 03:41:47 INFO - 'LOGNAME': 'cltbld', 03:41:47 INFO - 'MAIL': '/var/mail/cltbld', 03:41:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:47 INFO - 'MOZ_NO_REMOTE': '1', 03:41:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:47 INFO - 'NO_EM_RESTART': '1', 03:41:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:47 INFO - 'PWD': '/builds/slave/test', 03:41:47 INFO - 'SHELL': '/bin/bash', 03:41:47 INFO - 'SHLVL': '1', 03:41:47 INFO - 'TERM': 'linux', 03:41:47 INFO - 'TMOUT': '86400', 03:41:47 INFO - 'USER': 'cltbld', 03:41:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281', 03:41:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:47 INFO - '_': '/tools/buildbot/bin/python'} 03:41:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:48 INFO - Running setup.py (path:/tmp/pip-FcpFBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:48 INFO - Running setup.py (path:/tmp/pip-ta1uA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:48 INFO - Running setup.py (path:/tmp/pip-pBsCYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:48 INFO - Running setup.py (path:/tmp/pip-em_Zbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:48 INFO - Running setup.py (path:/tmp/pip-_XYv93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:48 INFO - Running setup.py (path:/tmp/pip-V3RqtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:48 INFO - Running setup.py (path:/tmp/pip-rvN9Lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:48 INFO - Running setup.py (path:/tmp/pip-lFSK3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:48 INFO - Running setup.py (path:/tmp/pip-j2WeQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:48 INFO - Running setup.py (path:/tmp/pip-ksTUP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:48 INFO - Running setup.py (path:/tmp/pip-4E0w1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:48 INFO - Running setup.py (path:/tmp/pip-C_VERS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:48 INFO - Running setup.py (path:/tmp/pip-8L24z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:49 INFO - Running setup.py (path:/tmp/pip-5l3NuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:49 INFO - Running setup.py (path:/tmp/pip-lvjSRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:49 INFO - Running setup.py (path:/tmp/pip-g19tsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:49 INFO - Running setup.py (path:/tmp/pip-UefjXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:41:49 INFO - Running setup.py install for manifestparser 03:41:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:41:49 INFO - Running setup.py install for mozcrash 03:41:49 INFO - Running setup.py install for mozdebug 03:41:49 INFO - Running setup.py install for mozdevice 03:41:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:41:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:41:49 INFO - Running setup.py install for mozfile 03:41:49 INFO - Running setup.py install for mozhttpd 03:41:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:41:49 INFO - Running setup.py install for mozinfo 03:41:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:41:50 INFO - Running setup.py install for mozInstall 03:41:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:41:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:41:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:41:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:41:50 INFO - Running setup.py install for mozleak 03:41:50 INFO - Running setup.py install for mozlog 03:41:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:41:50 INFO - Running setup.py install for moznetwork 03:41:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:41:50 INFO - Running setup.py install for mozprocess 03:41:50 INFO - Running setup.py install for mozprofile 03:41:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:41:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:41:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:41:50 INFO - Running setup.py install for mozrunner 03:41:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:41:50 INFO - Running setup.py install for mozscreenshot 03:41:50 INFO - Running setup.py install for moztest 03:41:51 INFO - Running setup.py install for mozversion 03:41:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:41:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:41:51 INFO - Cleaning up... 03:41:51 INFO - Return code: 0 03:41:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f728baaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe35770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec49c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:41:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:51 INFO - Using env: {'DISPLAY': ':0', 03:41:51 INFO - 'HOME': '/home/cltbld', 03:41:51 INFO - 'LANG': 'en_US.UTF-8', 03:41:51 INFO - 'LANGUAGE': 'en_US:en', 03:41:51 INFO - 'LOGNAME': 'cltbld', 03:41:51 INFO - 'MAIL': '/var/mail/cltbld', 03:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:51 INFO - 'MOZ_NO_REMOTE': '1', 03:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:51 INFO - 'NO_EM_RESTART': '1', 03:41:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:51 INFO - 'PWD': '/builds/slave/test', 03:41:51 INFO - 'SHELL': '/bin/bash', 03:41:51 INFO - 'SHLVL': '1', 03:41:51 INFO - 'TERM': 'linux', 03:41:51 INFO - 'TMOUT': '86400', 03:41:51 INFO - 'USER': 'cltbld', 03:41:51 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281', 03:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:51 INFO - '_': '/tools/buildbot/bin/python'} 03:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:41:51 INFO - Running setup.py (path:/tmp/pip-1uRUb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:41:51 INFO - Running setup.py (path:/tmp/pip-FKbIWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:41:51 INFO - Running setup.py (path:/tmp/pip-RHmOlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:41:51 INFO - Running setup.py (path:/tmp/pip-Yq3ty1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:41:51 INFO - Running setup.py (path:/tmp/pip-7DtC9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:41:51 INFO - Running setup.py (path:/tmp/pip-0YeqIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:41:51 INFO - Running setup.py (path:/tmp/pip-PJAY3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:41:51 INFO - Running setup.py (path:/tmp/pip-YxKM0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:41:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:41:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:41:51 INFO - Running setup.py (path:/tmp/pip-FoDQvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:41:52 INFO - Running setup.py (path:/tmp/pip-1u0pP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:41:52 INFO - Running setup.py (path:/tmp/pip-vKHkZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:41:52 INFO - Running setup.py (path:/tmp/pip-qKweYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:41:52 INFO - Running setup.py (path:/tmp/pip-zDU0XK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:41:52 INFO - Running setup.py (path:/tmp/pip-VvnpFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:52 INFO - Running setup.py (path:/tmp/pip-dZel_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:41:52 INFO - Running setup.py (path:/tmp/pip-gKliUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:41:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:41:52 INFO - Running setup.py (path:/tmp/pip-AfIYPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:41:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:54 INFO - Downloading blessings-1.6.tar.gz 03:41:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:41:54 INFO - Installing collected packages: blessings 03:41:54 INFO - Running setup.py install for blessings 03:41:54 INFO - Successfully installed blessings 03:41:54 INFO - Cleaning up... 03:41:54 INFO - Return code: 0 03:41:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:41:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:41:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:41:54 INFO - Reading from file tmpfile_stdout 03:41:54 INFO - Current package versions: 03:41:54 INFO - argparse == 1.2.1 03:41:54 INFO - blessings == 1.6 03:41:54 INFO - blobuploader == 1.2.4 03:41:54 INFO - docopt == 0.6.1 03:41:54 INFO - manifestparser == 1.1 03:41:54 INFO - mozInstall == 1.12 03:41:54 INFO - mozcrash == 0.17 03:41:54 INFO - mozdebug == 0.1 03:41:54 INFO - mozdevice == 0.48 03:41:54 INFO - mozfile == 1.2 03:41:54 INFO - mozhttpd == 0.7 03:41:54 INFO - mozinfo == 0.9 03:41:54 INFO - mozleak == 0.1 03:41:54 INFO - mozlog == 3.1 03:41:54 INFO - moznetwork == 0.27 03:41:54 INFO - mozprocess == 0.22 03:41:54 INFO - mozprofile == 0.28 03:41:54 INFO - mozrunner == 6.11 03:41:54 INFO - mozscreenshot == 0.1 03:41:54 INFO - mozsystemmonitor == 0.0 03:41:54 INFO - moztest == 0.7 03:41:54 INFO - mozversion == 1.4 03:41:54 INFO - psutil == 3.1.1 03:41:54 INFO - requests == 1.2.3 03:41:54 INFO - wsgiref == 0.1.2 03:41:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f728baaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe35770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec49c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:41:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:41:54 INFO - Using env: {'DISPLAY': ':0', 03:41:54 INFO - 'HOME': '/home/cltbld', 03:41:54 INFO - 'LANG': 'en_US.UTF-8', 03:41:54 INFO - 'LANGUAGE': 'en_US:en', 03:41:54 INFO - 'LOGNAME': 'cltbld', 03:41:54 INFO - 'MAIL': '/var/mail/cltbld', 03:41:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:54 INFO - 'MOZ_NO_REMOTE': '1', 03:41:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:54 INFO - 'NO_EM_RESTART': '1', 03:41:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:54 INFO - 'PWD': '/builds/slave/test', 03:41:54 INFO - 'SHELL': '/bin/bash', 03:41:54 INFO - 'SHLVL': '1', 03:41:54 INFO - 'TERM': 'linux', 03:41:54 INFO - 'TMOUT': '86400', 03:41:54 INFO - 'USER': 'cltbld', 03:41:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281', 03:41:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:54 INFO - '_': '/tools/buildbot/bin/python'} 03:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:41:55 INFO - Cleaning up... 03:41:55 INFO - Return code: 0 03:41:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f728baaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe35770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec49c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:41:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:41:55 INFO - Using env: {'DISPLAY': ':0', 03:41:55 INFO - 'HOME': '/home/cltbld', 03:41:55 INFO - 'LANG': 'en_US.UTF-8', 03:41:55 INFO - 'LANGUAGE': 'en_US:en', 03:41:55 INFO - 'LOGNAME': 'cltbld', 03:41:55 INFO - 'MAIL': '/var/mail/cltbld', 03:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:55 INFO - 'MOZ_NO_REMOTE': '1', 03:41:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:55 INFO - 'NO_EM_RESTART': '1', 03:41:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:55 INFO - 'PWD': '/builds/slave/test', 03:41:55 INFO - 'SHELL': '/bin/bash', 03:41:55 INFO - 'SHLVL': '1', 03:41:55 INFO - 'TERM': 'linux', 03:41:55 INFO - 'TMOUT': '86400', 03:41:55 INFO - 'USER': 'cltbld', 03:41:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281', 03:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:55 INFO - '_': '/tools/buildbot/bin/python'} 03:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:55 INFO - Downloading/unpacking jsonschema 03:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:41:57 INFO - Downloading/unpacking functools32 (from jsonschema) 03:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:57 INFO - Downloading functools32-3.2.3-2.tar.gz 03:41:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:41:57 INFO - warning: no files found matching '*.txt' 03:41:57 INFO - no previously-included directories found matching 'build' 03:41:57 INFO - no previously-included directories found matching 'dist' 03:41:57 INFO - no previously-included directories found matching '.git*' 03:41:57 INFO - Installing collected packages: jsonschema, functools32 03:41:57 INFO - Running setup.py install for functools32 03:41:57 INFO - warning: no files found matching '*.txt' 03:41:57 INFO - no previously-included directories found matching 'build' 03:41:57 INFO - no previously-included directories found matching 'dist' 03:41:57 INFO - no previously-included directories found matching '.git*' 03:41:57 INFO - Successfully installed jsonschema functools32 03:41:57 INFO - Cleaning up... 03:41:57 INFO - Return code: 0 03:41:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:41:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:41:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:41:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f728baaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe35770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec49c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:41:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:41:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:41:57 INFO - Using env: {'DISPLAY': ':0', 03:41:57 INFO - 'HOME': '/home/cltbld', 03:41:57 INFO - 'LANG': 'en_US.UTF-8', 03:41:57 INFO - 'LANGUAGE': 'en_US:en', 03:41:57 INFO - 'LOGNAME': 'cltbld', 03:41:57 INFO - 'MAIL': '/var/mail/cltbld', 03:41:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:57 INFO - 'MOZ_NO_REMOTE': '1', 03:41:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:57 INFO - 'NO_EM_RESTART': '1', 03:41:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:57 INFO - 'PWD': '/builds/slave/test', 03:41:57 INFO - 'SHELL': '/bin/bash', 03:41:57 INFO - 'SHLVL': '1', 03:41:57 INFO - 'TERM': 'linux', 03:41:57 INFO - 'TMOUT': '86400', 03:41:57 INFO - 'USER': 'cltbld', 03:41:57 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281', 03:41:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:57 INFO - '_': '/tools/buildbot/bin/python'} 03:41:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:41:57 INFO - Downloading/unpacking flake8 03:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:41:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:41:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:41:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:42:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:42:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:42:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:42:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:42:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:42:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:42:00 INFO - no previously-included directories found matching 'docs/_build' 03:42:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:42:00 INFO - Running setup.py install for pep8 03:42:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:42:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:42:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:42:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:42:00 INFO - no previously-included directories found matching 'docs/_build' 03:42:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:42:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:42:00 INFO - Cleaning up... 03:42:00 INFO - Return code: 0 03:42:00 INFO - Running post-action listener: _resource_record_post_action 03:42:00 INFO - Running post-action listener: _start_resource_monitoring 03:42:00 INFO - Starting resource monitoring. 03:42:00 INFO - ##### 03:42:00 INFO - ##### Finished create-virtualenv step (success) 03:42:00 INFO - ##### 03:42:00 INFO - ##### 03:42:00 INFO - ##### Running install step. 03:42:00 INFO - ##### 03:42:00 INFO - Running pre-action listener: _resource_record_pre_action 03:42:00 INFO - Running main action method: install 03:42:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:42:01 INFO - Reading from file tmpfile_stdout 03:42:01 INFO - Detecting whether we're running mozinstall >=1.0... 03:42:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:42:01 INFO - Reading from file tmpfile_stdout 03:42:01 INFO - Output received: 03:42:01 INFO - Usage: mozinstall [options] installer 03:42:01 INFO - Options: 03:42:01 INFO - -h, --help show this help message and exit 03:42:01 INFO - -d DEST, --destination=DEST 03:42:01 INFO - Directory to install application into. [default: 03:42:01 INFO - "/builds/slave/test"] 03:42:01 INFO - --app=APP Application being installed. [default: firefox] 03:42:01 INFO - mkdir: /builds/slave/test/build/application 03:42:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:42:17 INFO - Reading from file tmpfile_stdout 03:42:17 INFO - Output received: 03:42:17 INFO - /builds/slave/test/build/application/firefox/firefox 03:42:17 INFO - Running post-action listener: _resource_record_post_action 03:42:17 INFO - ##### 03:42:17 INFO - ##### Finished install step (success) 03:42:17 INFO - ##### 03:42:17 INFO - ##### 03:42:17 INFO - ##### Running run-tests step. 03:42:17 INFO - ##### 03:42:17 INFO - Running pre-action listener: _resource_record_pre_action 03:42:17 INFO - Running main action method: run_tests 03:42:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:42:17 INFO - Python 2.7.3 03:42:17 INFO - Return code: 0 03:42:17 INFO - grabbing minidump binary from tooltool 03:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:42:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec49c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec5d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:42:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:42:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:42:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:42:17 INFO - Return code: 0 03:42:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:42:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:42:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:42:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:42:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:42:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:42:18 INFO - Return code: 0 03:42:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:42:18 INFO - Using env: {'DISPLAY': ':0', 03:42:18 INFO - 'HOME': '/home/cltbld', 03:42:18 INFO - 'LANG': 'en_US.UTF-8', 03:42:18 INFO - 'LANGUAGE': 'en_US:en', 03:42:18 INFO - 'LOGNAME': 'cltbld', 03:42:18 INFO - 'MAIL': '/var/mail/cltbld', 03:42:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:42:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:42:18 INFO - 'MOZ_NO_REMOTE': '1', 03:42:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:42:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:42:18 INFO - 'NO_EM_RESTART': '1', 03:42:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:42:18 INFO - 'PWD': '/builds/slave/test', 03:42:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:42:18 INFO - 'SHELL': '/bin/bash', 03:42:18 INFO - 'SHLVL': '1', 03:42:18 INFO - 'TERM': 'linux', 03:42:18 INFO - 'TMOUT': '86400', 03:42:18 INFO - 'USER': 'cltbld', 03:42:18 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281', 03:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:42:18 INFO - '_': '/tools/buildbot/bin/python'} 03:42:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:42:18 INFO - mozversion application_buildid: 20160509021943 03:42:18 INFO - mozversion application_changeset: 748b70bcdbc95a4f3e72ca53a23c8f766049d011 03:42:18 INFO - mozversion application_display_name: Nightly 03:42:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:42:18 INFO - mozversion application_name: Firefox 03:42:18 INFO - mozversion application_remotingname: firefox 03:42:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:42:18 INFO - mozversion application_vendor: Mozilla 03:42:18 INFO - mozversion application_version: 49.0a1 03:42:18 INFO - mozversion platform_buildid: 20160509021943 03:42:18 INFO - mozversion platform_changeset: 748b70bcdbc95a4f3e72ca53a23c8f766049d011 03:42:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:42:18 INFO - mozversion platform_version: 49.0a1 03:42:18 INFO - using testdate: 1462790538 03:42:18 INFO - actual date: 1462790538 03:42:18 INFO - starting webserver on 'localhost:34444' 03:42:18 INFO - SUITE-START | Running 2 tests 03:42:18 INFO - TEST-START | dromaeo_css 03:42:18 INFO - operating with platform_type : linux_ 03:42:18 INFO - Initialising browser for dromaeo_css test... 03:42:18 INFO - TEST-INFO | started process 27260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9VoIiO/profile http://localhost:34444/getInfo.html) 03:42:22 INFO - PROCESS | 27260 | 03:42:22 INFO - PROCESS | 27260 | (process:27325): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:42:22 INFO - PROCESS | 27260 | __metrics Screen width/height:1600/1200 03:42:22 INFO - PROCESS | 27260 | colorDepth:24 03:42:22 INFO - PROCESS | 27260 | Browser inner width/height: 1024/697 03:42:22 INFO - PROCESS | 27260 | __metrics 03:42:23 ERROR - PROCESS | 27260 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 03:42:24 INFO - TEST-INFO | 27260: exit 0 03:42:24 INFO - Browser initialized. 03:42:24 INFO - Running cycle 1/1 for dromaeo_css test... 03:42:24 INFO - TEST-INFO | started process 27377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9VoIiO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:26 INFO - PROCESS | 27377 | 03:42:26 INFO - PROCESS | 27377 | (process:27436): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:42:36 INFO - PROCESS | 27377 | RSS: Main: 164651008 03:42:36 INFO - PROCESS | 27377 | 03:43:26 INFO - PROCESS | 27377 | 1462790605998 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:45:38 INFO - PROCESS | 27377 | Cycle 1(1): loaded http://localhost:34444/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34444/tests/dromaeo/cssquery-ext.html) 03:45:39 INFO - PROCESS | 27377 | RSS: Main: 165822464 03:45:39 INFO - PROCESS | 27377 | 03:48:41 INFO - PROCESS | 27377 | Cycle 1(1): loaded http://localhost:34444/tests/dromaeo/cssquery-ext.html (next: http://localhost:34444/tests/dromaeo/cssquery-jquery.html) 03:48:42 INFO - PROCESS | 27377 | RSS: Main: 167182336 03:48:42 INFO - PROCESS | 27377 | 03:51:44 INFO - PROCESS | 27377 | Cycle 1(1): loaded http://localhost:34444/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34444/tests/dromaeo/cssquery-mootools.html) 03:51:44 INFO - PROCESS | 27377 | RSS: Main: 168017920 03:51:44 INFO - PROCESS | 27377 | 03:54:46 INFO - PROCESS | 27377 | Cycle 1(1): loaded http://localhost:34444/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34444/tests/dromaeo/cssquery-prototype.html) 03:54:47 INFO - PROCESS | 27377 | RSS: Main: 165732352 03:54:47 INFO - PROCESS | 27377 | 03:57:50 INFO - PROCESS | 27377 | Cycle 1(1): loaded http://localhost:34444/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34444/tests/dromaeo/cssquery-yui.html) 03:57:50 INFO - PROCESS | 27377 | RSS: Main: 167092224 03:57:50 INFO - PROCESS | 27377 | 04:00:53 INFO - PROCESS | 27377 | Cycle 1(1): loaded http://localhost:34444/tests/dromaeo/cssquery-yui.html (next: http://localhost:34444/tests/dromaeo/cssquery-dojo.html) 04:00:53 INFO - PROCESS | 27377 | RSS: Main: 169046016 04:00:53 INFO - PROCESS | 27377 | 04:00:53 INFO - PROCESS | 27377 | __start_tp_report 04:00:53 INFO - PROCESS | 27377 | _x_x_mozilla_page_load 04:00:53 INFO - PROCESS | 27377 | _x_x_mozilla_page_load_details 04:00:53 INFO - PROCESS | 27377 | |i|pagename|runs| 04:00:53 INFO - PROCESS | 27377 | |0;dojo.html;2650.1651979626417;2723.2374935018197;2739.6027576001466;2751.7248275172487;2752.958705619416;4794.640401969848;4838.298446725227;4860.416749990001;4932.531409516099;4991.6256280779;4682.461516925555;4805;4873.902521949568;4895.437024742156;4899.2161254199245;4480.0143968327;4508.977455112737;4589.5410458954175;4614.146382919171;4643.210654188796;591.024235320806;4135.60711732385;4362.411074504948;4450.310201918708;4457.59881610655;4467.01725620363;4470.552944705536;4472.373867658531;4504.797284122223;4528.230200865861;4494.820207191741;4495.34817451471;4497.707649002837;4500.639948804088;4530.1392735380505;4374.34384842273;4382.057857560608;4389.253826849444;4413.44831896013;4432.645388368955;4638.512956139591;4718.882027949328;4739.123262196505;4742.620590352763;4775.952240477585;5194.480551944813;5207.140821764404;5211.114110601206;5240.764165612557;5272.762725677354;5333.040052790496;5350.30446042016;5360.303160589137;5363.54409875161;5427.48438898304;4909.729964851932;4924.803007879645;4969.378827646544;4988.226824842155;5002.024605202024;5159.355080614923;5298.15229563268;5346.43862394443;5429.972850135724;5452.236686863842;5145.794168233304;5153.871153221125;5155.278261043457;5168.302279192261;5221.347331583552;5206.635535512553;5217.843464696065;5224.164133738584;5245.816396426107;5298.072837253542;5072.163093089673;5158.432572417031;5208.9739551302;5223.399309079428;5261.710605916634;5213.3222681051975;5249.973750131225;5260.579153667697;5263.131583288715;5272.499112584298;4455.443069616298;4472.619827314649;4473.821047158142;4493.1013797240685;4522.23122069249;3739.6821270191795;3857.1707082977296;3858.054776579756;3891.4357418174204;3907.706921980806;4333.523312435629;4446.399736035659;4474.485434175046;4498.932516012263;4519.435070616173;5282.524572788468;5301.761420736076;5302.965921645319;5325.3875804282225;5352.759125839269;4352.455943007124;4494.393256910341;4512.187806194851;4529.456465224128;4549.454065512094;4739.905201895943;4754.4532378776885;4754.643401744883;4757.857264282077;4778.832740854054;4935.210366341368;4970.130227210224;4985.900281994267;4990.076835785391;4995.300657907968;5087.898242035212;5173.22401639757;5222.033923724123;5226.529612334908;5274.578033757213;4903.092927808367;4903.289023091703;4930.2604609307455;4930.6055515557955;4947.960928205117;4992.825251116194;5103.055934652101;5111.795528178831;5157.226416037624;5168.560672342743;5243.68537887728;5262.210668399617;5288.444713305202;5308.893822123613;5314.176302673091;5128.79484820603;5144.459831717765;5153.819616313561;5168.224766285088;5189.81835635766;4940.580050695731;4957.157283261782;5155.3813542373655;5162.561182299547;5169.224616307584;4991.925121123259;4996.7001979881325;5021.748912554284;5024.371953505812;5092.108880945746;5140.76866541014;5144.331236939174;5171;5178.663386879841;5224.03355379256;4891.853244402673;5021.221710634857;5024.095662780588;5052;5064.620153488577 04:00:53 INFO - PROCESS | 27377 | |1;ext.html;557.6960556496709;594.56002558107;595.6396380189985;617.5923890232444;630.8864404407211;36665.816670916676;40642;40938;40970.59029409705;41064.17871642569;41293.380599291035;41780.16439671205;41782.37326440106;41976;41981;7789.4157938154585;7933.444658873881;7969.481983671043;7976.441649084566;7992.600369981477;7854.253845884632;7886.093099293568;7924.722634707787;7935.285824275814;7967.163447837952;7916.722914697987;7961.482503637245;7966.203379662045;7997.880031799527;8028.5182889026555;7803.453758236926;7927.72252971149;7956.602169891511;7958.442908996372;7979.48133371329;7831.608419579055;7885.172056933997;7907.525548467111;7918.129005809356;7933.96033019837;30708.53937190944;38174.23651526954;38669;38718.80640596779;38805.22389552193;3182.8726850925937;3198.296374797541;3217.8551965161623;3322.1030321812973;3376.6960973512255;28212.153635390972;28360.716392836013;28420.43159136806;30473.847630761928;31412;3262.8368581570826;3288.7369010479106;3326.7172290355347;3418.9316213675834;3463.8614455422003;247200;251052;253280;253518;257222;35179.29641407158;36309.455358169645;60094;61452.38547614556;61756.073658895155;36686;36892.446613300825;36908.26183476369;36988.815055925086;37234.627653723655;12869.742605147845;13053.477860885458;13064.54274100402;13087.476500940045;13102.60692179217;9895.356801808004;9917.504124793732;9927.40435573868;9972.401655900669;10015.248856335804;8546.871796923051;8561.272291855263;8577.228049475578;8581.528015959057;8630.784230394165;3361.3949489092197;3376.324735052999;3379.8648054078053;3453.3611281912927;3465.601455832561;930.4556834251903;935.6725146198776;998.9400635961865;1039.095986491742;1102.9503672334765;28904.132876013755;29589.37857934059;30214.29561704045;30245.243868903453;30248.395032099234;993.3344659078434;1004.8241557727368;1015.5988384588046;1042.2652030318607;1042.8331466965249;15477.690446191013;16001.919990399974;16092;16203.432879849148;16318.918405407898;368254;371038;371265;372828;373599;51712.74143629258;53435.73282133642;53717.46282537203;53824.73087634537;53903.730481348124;1261.3377976562379;1264.778663733843;1265.367316341829;1270.6315168601002;1290.832191815058;28713.56929646015;29436;29841;30025.54961675533;30304;46385.304220436046;46444.30333544932;46642.766786165856;46721.766391167825;46834.76582617065;260920;261079;261313.16060518214;262313;262565;27074.864625676746;27116.1865144046;27976;28020.439591207654;28092.578611321256;39951.600483994785;39997.200055999296;44417;44891;45657.54342456533;38059.42910856395;38419.231615368095;38750.224995500495;39076;39343.606563933994;38033.42949855699;38442.615573843905;38613.22773544457;38966.6103338963;39480.80259598684;37995;39648.60351396449;40166;40582.594174059064;43395;32653.34693306073;35159.47260791039;35824.82087589546;35829.28341433209;35870.8206458966;26686.733132668425;26937.86531067332;27031.324216894736;27138;27491 04:00:53 INFO - PROCESS | 27377 | |2;jquery.html;366.8092591852237;370.73862926636724;370.91839795245045;382.71105315486835;389.3439554350919;15845;16060.27728752206;16147.43483978061;16298.918505407457;16342.346306147769;16348.182590870469;16757.162141892917;17685.73471397927;17694.38069667562;17726.911365443153;4992.251162325653;5152.974235128819;5181.689098654074;5181.922271165936;5200.8699782505555;3698.7041036717133;5069.239614057902;5611.2144299798065;5926.940730592703;5933.317668468138;5949.762009519614;5958.612690175147;5961.314448838396;5968.343482216975;5992.250968628921;5747.626404283708;5940.910886336686;5942.049272116462;5964.433378829004;5978.192943952554;5079.593632509391;5132.307138536325;5141.203113517374;5181.4041385240425;5187.766550505236;20313.390598281927;20372.388828335173;20661.27685531014;20678.276260330967;20690;1823.9817601823945;1952.7851936286997;1989.950251243716;2012.1247257443058;2079.469735217525;9124;9159.397699909126;9268.49023303718;9460.432374057578;9495.240380769523;1776.2362184260762;1788.418763901737;1802.9459116226535;1822.5443639090226;1873.7189421586734;67208.6639566804;68975;69254;69681;71586.28413715848;9317.860232096524;9396.859047114298;9454.810903781887;9583.664571739955;9598.520073996273;12837.358132093357;12906.935465322613;12936.482540698455;12944.741105177844;12989.28558929268;6659.567128136656;6665.833354166185;6691.26396096429;6747.291534388818;6831.2144103427745;6364.554481186365;6433.356664333623;6509.967450162719;6535.803925882231;6560.967195163994;3903.785291808921;3913.4521167036637;3949.6840252779707;4025.0943537703783;4053.5338436079637;1616.9838301616833;1696.7370057641085;1768.3280353465857;1781.8040015598274;1881.8306352428347;898.3846065445191;921.1203300847808;952.2905435450633;955.8327292723745;995.2983146881431;16451.6709665806;16613.750793738105;16667.583310417092;16918.74621880673;16947.152642367833;909.7407238936871;920.9171174594319;947.2280091725222;956.502618638318;977.3402953006693;9411.811763764686;9484.90515094854;9641.614335426644;9674.806503870024;9814.803703925882;382353;385690;393253;393663;394580;47158.5284147161;47595.286070708964;49921.500784992415;78306.6084669573;78838;951.9476428796482;977.6822532676908;986.6645340584236;1001.62439085343;1007.4811472091878;14838.109713416798;14963.850361496246;15080.622984425478;15217.847821522086;15237.542873713806;34082.82958585191;34447.4832877512;34653.48019779655;35217;35971.640283596826;45496;48003.75998120127;49132.508674912795;49827.75086124691;49856.501434985184;7439.665215065227;7733.91725158467;7745.109312428917;7757.650905709143;7996.800079998046;9181.586828592595;10424.374537527772;11412.771744565229;11565.479553420284;11853.940730296294;9643.517824108627;10326.225533084898;10368;10511.316764410289;10708.57165713394;8921.394149053232;9699.369540979813;10023.148032417326;10569.894301056891;10696.358218506915;10252.897471025493;10258.692239232834;10525.842112368167;10619.734506637396;10671.253012289066;7646.923530764621;7813.296803287504;7846.450748447783;7966.681332746625;8021.27808497238;9039.412438191497;10190.898091018995;10255.58977640886;10287.074163325336;10408.219383546415 04:00:53 INFO - PROCESS | 27377 | |3;mootools.html;1450.9274536273188;1483.9332230049647;1638.4265507072525;1813.927442902284;1835.2383760739294;6443.29123796382;7122.3945964593;7137.928620713791;7598.16420193779;7623.237676232381;7134.928650713491;7369.594672293022;7422.665980030898;7434.814129646748;7459.701611935516;2207.867527948324;2224.143704673704;2227.387468446182;2238.4851484158653;2247.6516139998325;2214.5903007943502;2215.4129155773735;2220.123051394698;2238.0712004518105;2245.8877056147207;2139.1336508713916;2178.814800741939;2187.58435897179;2203.4160947348964;2242.9439264018447;2153.4078128514625;2155.644318687415;2159.3090211132444;2165.9133634654595;2174.4129085147;2131.541718530523;2135.4981579328846;2136.2523116908956;2137.935861924145;2144.0994782191515;7363.447741419415;7379;7382.963085184593;7396.519226250277;7475.476716629838;4374.956250437487;4399.890002749925;4415.911681766347;4453.131639330332;4481.551844815525;2902.840343781091;2924.400497897947;3039.832809195493;3069.0946170879643;3069.708377704137;879.0594064351147;892.1123482135253;906.8231694819513;921.6129225725144;967.9225661947028;9209.815803683956;9558.95220523893;9577.61689532418;9720.396134637776;9817.656382026595;3999.460072890181;4037.0916543778003;4124.958750412457;4141.213169497786;4155.605217504332;8079.636416361278;8086.43394962347;8103.9594802026795;8104.5137291762685;8111.878321825177;4418.690691651618;4429.357743127229;4443.666724995638;4473.2842745160615;4515.254982927846;3512.84192211346;3995.6603688686205;4096.651784598283;4108.609682080198;4143.544210136883;3408.1138903885167;3413.8805141819917;3464.0647025303533;3499.230169362736;3502.404591219499;1031.4739482863793;1031.5770534080991;1034.539629864718;1042.124615323117;1044.9373037617768;767.1944458318743;781.3397678961269;859.5143743784741;894.6063731957918;923.958421871004;5122.641415100908;5125.8617606738935;5177.404598471224;5184;5213.165893457029;408.34868384925994;428.29545397820414;429.0175498109357;431.16139109431856;433.91755566442276;3451.861925523001;3500.7724497907557;3542.4686297055646;3571.7321200910037;3594.694450971697;8765.824683506295;8979.236764874928;9098.909010909938;9120.270378369847;9134;8956.552172391355;8996.59515321812;9019.594118264562;9037.954810226038;9066.909330906607;6828.5220034597105;6924.446044316443;7061.89407158893;7074.893876591856;7088.432925366062;4953.950460495349;5040.949590504195;5061.797528098835;5069.645124841373;5136.512031357015;8380.12008739098;8414.948131483565;8417.242448179693;8482.363822713445;8504.787380315294;7986;8363.20549547792;8388.916110838814;8538.359623028173;8639.352048596505;5851.853703657443;6337.334579869047;6542.182227221598;6570.310117437601;6691.09670194537;7228.277172282729;7232.89150662751;7239.8914016288745;7292.817679558054;7316.268373162641;6389.616623002635;6669.199696036312;6691.498137639794;6721.630310332978;6755.324467553205;6424.550281480439;6452.870942581028;6624.072629831924;6630.3038180992235;6735.0570920072205;6241.157443745218;6283.151774510566;6317.747290108528;6325.9683701583035;6338.271098823694;4282.828686852491;4387.627051700513;4425.291953287458;4462.977685111554;4474.530174331649;4477.171723231213;4494.0337827367275;4515.841945531891;4518.6611004174165;4536.909261814679 04:00:53 INFO - PROCESS | 27377 | |4;prototype.html;310.32968787419173;312.21166554450014;313.8540578630938;315.9668234835341;316.50783032384635;4971.955889263259;4978.411226162398;5003.374578177723;5017.698938063719;5021.196608542634;4885.193942999401;4897.351473152497;4897.604182807891;4901.975490122544;4939.802407903689;3658.378075727126;3720.348938935689;3821.464994900702;3855.267499175148;3862;3842.6733727633186;3852.1717830666403;3858.266929283427;3858.3826587745966;3876.2247550489874;3837.330761118922;3844.961860297718;3847.711421643388;3853.556840963297;3870.2453021660644;3574.8212589370687;3843.9039024024482;3849.7497662652117;3854.383298672199;3858.2862170498406;3288.917777055569;3331.3004269103517;3335.93328133436;3344.1305260632166;3361.210115622827;4708.858734237944;4728.598069164125;4743.905121897577;4753.762311884392;4761.4524329701835;4366.345048242757;4370.2352088384405;4378.080603073358;4387.6709246806295;4389.2977123660385;4998.150684246815;5162.354705661793;5172.948270517322;5173.741312934339;5174.377935445165;3659.176685245825;3659.396199627058;3666.7983260920637;3666.853325866962;3668.633136686337;5391.353037635469;5425.593080518976;5426.75579598919;5429.67421954684;5435.483629055233;3645.343838109166;3748.1379282765115;3758.830852611639;3778.0366006668123;3783.432485127253;3815.778950735738;3832.1186127190904;3836.6547010769164;3837.94456524458;3839.8480455863128;4362.563743625676;4363.498197707241;4371.278739008092;4381.145676593033;4384.172208925225;5052.979575272578;5189.766460509286;5249.737513124329;5256.658317209369;5279.884867927941;1264.7217612125319;1269.676232560691;1272.3574594829552;1274;1277.1698396042646;821;855.3371137368589;870.3385427075468;881.8015946412006;884.4339622641514;4414.779261036935;4541;4542.68201225911;4550.977245113753;4552.567506086916;5341.412444631087;5347.422510359454;5356.1697936819855;5368.570514358842;5395.109806881899;4368.541303163186;4506.414166158378;4516.522277846106;4528.841490547815;4568.109218702321;2697.6223328733995;2773.459175460766;2778.7221277872454;2789.1911345709923;2804.4671512412983;4879.2188452582395;4908.165611845995;4936.284238785356;4949.975250123726;4951.306817045616;5107.821226257063;5289.656172348785;5334.226537152169;5368.1679339702405;5437.238786569884;4855.101806165871;4869.805207791649;4889.828855990023;4909.288153217834;4956.529129732669;5187.4984385540365;5209.665813879044;5241.659292145999;5282.754829197653;5287.471252874681;5029.295898574275;5082.33929589151;5147.897042059063;5165.793368265227;5175.249588809676;4918.721132505503;4929.556339929423;4936.506349365035;4940.629452791127;4957.504249575014;3617.511635929221;3635.763675361093;3644.726645501651;3655.5430571178604;3682.686971607336;4964.950350496449;5088.236764485357;5213.826888949956;5233.979374022029;5261.421243663118;5061.898762024813;5074.340335756328;5077.822276220315;5103.744812759422;5107.807620237351;4970.453250142554;5061.392632884077;5067.341245638191;5077.949220507748;5084.3898732152375;4781.952180478151;5006.524380184022;5033.188052301095;5076.213186956028;5098.031374038921;4963.975180124076;5116.411612664591;5202.531772140525;5230.372355317234;5233.215017747216;5112.156494178419;5115.411727651219;5134.383873935151;5143.71709555978;5147.742612869267 04:00:53 INFO - PROCESS | 27377 | |5;yui.html;750.5571712689513;776.7436745873858;778.8364443466871;784.846954843805;788.1881661888256;11222.887771122287;12504.56234031809;12749.426275817586;12810.807837882416;13437.529686460952;14204;14286.857131428682;14320.64198395038;14330.641733956656;14381.06523076002;657.1161787395945;878.5431575580694;879.6877108626442;882.2104216726026;888.524639317965;858.1761508951383;888.3337496877342;891.3092353426114;893.673809059695;897.3673560140119;915.9908400916006;927.6938610258633;928.2434815625278;929.790797070657;931.1340453378356;915.9404638698463;920.6041402197053;921.3320342751518;923.3951761596165;923.6443969071955;665.9866802663968;677.1603212017112;678.5284227461916;679.1035832700837;681.0261326303385;11531.88468115325;11628;11635.476403561861;11683.41582920859;11697.064234861276;11833.171677982544;11925.701857453547;11925.91969187669;11988.801119888029;12304.446299916524;11117.27737697047;11247.775044499063;11310.208285420023;11345.943270283678;11592.304461732323;4178;4229.069604686964;4264.23243816113;4398.692091553593;4435.024294655171;45855.77072114652;46014.53985460136;46277.07445851098;46406.30390544145;47083.529164708256;10190.337628054152;10261.897381026094;10284.382937023802;10313.329633573794;10518.42223666456;17935.551611209565;17949.102544872967;17976.730349044774;18069.909650451926;18632.347867824563;6651.567648102858;6670.299618540081;6691;6699;6902.102726645504;3256.7720259582075;3306.5866766654167;3351.346487434927;3371.4268574342423;3375.8987230383127;2897.463969165711;2944.102048875071;2954.3943491584173;2968.450836595237;2977.434287485371;531.3729798837409;534.3480953237045;546.8796864689762;548.1120584652888;560.1597603594608;432.83119583362515;464.96512761542346;485.9271109333628;546.4016901492859;551.0246863052375;7478.663460144197;7567;7643.847123057508;7956;7962.3630109591095;588.6026931821003;600.7626987339976;604.1300527240759;613.8987067133962;629.1475051305415;3290.670932906738;3417.2823707021307;3473.1664400543686;3475.1138459692615;3534.770239934396;49679;50352.98588056437;50630;50799;50818.491815081376;43944.3408348875;45559.77220113944;45791.313130303075;45841.54158458373;46473.76763116231;42076.368854467204;42155.57844421516;43270.56729432728;43429.565704343186;43569.782151089676;6980.162380514371;7110.964445177741;7137.250588688113;7250.854982900418;7354.521956072838;28770.807298175456;29242.268943275736;29484.11547653574;29495.26261843471;30044.699553005066;33808;34269.48595771015;37252;37748.245035099695;38004.809975949946;9344.439333640003;9631.9036809631;9664.130228279208;9675.854862177213;9782.41305521671;9479.952600236955;9588.472634004918;9723.31936764448;9770.120689138012;9901.851472227778;9621.134097931219;9651.758706032406;9716.125548700651;9772.706818795448;9791.608335666493;9184.403013804082;9229.630814767334;9352.53237338144;9374.859377109486;9454.952725236604;9063.32025098107;9288.58201380926;9294.349395542518;9306.302027347841;9440.622375105193;7443.18125006238;7767.689292428466;7904.84190316202;7942.324902383362;8215.260626543639;7887.881681774663;9448.811023779623;9575.186109180797;9888.802223955337;9963.25275604347 04:00:53 INFO - PROCESS | 27377 | __end_tp_report 04:00:53 INFO - PROCESS | 27377 | __start_cc_report 04:00:53 INFO - PROCESS | 27377 | _x_x_mozilla_cycle_collect,394 04:00:53 INFO - PROCESS | 27377 | __end_cc_report 04:00:53 INFO - PROCESS | 27377 | __startTimestamp1462791653351__endTimestamp 04:00:53 INFO - PROCESS | 27377 | 04:00:53 INFO - PROCESS | 27377 | ------- Summary: start ------- 04:00:53 INFO - PROCESS | 27377 | Number of tests: 6 04:00:53 INFO - PROCESS | 27377 | 04:00:53 INFO - PROCESS | 27377 | [#0] dojo.html Cycles:165 Average:4809.85 Median:4988.23 stddev:616.61 (12.4%) stddev-sans-first:594.77 04:00:53 INFO - PROCESS | 27377 | Values: 2650.2 2723.2 2739.6 2751.7 2753.0 4794.6 4838.3 4860.4 4932.5 4991.6 4682.5 4805.0 4873.9 4895.4 4899.2 4480.0 4509.0 4589.5 4614.1 4643.2 591.0 4135.6 4362.4 4450.3 4457.6 4467.0 4470.6 4472.4 4504.8 4528.2 4494.8 4495.3 4497.7 4500.6 4530.1 4374.3 4382.1 4389.3 4413.4 4432.6 4638.5 4718.9 4739.1 4742.6 4776.0 5194.5 5207.1 5211.1 5240.8 5272.8 5333.0 5350.3 5360.3 5363.5 5427.5 4909.7 4924.8 4969.4 4988.2 5002.0 5159.4 5298.2 5346.4 5430.0 5452.2 5145.8 5153.9 5155.3 5168.3 5221.3 5206.6 5217.8 5224.2 5245.8 5298.1 5072.2 5158.4 5209.0 5223.4 5261.7 5213.3 5250.0 5260.6 5263.1 5272.5 4455.4 4472.6 4473.8 4493.1 4522.2 3739.7 3857.2 3858.1 3891.4 3907.7 4333.5 4446.4 4474.5 4498.9 4519.4 5282.5 5301.8 5303.0 5325.4 5352.8 4352.5 4494.4 4512.2 4529.5 4549.5 4739.9 4754.5 4754.6 4757.9 4778.8 4935.2 4970.1 4985.9 4990.1 4995.3 5087.9 5173.2 5222.0 5226.5 5274.6 4903.1 4903.3 4930.3 4930.6 4948.0 4992.8 5103.1 5111.8 5157.2 5168.6 5243.7 5262.2 5288.4 5308.9 5314.2 5128.8 5144.5 5153.8 5168.2 5189.8 4940.6 4957.2 5155.4 5162.6 5169.2 4991.9 4996.7 5021.7 5024.4 5092.1 5140.8 5144.3 5171.0 5178.7 5224.0 4891.9 5021.2 5024.1 5052.0 5064.6 04:00:53 INFO - PROCESS | 27377 | 04:00:53 INFO - PROCESS | 27377 | [#1] ext.html Cycles:180 Average:45353.22 Median:205797.00 stddev:78880.41 (38.3%) stddev-sans-first:79029.99 04:00:53 INFO - PROCESS | 27377 | Values: 557.7 594.6 595.6 617.6 630.9 36665.8 40642.0 40938.0 40970.6 41064.2 41293.4 41780.2 41782.4 41976.0 41981.0 7789.4 7933.4 7969.5 7976.4 7992.6 7854.3 7886.1 7924.7 7935.3 7967.2 7916.7 7961.5 7966.2 7997.9 8028.5 7803.5 7927.7 7956.6 7958.4 7979.5 7831.6 7885.2 7907.5 7918.1 7934.0 30708.5 38174.2 38669.0 38718.8 38805.2 3182.9 3198.3 3217.9 3322.1 3376.7 28212.2 28360.7 28420.4 30473.8 31412.0 3262.8 3288.7 3326.7 3418.9 3463.9 247200.0 251052.0 253280.0 253518.0 257222.0 35179.3 36309.5 60094.0 61452.4 61756.1 36686.0 36892.4 36908.3 36988.8 37234.6 12869.7 13053.5 13064.5 13087.5 13102.6 9895.4 9917.5 9927.4 9972.4 10015.2 8546.9 8561.3 8577.2 8581.5 8630.8 3361.4 3376.3 3379.9 3453.4 3465.6 930.5 935.7 998.9 1039.1 1103.0 28904.1 29589.4 30214.3 30245.2 30248.4 993.3 1004.8 1015.6 1042.3 1042.8 15477.7 16001.9 16092.0 16203.4 16318.9 368254.0 371038.0 371265.0 372828.0 373599.0 51712.7 53435.7 53717.5 53824.7 53903.7 1261.3 1264.8 1265.4 1270.6 1290.8 28713.6 29436.0 29841.0 30025.5 30304.0 46385.3 46444.3 46642.8 46721.8 46834.8 260920.0 261079.0 261313.2 262313.0 262565.0 27074.9 27116.2 27976.0 28020.4 28092.6 39951.6 39997.2 44417.0 44891.0 45657.5 38059.4 38419.2 38750.2 39076.0 39343.6 38033.4 38442.6 38613.2 38966.6 39480.8 37995.0 39648.6 40166.0 40582.6 43395.0 32653.3 35159.5 35824.8 35829.3 35870.8 26686.7 26937.9 27031.3 27138.0 27491.0 04:00:53 INFO - PROCESS | 27377 | 04:00:53 INFO - PROCESS | 27377 | [#2] jquery.html Cycles:180 Average:23627.92 Median:47799.52 stddev:64089.39 (134.1%) stddev-sans-first:64245.38 04:00:53 INFO - PROCESS | 27377 | Values: 366.8 370.7 370.9 382.7 389.3 15845.0 16060.3 16147.4 16298.9 16342.3 16348.2 16757.2 17685.7 17694.4 17726.9 4992.3 5153.0 5181.7 5181.9 5200.9 3698.7 5069.2 5611.2 5926.9 5933.3 5949.8 5958.6 5961.3 5968.3 5992.3 5747.6 5940.9 5942.0 5964.4 5978.2 5079.6 5132.3 5141.2 5181.4 5187.8 20313.4 20372.4 20661.3 20678.3 20690.0 1824.0 1952.8 1990.0 2012.1 2079.5 9124.0 9159.4 9268.5 9460.4 9495.2 1776.2 1788.4 1802.9 1822.5 1873.7 67208.7 68975.0 69254.0 69681.0 71586.3 9317.9 9396.9 9454.8 9583.7 9598.5 12837.4 12906.9 12936.5 12944.7 12989.3 6659.6 6665.8 6691.3 6747.3 6831.2 6364.6 6433.4 6510.0 6535.8 6561.0 3903.8 3913.5 3949.7 4025.1 4053.5 1617.0 1696.7 1768.3 1781.8 1881.8 898.4 921.1 952.3 955.8 995.3 16451.7 16613.8 16667.6 16918.7 16947.2 909.7 920.9 947.2 956.5 977.3 9411.8 9484.9 9641.6 9674.8 9814.8 382353.0 385690.0 393253.0 393663.0 394580.0 47158.5 47595.3 49921.5 78306.6 78838.0 951.9 977.7 986.7 1001.6 1007.5 14838.1 14963.9 15080.6 15217.8 15237.5 34082.8 34447.5 34653.5 35217.0 35971.6 45496.0 48003.8 49132.5 49827.8 49856.5 7439.7 7733.9 7745.1 7757.7 7996.8 9181.6 10424.4 11412.8 11565.5 11853.9 9643.5 10326.2 10368.0 10511.3 10708.6 8921.4 9699.4 10023.1 10569.9 10696.4 10252.9 10258.7 10525.8 10619.7 10671.3 7646.9 7813.3 7846.5 7966.7 8021.3 9039.4 10190.9 10255.6 10287.1 10408.2 04:00:53 INFO - PROCESS | 27377 | 04:00:53 INFO - PROCESS | 27377 | [#3] mootools.html Cycles:180 Average:4903.80 Median:5131.19 stddev:2660.51 (51.8%) stddev-sans-first:2655.32 04:00:53 INFO - PROCESS | 27377 | Values: 1450.9 1483.9 1638.4 1813.9 1835.2 6443.3 7122.4 7137.9 7598.2 7623.2 7134.9 7369.6 7422.7 7434.8 7459.7 2207.9 2224.1 2227.4 2238.5 2247.7 2214.6 2215.4 2220.1 2238.1 2245.9 2139.1 2178.8 2187.6 2203.4 2242.9 2153.4 2155.6 2159.3 2165.9 2174.4 2131.5 2135.5 2136.3 2137.9 2144.1 7363.4 7379.0 7383.0 7396.5 7475.5 4375.0 4399.9 4415.9 4453.1 4481.6 2902.8 2924.4 3039.8 3069.1 3069.7 879.1 892.1 906.8 921.6 967.9 9209.8 9559.0 9577.6 9720.4 9817.7 3999.5 4037.1 4125.0 4141.2 4155.6 8079.6 8086.4 8104.0 8104.5 8111.9 4418.7 4429.4 4443.7 4473.3 4515.3 3512.8 3995.7 4096.7 4108.6 4143.5 3408.1 3413.9 3464.1 3499.2 3502.4 1031.5 1031.6 1034.5 1042.1 1044.9 767.2 781.3 859.5 894.6 924.0 5122.6 5125.9 5177.4 5184.0 5213.2 408.3 428.3 429.0 431.2 433.9 3451.9 3500.8 3542.5 3571.7 3594.7 8765.8 8979.2 9098.9 9120.3 9134.0 8956.6 8996.6 9019.6 9038.0 9066.9 6828.5 6924.4 7061.9 7074.9 7088.4 4954.0 5040.9 5061.8 5069.6 5136.5 8380.1 8414.9 8417.2 8482.4 8504.8 7986.0 8363.2 8388.9 8538.4 8639.4 5851.9 6337.3 6542.2 6570.3 6691.1 7228.3 7232.9 7239.9 7292.8 7316.3 6389.6 6669.2 6691.5 6721.6 6755.3 6424.6 6452.9 6624.1 6630.3 6735.1 6241.2 6283.2 6317.7 6326.0 6338.3 4282.8 4387.6 4425.3 4463.0 4474.5 4477.2 4494.0 4515.8 4518.7 4536.9 04:00:53 INFO - PROCESS | 27377 | 04:00:53 INFO - PROCESS | 27377 | [#4] prototype.html Cycles:180 Average:4257.13 Median:4893.59 stddev:1240.14 (25.3%) stddev-sans-first:1207.71 04:00:53 INFO - PROCESS | 27377 | Values: 310.3 312.2 313.9 316.0 316.5 4972.0 4978.4 5003.4 5017.7 5021.2 4885.2 4897.4 4897.6 4902.0 4939.8 3658.4 3720.3 3821.5 3855.3 3862.0 3842.7 3852.2 3858.3 3858.4 3876.2 3837.3 3845.0 3847.7 3853.6 3870.2 3574.8 3843.9 3849.7 3854.4 3858.3 3288.9 3331.3 3335.9 3344.1 3361.2 4708.9 4728.6 4743.9 4753.8 4761.5 4366.3 4370.2 4378.1 4387.7 4389.3 4998.2 5162.4 5172.9 5173.7 5174.4 3659.2 3659.4 3666.8 3666.9 3668.6 5391.4 5425.6 5426.8 5429.7 5435.5 3645.3 3748.1 3758.8 3778.0 3783.4 3815.8 3832.1 3836.7 3837.9 3839.8 4362.6 4363.5 4371.3 4381.1 4384.2 5053.0 5189.8 5249.7 5256.7 5279.9 1264.7 1269.7 1272.4 1274.0 1277.2 821.0 855.3 870.3 881.8 884.4 4414.8 4541.0 4542.7 4551.0 4552.6 5341.4 5347.4 5356.2 5368.6 5395.1 4368.5 4506.4 4516.5 4528.8 4568.1 2697.6 2773.5 2778.7 2789.2 2804.5 4879.2 4908.2 4936.3 4950.0 4951.3 5107.8 5289.7 5334.2 5368.2 5437.2 4855.1 4869.8 4889.8 4909.3 4956.5 5187.5 5209.7 5241.7 5282.8 5287.5 5029.3 5082.3 5147.9 5165.8 5175.2 4918.7 4929.6 4936.5 4940.6 4957.5 3617.5 3635.8 3644.7 3655.5 3682.7 4965.0 5088.2 5213.8 5234.0 5261.4 5061.9 5074.3 5077.8 5103.7 5107.8 4970.5 5061.4 5067.3 5077.9 5084.4 4782.0 5006.5 5033.2 5076.2 5098.0 4964.0 5116.4 5202.5 5230.4 5233.2 5112.2 5115.4 5134.4 5143.7 5147.7 04:00:53 INFO - PROCESS | 27377 | 04:00:53 INFO - PROCESS | 27377 | [#5] yui.html Cycles:180 Average:12449.71 Median:546.64 stddev:14207.17 (2599.0%) stddev-sans-first:14219.86 04:00:53 INFO - PROCESS | 27377 | Values: 750.6 776.7 778.8 784.8 788.2 11222.9 12504.6 12749.4 12810.8 13437.5 14204.0 14286.9 14320.6 14330.6 14381.1 657.1 878.5 879.7 882.2 888.5 858.2 888.3 891.3 893.7 897.4 916.0 927.7 928.2 929.8 931.1 915.9 920.6 921.3 923.4 923.6 666.0 677.2 678.5 679.1 681.0 11531.9 11628.0 11635.5 11683.4 11697.1 11833.2 11925.7 11925.9 11988.8 12304.4 11117.3 11247.8 11310.2 11345.9 11592.3 4178.0 4229.1 4264.2 4398.7 4435.0 45855.8 46014.5 46277.1 46406.3 47083.5 10190.3 10261.9 10284.4 10313.3 10518.4 17935.6 17949.1 17976.7 18069.9 18632.3 6651.6 6670.3 6691.0 6699.0 6902.1 3256.8 3306.6 3351.3 3371.4 3375.9 2897.5 2944.1 2954.4 2968.5 2977.4 531.4 534.3 546.9 548.1 560.2 432.8 465.0 485.9 546.4 551.0 7478.7 7567.0 7643.8 7956.0 7962.4 588.6 600.8 604.1 613.9 629.1 3290.7 3417.3 3473.2 3475.1 3534.8 49679.0 50353.0 50630.0 50799.0 50818.5 43944.3 45559.8 45791.3 45841.5 46473.8 42076.4 42155.6 43270.6 43429.6 43569.8 6980.2 7111.0 7137.3 7250.9 7354.5 28770.8 29242.3 29484.1 29495.3 30044.7 33808.0 34269.5 37252.0 37748.2 38004.8 9344.4 9631.9 9664.1 9675.9 9782.4 9480.0 9588.5 9723.3 9770.1 9901.9 9621.1 9651.8 9716.1 9772.7 9791.6 9184.4 9229.6 9352.5 9374.9 9455.0 9063.3 9288.6 9294.3 9306.3 9440.6 7443.2 7767.7 7904.8 7942.3 8215.3 7887.9 9448.8 9575.2 9888.8 9963.3 04:00:53 INFO - PROCESS | 27377 | -------- Summary: end -------- 04:00:53 INFO - PROCESS | 27377 | 04:00:54 INFO - TEST-INFO | 27377: exit 0 04:00:54 INFO - TEST-OK | dromaeo_css | took 1115814ms 04:00:54 INFO - TEST-START | kraken 04:00:54 INFO - operating with platform_type : linux_ 04:00:54 INFO - Initialising browser for kraken test... 04:00:54 INFO - TEST-INFO | started process 27612 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbSoynx/profile http://localhost:34444/getInfo.html) 04:00:57 INFO - PROCESS | 27612 | 04:00:57 INFO - PROCESS | 27612 | (process:27680): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:00:58 INFO - PROCESS | 27612 | __metrics Screen width/height:1600/1200 04:00:58 INFO - PROCESS | 27612 | colorDepth:24 04:00:58 INFO - PROCESS | 27612 | Browser inner width/height: 1024/697 04:00:58 INFO - PROCESS | 27612 | __metrics 04:00:59 ERROR - PROCESS | 27612 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 04:01:00 INFO - TEST-INFO | 27612: exit 0 04:01:00 INFO - Browser initialized. 04:01:00 INFO - Running cycle 1/1 for kraken test... 04:01:00 INFO - TEST-INFO | started process 27731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbSoynx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:01:02 INFO - PROCESS | 27731 | 04:01:02 INFO - PROCESS | 27731 | (process:27791): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:01:12 INFO - PROCESS | 27731 | RSS: Main: 164560896 04:01:12 INFO - PROCESS | 27731 | 04:01:14 INFO - PROCESS | 27731 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34444/tests/kraken/driver.html?testName=audio-beat-detection) 04:01:15 INFO - PROCESS | 27731 | RSS: Main: 168583168 04:01:15 INFO - PROCESS | 27731 | 04:01:18 INFO - PROCESS | 27731 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34444/tests/kraken/driver.html?testName=audio-dft) 04:01:19 INFO - PROCESS | 27731 | RSS: Main: 169340928 04:01:19 INFO - PROCESS | 27731 | 04:01:22 INFO - PROCESS | 27731 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34444/tests/kraken/driver.html?testName=audio-fft) 04:01:22 INFO - PROCESS | 27731 | RSS: Main: 164413440 04:01:22 INFO - PROCESS | 27731 | 04:01:25 INFO - PROCESS | 27731 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34444/tests/kraken/driver.html?testName=audio-oscillator) 04:01:25 INFO - PROCESS | 27731 | RSS: Main: 163897344 04:01:25 INFO - PROCESS | 27731 | 04:01:28 INFO - PROCESS | 27731 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34444/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:01:28 INFO - PROCESS | 27731 | RSS: Main: 164937728 04:01:28 INFO - PROCESS | 27731 | 04:01:32 INFO - PROCESS | 27731 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34444/tests/kraken/driver.html?testName=imaging-darkroom) 04:01:32 INFO - PROCESS | 27731 | RSS: Main: 164651008 04:01:32 INFO - PROCESS | 27731 | 04:01:36 INFO - PROCESS | 27731 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34444/tests/kraken/driver.html?testName=imaging-desaturate) 04:01:36 INFO - PROCESS | 27731 | RSS: Main: 163778560 04:01:36 INFO - PROCESS | 27731 | 04:01:39 INFO - PROCESS | 27731 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34444/tests/kraken/driver.html?testName=json-parse-financial) 04:01:40 INFO - PROCESS | 27731 | RSS: Main: 163577856 04:01:40 INFO - PROCESS | 27731 | 04:01:42 INFO - PROCESS | 27731 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34444/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:01:43 INFO - PROCESS | 27731 | RSS: Main: 163831808 04:01:43 INFO - PROCESS | 27731 | 04:01:44 INFO - PROCESS | 27731 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34444/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:01:45 INFO - PROCESS | 27731 | RSS: Main: 164212736 04:01:45 INFO - PROCESS | 27731 | 04:01:47 INFO - PROCESS | 27731 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34444/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:01:48 INFO - PROCESS | 27731 | RSS: Main: 165359616 04:01:48 INFO - PROCESS | 27731 | 04:01:51 INFO - PROCESS | 27731 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:01:52 INFO - PROCESS | 27731 | RSS: Main: 164823040 04:01:52 INFO - PROCESS | 27731 | 04:01:55 INFO - PROCESS | 27731 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:01:55 INFO - PROCESS | 27731 | RSS: Main: 164691968 04:01:55 INFO - PROCESS | 27731 | 04:01:57 INFO - PROCESS | 27731 | Cycle 1(1): loaded http://localhost:34444/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34444/tests/kraken/driver.html?testName=ai-astar) 04:01:57 INFO - PROCESS | 27731 | RSS: Main: 167030784 04:01:57 INFO - PROCESS | 27731 | 04:01:57 INFO - PROCESS | 27731 | __start_tp_report 04:01:57 INFO - PROCESS | 27731 | _x_x_mozilla_page_load 04:01:57 INFO - PROCESS | 27731 | _x_x_mozilla_page_load_details 04:01:57 INFO - PROCESS | 27731 | |i|pagename|runs| 04:01:57 INFO - PROCESS | 27731 | |0;ai-astar;115;116;106;116;116;116;109;116;117;115 04:01:57 INFO - PROCESS | 27731 | |1;audio-beat-detection;162;132;160;228;143;165;169;139;195;140 04:01:57 INFO - PROCESS | 27731 | |2;audio-dft;162;163;166;167;165;164;163;165;165;163 04:01:57 INFO - PROCESS | 27731 | |3;audio-fft;77;77;78;183;76;76;77;78;156;78 04:01:57 INFO - PROCESS | 27731 | |4;audio-oscillator;100;94;191;94;94;93;148;95;93;155 04:01:57 INFO - PROCESS | 27731 | |5;imaging-gaussian-blur;119;118;118;118;118;119;119;118;125;125 04:01:57 INFO - PROCESS | 27731 | |6;imaging-darkroom;149;147;149;148;149;150;147;150;149;149 04:01:57 INFO - PROCESS | 27731 | |7;imaging-desaturate;96;95;96;97;97;97;96;96;97;96 04:01:57 INFO - PROCESS | 27731 | |8;json-parse-financial;68;68;68;68;68;67;74;69;67;68 04:01:57 INFO - PROCESS | 27731 | |9;json-stringify-tinderbox;65;66;66;66;65;65;65;65;66;65 04:01:57 INFO - PROCESS | 27731 | |10;stanford-crypto-aes;85;83;84;82;88;87;83;88;146;83 04:01:57 INFO - PROCESS | 27731 | |11;stanford-crypto-ccm;153;134;150;133;147;138;135;145;165;137 04:01:57 INFO - PROCESS | 27731 | |12;stanford-crypto-pbkdf2;172;178;177;174;176;172;179;172;177;172 04:01:57 INFO - PROCESS | 27731 | |13;stanford-crypto-sha256-iterative;71;69;71;67;68;70;68;67;72;70 04:01:57 INFO - PROCESS | 27731 | __end_tp_report 04:01:57 INFO - PROCESS | 27731 | __start_cc_report 04:01:57 INFO - PROCESS | 27731 | _x_x_mozilla_cycle_collect,929 04:01:57 INFO - PROCESS | 27731 | __end_cc_report 04:01:57 INFO - PROCESS | 27731 | __startTimestamp1462791717890__endTimestamp 04:01:57 INFO - PROCESS | 27731 | 04:01:57 INFO - PROCESS | 27731 | ------- Summary: start ------- 04:01:57 INFO - PROCESS | 27731 | Number of tests: 14 04:01:57 INFO - PROCESS | 27731 | 04:01:57 INFO - PROCESS | 27731 | [#0] ai-astar Cycles:10 Average:114.20 Median:116.00 stddev:3.65 (3.1%) stddev-sans-first:3.86 04:01:57 INFO - PROCESS | 27731 | Values: 115.0 116.0 106.0 116.0 116.0 116.0 109.0 116.0 117.0 115.0 04:01:57 INFO - PROCESS | 27731 | 04:01:57 INFO - PROCESS | 27731 | [#1] audio-beat-detection Cycles:10 Average:163.30 Median:163.50 stddev:29.37 (18.0%) stddev-sans-first:31.15 04:01:57 INFO - PROCESS | 27731 | Values: 162.0 132.0 160.0 228.0 143.0 165.0 169.0 139.0 195.0 140.0 04:01:57 INFO - PROCESS | 27731 | 04:01:57 INFO - PROCESS | 27731 | [#2] audio-dft Cycles:10 Average:164.30 Median:165.00 stddev:1.57 (0.9%) stddev-sans-first:1.42 04:01:57 INFO - PROCESS | 27731 | Values: 162.0 163.0 166.0 167.0 165.0 164.0 163.0 165.0 165.0 163.0 04:01:57 INFO - PROCESS | 27731 | 04:01:57 INFO - PROCESS | 27731 | [#3] audio-fft Cycles:10 Average:95.60 Median:77.00 stddev:39.47 (51.3%) stddev-sans-first:41.29 04:01:57 INFO - PROCESS | 27731 | Values: 77.0 77.0 78.0 183.0 76.0 76.0 77.0 78.0 156.0 78.0 04:01:57 INFO - PROCESS | 27731 | 04:01:57 INFO - PROCESS | 27731 | [#4] audio-oscillator Cycles:10 Average:115.70 Median:93.50 stddev:35.55 (38.0%) stddev-sans-first:37.25 04:01:57 INFO - PROCESS | 27731 | Values: 100.0 94.0 191.0 94.0 94.0 93.0 148.0 95.0 93.0 155.0 04:01:57 INFO - PROCESS | 27731 | 04:01:57 INFO - PROCESS | 27731 | [#5] imaging-gaussian-blur Cycles:10 Average:119.70 Median:119.00 stddev:2.83 (2.4%) stddev-sans-first:2.99 04:01:57 INFO - PROCESS | 27731 | Values: 119.0 118.0 118.0 118.0 118.0 119.0 119.0 118.0 125.0 125.0 04:01:57 INFO - PROCESS | 27731 | 04:01:57 INFO - PROCESS | 27731 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 04:01:57 INFO - PROCESS | 27731 | Values: 149.0 147.0 149.0 148.0 149.0 150.0 147.0 150.0 149.0 149.0 04:01:57 INFO - PROCESS | 27731 | 04:01:57 INFO - PROCESS | 27731 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 04:01:57 INFO - PROCESS | 27731 | Values: 96.0 95.0 96.0 97.0 97.0 97.0 96.0 96.0 97.0 96.0 04:01:57 INFO - PROCESS | 27731 | 04:01:57 INFO - PROCESS | 27731 | [#8] json-parse-financial Cycles:10 Average:68.50 Median:68.00 stddev:2.01 (3.0%) stddev-sans-first:2.13 04:01:57 INFO - PROCESS | 27731 | Values: 68.0 68.0 68.0 68.0 68.0 67.0 74.0 69.0 67.0 68.0 04:01:57 INFO - PROCESS | 27731 | 04:01:57 INFO - PROCESS | 27731 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 04:01:57 INFO - PROCESS | 27731 | Values: 65.0 66.0 66.0 66.0 65.0 65.0 65.0 65.0 66.0 65.0 04:01:57 INFO - PROCESS | 27731 | 04:01:57 INFO - PROCESS | 27731 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:84.50 stddev:19.48 (23.1%) stddev-sans-first:20.55 04:01:57 INFO - PROCESS | 27731 | Values: 85.0 83.0 84.0 82.0 88.0 87.0 83.0 88.0 146.0 83.0 04:01:57 INFO - PROCESS | 27731 | 04:01:57 INFO - PROCESS | 27731 | [#11] stanford-crypto-ccm Cycles:10 Average:143.70 Median:146.00 stddev:10.30 (7.1%) stddev-sans-first:10.36 04:01:57 INFO - PROCESS | 27731 | Values: 153.0 134.0 150.0 133.0 147.0 138.0 135.0 145.0 165.0 137.0 04:01:57 INFO - PROCESS | 27731 | 04:01:57 INFO - PROCESS | 27731 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:176.50 stddev:2.81 (1.6%) stddev-sans-first:2.77 04:01:57 INFO - PROCESS | 27731 | Values: 172.0 178.0 177.0 174.0 176.0 172.0 179.0 172.0 177.0 172.0 04:01:57 INFO - PROCESS | 27731 | 04:01:57 INFO - PROCESS | 27731 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:70.00 stddev:1.77 (2.5%) stddev-sans-first:1.76 04:01:57 INFO - PROCESS | 27731 | Values: 71.0 69.0 71.0 67.0 68.0 70.0 68.0 67.0 72.0 70.0 04:01:57 INFO - PROCESS | 27731 | -------- Summary: end -------- 04:01:57 INFO - PROCESS | 27731 | 04:01:58 INFO - TEST-INFO | 27731: exit 0 04:01:59 INFO - TEST-OK | kraken | took 64921ms 04:01:59 INFO - SUITE-END | took 1180s 04:01:59 INFO - Completed test suite (00:19:40) 04:01:59 INFO - javascript benchmark 04:01:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2650.1651979626417, 2723.2374935018197, 2739.6027576001466, 2751.7248275172487, 2752.958705619416, 4794.640401969848, 4838.298446725227, 4860.416749990001, 4932.531409516099, 4991.6256280779, 4682.461516925555, 4805.0, 4873.902521949568, 4895.437024742156, 4899.2161254199245, 4480.0143968327, 4508.977455112737, 4589.5410458954175, 4614.146382919171, 4643.210654188796, 591.024235320806, 4135.60711732385, 4362.411074504948, 4450.310201918708, 4457.59881610655, 4467.01725620363, 4470.552944705536, 4472.373867658531, 4504.797284122223, 4528.230200865861, 4494.820207191741, 4495.34817451471, 4497.707649002837, 4500.639948804088, 4530.1392735380505, 4374.34384842273, 4382.057857560608, 4389.253826849444, 4413.44831896013, 4432.645388368955, 4638.512956139591, 4718.882027949328, 4739.123262196505, 4742.620590352763, 4775.952240477585, 5194.480551944813, 5207.140821764404, 5211.114110601206, 5240.764165612557, 5272.762725677354, 5333.040052790496, 5350.30446042016, 5360.303160589137, 5363.54409875161, 5427.48438898304, 4909.729964851932, 4924.803007879645, 4969.378827646544, 4988.226824842155, 5002.024605202024, 5159.355080614923, 5298.15229563268, 5346.43862394443, 5429.972850135724, 5452.236686863842, 5145.794168233304, 5153.871153221125, 5155.278261043457, 5168.302279192261, 5221.347331583552, 5206.635535512553, 5217.843464696065, 5224.164133738584, 5245.816396426107, 5298.072837253542, 5072.163093089673, 5158.432572417031, 5208.9739551302, 5223.399309079428, 5261.710605916634, 5213.3222681051975, 5249.973750131225, 5260.579153667697, 5263.131583288715, 5272.499112584298, 4455.443069616298, 4472.619827314649, 4473.821047158142, 4493.1013797240685, 4522.23122069249, 3739.6821270191795, 3857.1707082977296, 3858.054776579756, 3891.4357418174204, 3907.706921980806, 4333.523312435629, 4446.399736035659, 4474.485434175046, 4498.932516012263, 4519.435070616173, 5282.524572788468, 5301.761420736076, 5302.965921645319, 5325.3875804282225, 5352.759125839269, 4352.455943007124, 4494.393256910341, 4512.187806194851, 4529.456465224128, 4549.454065512094, 4739.905201895943, 4754.4532378776885, 4754.643401744883, 4757.857264282077, 4778.832740854054, 4935.210366341368, 4970.130227210224, 4985.900281994267, 4990.076835785391, 4995.300657907968, 5087.898242035212, 5173.22401639757, 5222.033923724123, 5226.529612334908, 5274.578033757213, 4903.092927808367, 4903.289023091703, 4930.2604609307455, 4930.6055515557955, 4947.960928205117, 4992.825251116194, 5103.055934652101, 5111.795528178831, 5157.226416037624, 5168.560672342743, 5243.68537887728, 5262.210668399617, 5288.444713305202, 5308.893822123613, 5314.176302673091, 5128.79484820603, 5144.459831717765, 5153.819616313561, 5168.224766285088, 5189.81835635766, 4940.580050695731, 4957.157283261782, 5155.3813542373655, 5162.561182299547, 5169.224616307584, 4991.925121123259, 4996.7001979881325, 5021.748912554284, 5024.371953505812, 5092.108880945746, 5140.76866541014, 5144.331236939174, 5171.0, 5178.663386879841, 5224.03355379256, 4891.853244402673, 5021.221710634857, 5024.095662780588, 5052.0, 5064.620153488577], "value": 4771.115958222379, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.6960556496709, 594.56002558107, 595.6396380189985, 617.5923890232444, 630.8864404407211, 36665.816670916676, 40642.0, 40938.0, 40970.59029409705, 41064.17871642569, 41293.380599291035, 41780.16439671205, 41782.37326440106, 41976.0, 41981.0, 7789.4157938154585, 7933.444658873881, 7969.481983671043, 7976.441649084566, 7992.600369981477, 7854.253845884632, 7886.093099293568, 7924.722634707787, 7935.285824275814, 7967.163447837952, 7916.722914697987, 7961.482503637245, 7966.203379662045, 7997.880031799527, 8028.5182889026555, 7803.453758236926, 7927.72252971149, 7956.602169891511, 7958.442908996372, 7979.48133371329, 7831.608419579055, 7885.172056933997, 7907.525548467111, 7918.129005809356, 7933.96033019837, 30708.53937190944, 38174.23651526954, 38669.0, 38718.80640596779, 38805.22389552193, 3182.8726850925937, 3198.296374797541, 3217.8551965161623, 3322.1030321812973, 3376.6960973512255, 28212.153635390972, 28360.716392836013, 28420.43159136806, 30473.847630761928, 31412.0, 3262.8368581570826, 3288.7369010479106, 3326.7172290355347, 3418.9316213675834, 3463.8614455422003, 247200.0, 251052.0, 253280.0, 253518.0, 257222.0, 35179.29641407158, 36309.455358169645, 60094.0, 61452.38547614556, 61756.073658895155, 36686.0, 36892.446613300825, 36908.26183476369, 36988.815055925086, 37234.627653723655, 12869.742605147845, 13053.477860885458, 13064.54274100402, 13087.476500940045, 13102.60692179217, 9895.356801808004, 9917.504124793732, 9927.40435573868, 9972.401655900669, 10015.248856335804, 8546.871796923051, 8561.272291855263, 8577.228049475578, 8581.528015959057, 8630.784230394165, 3361.3949489092197, 3376.324735052999, 3379.8648054078053, 3453.3611281912927, 3465.601455832561, 930.4556834251903, 935.6725146198776, 998.9400635961865, 1039.095986491742, 1102.9503672334765, 28904.132876013755, 29589.37857934059, 30214.29561704045, 30245.243868903453, 30248.395032099234, 993.3344659078434, 1004.8241557727368, 1015.5988384588046, 1042.2652030318607, 1042.8331466965249, 15477.690446191013, 16001.919990399974, 16092.0, 16203.432879849148, 16318.918405407898, 368254.0, 371038.0, 371265.0, 372828.0, 373599.0, 51712.74143629258, 53435.73282133642, 53717.46282537203, 53824.73087634537, 53903.730481348124, 1261.3377976562379, 1264.778663733843, 1265.367316341829, 1270.6315168601002, 1290.832191815058, 28713.56929646015, 29436.0, 29841.0, 30025.54961675533, 30304.0, 46385.304220436046, 46444.30333544932, 46642.766786165856, 46721.766391167825, 46834.76582617065, 260920.0, 261079.0, 261313.16060518214, 262313.0, 262565.0, 27074.864625676746, 27116.1865144046, 27976.0, 28020.439591207654, 28092.578611321256, 39951.600483994785, 39997.200055999296, 44417.0, 44891.0, 45657.54342456533, 38059.42910856395, 38419.231615368095, 38750.224995500495, 39076.0, 39343.606563933994, 38033.42949855699, 38442.615573843905, 38613.22773544457, 38966.6103338963, 39480.80259598684, 37995.0, 39648.60351396449, 40166.0, 40582.594174059064, 43395.0, 32653.34693306073, 35159.47260791039, 35824.82087589546, 35829.28341433209, 35870.8206458966, 26686.733132668425, 26937.86531067332, 27031.324216894736, 27138.0, 27491.0], "value": 17016.179793680447, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.8092591852237, 370.73862926636724, 370.91839795245045, 382.71105315486835, 389.3439554350919, 15845.0, 16060.27728752206, 16147.43483978061, 16298.918505407457, 16342.346306147769, 16348.182590870469, 16757.162141892917, 17685.73471397927, 17694.38069667562, 17726.911365443153, 4992.251162325653, 5152.974235128819, 5181.689098654074, 5181.922271165936, 5200.8699782505555, 3698.7041036717133, 5069.239614057902, 5611.2144299798065, 5926.940730592703, 5933.317668468138, 5949.762009519614, 5958.612690175147, 5961.314448838396, 5968.343482216975, 5992.250968628921, 5747.626404283708, 5940.910886336686, 5942.049272116462, 5964.433378829004, 5978.192943952554, 5079.593632509391, 5132.307138536325, 5141.203113517374, 5181.4041385240425, 5187.766550505236, 20313.390598281927, 20372.388828335173, 20661.27685531014, 20678.276260330967, 20690.0, 1823.9817601823945, 1952.7851936286997, 1989.950251243716, 2012.1247257443058, 2079.469735217525, 9124.0, 9159.397699909126, 9268.49023303718, 9460.432374057578, 9495.240380769523, 1776.2362184260762, 1788.418763901737, 1802.9459116226535, 1822.5443639090226, 1873.7189421586734, 67208.6639566804, 68975.0, 69254.0, 69681.0, 71586.28413715848, 9317.860232096524, 9396.859047114298, 9454.810903781887, 9583.664571739955, 9598.520073996273, 12837.358132093357, 12906.935465322613, 12936.482540698455, 12944.741105177844, 12989.28558929268, 6659.567128136656, 6665.833354166185, 6691.26396096429, 6747.291534388818, 6831.2144103427745, 6364.554481186365, 6433.356664333623, 6509.967450162719, 6535.803925882231, 6560.967195163994, 3903.785291808921, 3913.4521167036637, 3949.6840252779707, 4025.0943537703783, 4053.5338436079637, 1616.9838301616833, 1696.7370057641085, 1768.3280353465857, 1781.8040015598274, 1881.8306352428347, 898.3846065445191, 921.1203300847808, 952.2905435450633, 955.8327292723745, 995.2983146881431, 16451.6709665806, 16613.750793738105, 16667.583310417092, 16918.74621880673, 16947.152642367833, 909.7407238936871, 920.9171174594319, 947.2280091725222, 956.502618638318, 977.3402953006693, 9411.811763764686, 9484.90515094854, 9641.614335426644, 9674.806503870024, 9814.803703925882, 382353.0, 385690.0, 393253.0, 393663.0, 394580.0, 47158.5284147161, 47595.286070708964, 49921.500784992415, 78306.6084669573, 78838.0, 951.9476428796482, 977.6822532676908, 986.6645340584236, 1001.62439085343, 1007.4811472091878, 14838.109713416798, 14963.850361496246, 15080.622984425478, 15217.847821522086, 15237.542873713806, 34082.82958585191, 34447.4832877512, 34653.48019779655, 35217.0, 35971.640283596826, 45496.0, 48003.75998120127, 49132.508674912795, 49827.75086124691, 49856.501434985184, 7439.665215065227, 7733.91725158467, 7745.109312428917, 7757.650905709143, 7996.800079998046, 9181.586828592595, 10424.374537527772, 11412.771744565229, 11565.479553420284, 11853.940730296294, 9643.517824108627, 10326.225533084898, 10368.0, 10511.316764410289, 10708.57165713394, 8921.394149053232, 9699.369540979813, 10023.148032417326, 10569.894301056891, 10696.358218506915, 10252.897471025493, 10258.692239232834, 10525.842112368167, 10619.734506637396, 10671.253012289066, 7646.923530764621, 7813.296803287504, 7846.450748447783, 7966.681332746625, 8021.27808497238, 9039.412438191497, 10190.898091018995, 10255.58977640886, 10287.074163325336, 10408.219383546415], "value": 8116.361324391706, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.9274536273188, 1483.9332230049647, 1638.4265507072525, 1813.927442902284, 1835.2383760739294, 6443.29123796382, 7122.3945964593, 7137.928620713791, 7598.16420193779, 7623.237676232381, 7134.928650713491, 7369.594672293022, 7422.665980030898, 7434.814129646748, 7459.701611935516, 2207.867527948324, 2224.143704673704, 2227.387468446182, 2238.4851484158653, 2247.6516139998325, 2214.5903007943502, 2215.4129155773735, 2220.123051394698, 2238.0712004518105, 2245.8877056147207, 2139.1336508713916, 2178.814800741939, 2187.58435897179, 2203.4160947348964, 2242.9439264018447, 2153.4078128514625, 2155.644318687415, 2159.3090211132444, 2165.9133634654595, 2174.4129085147, 2131.541718530523, 2135.4981579328846, 2136.2523116908956, 2137.935861924145, 2144.0994782191515, 7363.447741419415, 7379.0, 7382.963085184593, 7396.519226250277, 7475.476716629838, 4374.956250437487, 4399.890002749925, 4415.911681766347, 4453.131639330332, 4481.551844815525, 2902.840343781091, 2924.400497897947, 3039.832809195493, 3069.0946170879643, 3069.708377704137, 879.0594064351147, 892.1123482135253, 906.8231694819513, 921.6129225725144, 967.9225661947028, 9209.815803683956, 9558.95220523893, 9577.61689532418, 9720.396134637776, 9817.656382026595, 3999.460072890181, 4037.0916543778003, 4124.958750412457, 4141.213169497786, 4155.605217504332, 8079.636416361278, 8086.43394962347, 8103.9594802026795, 8104.5137291762685, 8111.878321825177, 4418.690691651618, 4429.357743127229, 4443.666724995638, 4473.2842745160615, 4515.254982927846, 3512.84192211346, 3995.6603688686205, 4096.651784598283, 4108.609682080198, 4143.544210136883, 3408.1138903885167, 3413.8805141819917, 3464.0647025303533, 3499.230169362736, 3502.404591219499, 1031.4739482863793, 1031.5770534080991, 1034.539629864718, 1042.124615323117, 1044.9373037617768, 767.1944458318743, 781.3397678961269, 859.5143743784741, 894.6063731957918, 923.958421871004, 5122.641415100908, 5125.8617606738935, 5177.404598471224, 5184.0, 5213.165893457029, 408.34868384925994, 428.29545397820414, 429.0175498109357, 431.16139109431856, 433.91755566442276, 3451.861925523001, 3500.7724497907557, 3542.4686297055646, 3571.7321200910037, 3594.694450971697, 8765.824683506295, 8979.236764874928, 9098.909010909938, 9120.270378369847, 9134.0, 8956.552172391355, 8996.59515321812, 9019.594118264562, 9037.954810226038, 9066.909330906607, 6828.5220034597105, 6924.446044316443, 7061.89407158893, 7074.893876591856, 7088.432925366062, 4953.950460495349, 5040.949590504195, 5061.797528098835, 5069.645124841373, 5136.512031357015, 8380.12008739098, 8414.948131483565, 8417.242448179693, 8482.363822713445, 8504.787380315294, 7986.0, 8363.20549547792, 8388.916110838814, 8538.359623028173, 8639.352048596505, 5851.853703657443, 6337.334579869047, 6542.182227221598, 6570.310117437601, 6691.09670194537, 7228.277172282729, 7232.89150662751, 7239.8914016288745, 7292.817679558054, 7316.268373162641, 6389.616623002635, 6669.199696036312, 6691.498137639794, 6721.630310332978, 6755.324467553205, 6424.550281480439, 6452.870942581028, 6624.072629831924, 6630.3038180992235, 6735.0570920072205, 6241.157443745218, 6283.151774510566, 6317.747290108528, 6325.9683701583035, 6338.271098823694, 4282.828686852491, 4387.627051700513, 4425.291953287458, 4462.977685111554, 4474.530174331649, 4477.171723231213, 4494.0337827367275, 4515.841945531891, 4518.6611004174165, 4536.909261814679], "value": 3938.0867243453486, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.32968787419173, 312.21166554450014, 313.8540578630938, 315.9668234835341, 316.50783032384635, 4971.955889263259, 4978.411226162398, 5003.374578177723, 5017.698938063719, 5021.196608542634, 4885.193942999401, 4897.351473152497, 4897.604182807891, 4901.975490122544, 4939.802407903689, 3658.378075727126, 3720.348938935689, 3821.464994900702, 3855.267499175148, 3862.0, 3842.6733727633186, 3852.1717830666403, 3858.266929283427, 3858.3826587745966, 3876.2247550489874, 3837.330761118922, 3844.961860297718, 3847.711421643388, 3853.556840963297, 3870.2453021660644, 3574.8212589370687, 3843.9039024024482, 3849.7497662652117, 3854.383298672199, 3858.2862170498406, 3288.917777055569, 3331.3004269103517, 3335.93328133436, 3344.1305260632166, 3361.210115622827, 4708.858734237944, 4728.598069164125, 4743.905121897577, 4753.762311884392, 4761.4524329701835, 4366.345048242757, 4370.2352088384405, 4378.080603073358, 4387.6709246806295, 4389.2977123660385, 4998.150684246815, 5162.354705661793, 5172.948270517322, 5173.741312934339, 5174.377935445165, 3659.176685245825, 3659.396199627058, 3666.7983260920637, 3666.853325866962, 3668.633136686337, 5391.353037635469, 5425.593080518976, 5426.75579598919, 5429.67421954684, 5435.483629055233, 3645.343838109166, 3748.1379282765115, 3758.830852611639, 3778.0366006668123, 3783.432485127253, 3815.778950735738, 3832.1186127190904, 3836.6547010769164, 3837.94456524458, 3839.8480455863128, 4362.563743625676, 4363.498197707241, 4371.278739008092, 4381.145676593033, 4384.172208925225, 5052.979575272578, 5189.766460509286, 5249.737513124329, 5256.658317209369, 5279.884867927941, 1264.7217612125319, 1269.676232560691, 1272.3574594829552, 1274.0, 1277.1698396042646, 821.0, 855.3371137368589, 870.3385427075468, 881.8015946412006, 884.4339622641514, 4414.779261036935, 4541.0, 4542.68201225911, 4550.977245113753, 4552.567506086916, 5341.412444631087, 5347.422510359454, 5356.1697936819855, 5368.570514358842, 5395.109806881899, 4368.541303163186, 4506.414166158378, 4516.522277846106, 4528.841490547815, 4568.109218702321, 2697.6223328733995, 2773.459175460766, 2778.7221277872454, 2789.1911345709923, 2804.4671512412983, 4879.2188452582395, 4908.165611845995, 4936.284238785356, 4949.975250123726, 4951.306817045616, 5107.821226257063, 5289.656172348785, 5334.226537152169, 5368.1679339702405, 5437.238786569884, 4855.101806165871, 4869.805207791649, 4889.828855990023, 4909.288153217834, 4956.529129732669, 5187.4984385540365, 5209.665813879044, 5241.659292145999, 5282.754829197653, 5287.471252874681, 5029.295898574275, 5082.33929589151, 5147.897042059063, 5165.793368265227, 5175.249588809676, 4918.721132505503, 4929.556339929423, 4936.506349365035, 4940.629452791127, 4957.504249575014, 3617.511635929221, 3635.763675361093, 3644.726645501651, 3655.5430571178604, 3682.686971607336, 4964.950350496449, 5088.236764485357, 5213.826888949956, 5233.979374022029, 5261.421243663118, 5061.898762024813, 5074.340335756328, 5077.822276220315, 5103.744812759422, 5107.807620237351, 4970.453250142554, 5061.392632884077, 5067.341245638191, 5077.949220507748, 5084.3898732152375, 4781.952180478151, 5006.524380184022, 5033.188052301095, 5076.213186956028, 5098.031374038921, 4963.975180124076, 5116.411612664591, 5202.531772140525, 5230.372355317234, 5233.215017747216, 5112.156494178419, 5115.411727651219, 5134.383873935151, 5143.71709555978, 5147.742612869267], "value": 3863.8651933933447, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.5571712689513, 776.7436745873858, 778.8364443466871, 784.846954843805, 788.1881661888256, 11222.887771122287, 12504.56234031809, 12749.426275817586, 12810.807837882416, 13437.529686460952, 14204.0, 14286.857131428682, 14320.64198395038, 14330.641733956656, 14381.06523076002, 657.1161787395945, 878.5431575580694, 879.6877108626442, 882.2104216726026, 888.524639317965, 858.1761508951383, 888.3337496877342, 891.3092353426114, 893.673809059695, 897.3673560140119, 915.9908400916006, 927.6938610258633, 928.2434815625278, 929.790797070657, 931.1340453378356, 915.9404638698463, 920.6041402197053, 921.3320342751518, 923.3951761596165, 923.6443969071955, 665.9866802663968, 677.1603212017112, 678.5284227461916, 679.1035832700837, 681.0261326303385, 11531.88468115325, 11628.0, 11635.476403561861, 11683.41582920859, 11697.064234861276, 11833.171677982544, 11925.701857453547, 11925.91969187669, 11988.801119888029, 12304.446299916524, 11117.27737697047, 11247.775044499063, 11310.208285420023, 11345.943270283678, 11592.304461732323, 4178.0, 4229.069604686964, 4264.23243816113, 4398.692091553593, 4435.024294655171, 45855.77072114652, 46014.53985460136, 46277.07445851098, 46406.30390544145, 47083.529164708256, 10190.337628054152, 10261.897381026094, 10284.382937023802, 10313.329633573794, 10518.42223666456, 17935.551611209565, 17949.102544872967, 17976.730349044774, 18069.909650451926, 18632.347867824563, 6651.567648102858, 6670.299618540081, 6691.0, 6699.0, 6902.102726645504, 3256.7720259582075, 3306.5866766654167, 3351.346487434927, 3371.4268574342423, 3375.8987230383127, 2897.463969165711, 2944.102048875071, 2954.3943491584173, 2968.450836595237, 2977.434287485371, 531.3729798837409, 534.3480953237045, 546.8796864689762, 548.1120584652888, 560.1597603594608, 432.83119583362515, 464.96512761542346, 485.9271109333628, 546.4016901492859, 551.0246863052375, 7478.663460144197, 7567.0, 7643.847123057508, 7956.0, 7962.3630109591095, 588.6026931821003, 600.7626987339976, 604.1300527240759, 613.8987067133962, 629.1475051305415, 3290.670932906738, 3417.2823707021307, 3473.1664400543686, 3475.1138459692615, 3534.770239934396, 49679.0, 50352.98588056437, 50630.0, 50799.0, 50818.491815081376, 43944.3408348875, 45559.77220113944, 45791.313130303075, 45841.54158458373, 46473.76763116231, 42076.368854467204, 42155.57844421516, 43270.56729432728, 43429.565704343186, 43569.782151089676, 6980.162380514371, 7110.964445177741, 7137.250588688113, 7250.854982900418, 7354.521956072838, 28770.807298175456, 29242.268943275736, 29484.11547653574, 29495.26261843471, 30044.699553005066, 33808.0, 34269.48595771015, 37252.0, 37748.245035099695, 38004.809975949946, 9344.439333640003, 9631.9036809631, 9664.130228279208, 9675.854862177213, 9782.41305521671, 9479.952600236955, 9588.472634004918, 9723.31936764448, 9770.120689138012, 9901.851472227778, 9621.134097931219, 9651.758706032406, 9716.125548700651, 9772.706818795448, 9791.608335666493, 9184.403013804082, 9229.630814767334, 9352.53237338144, 9374.859377109486, 9454.952725236604, 9063.32025098107, 9288.58201380926, 9294.349395542518, 9306.302027347841, 9440.622375105193, 7443.18125006238, 7767.689292428466, 7904.84190316202, 7942.324902383362, 8215.260626543639, 7887.881681774663, 9448.811023779623, 9575.186109180797, 9888.802223955337, 9963.25275604347], "value": 5859.79268400234, "unit": "score"}], "name": "dromaeo_css", "value": 6235.1509292557685, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 106.0, 116.0, 116.0, 116.0, 109.0, 116.0, 117.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 132.0, 160.0, 228.0, 143.0, 165.0, 169.0, 139.0, 195.0, 140.0], "value": 163.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 166.0, 167.0, 165.0, 164.0, 163.0, 165.0, 165.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 183.0, 76.0, 76.0, 77.0, 78.0, 156.0, 78.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 94.0, 191.0, 94.0, 94.0, 93.0, 148.0, 95.0, 93.0, 155.0], "value": 115.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 118.0, 118.0, 119.0, 119.0, 118.0, 125.0, 125.0], "value": 119.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 149.0, 148.0, 149.0, 150.0, 147.0, 150.0, 149.0, 149.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 97.0, 97.0, 97.0, 96.0, 96.0, 97.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 74.0, 69.0, 67.0, 68.0], "value": 68.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 84.0, 82.0, 88.0, 87.0, 83.0, 88.0, 146.0, 83.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 134.0, 150.0, 133.0, 147.0, 138.0, 135.0, 145.0, 165.0, 137.0], "value": 143.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 178.0, 177.0, 174.0, 176.0, 172.0, 179.0, 172.0, 177.0, 172.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 71.0, 67.0, 68.0, 70.0, 68.0, 67.0, 72.0, 70.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1630.5000000000002, "alertThreshold": 2.0}]} 04:01:59 INFO - Return code: 0 04:01:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:01:59 ERROR - # TBPL SUCCESS # 04:01:59 INFO - Running post-action listener: _resource_record_post_action 04:01:59 INFO - ##### 04:01:59 INFO - ##### Finished run-tests step (success) 04:01:59 INFO - ##### 04:01:59 INFO - Running post-run listener: _resource_record_post_run 04:02:00 INFO - Total resource usage - Wall time: 1198s; CPU: 14.0%; Read bytes: 4096; Write bytes: 538812416; Read time: 40; Write time: 730640 04:02:00 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 241520640; Read time: 0; Write time: 395208 04:02:00 INFO - run-tests - Wall time: 1182s; CPU: 14.0%; Read bytes: 4096; Write bytes: 296488960; Read time: 40; Write time: 335384 04:02:00 INFO - Running post-run listener: _upload_blobber_files 04:02:00 INFO - Blob upload gear active. 04:02:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:02:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:02:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:02:00 INFO - (blobuploader) - INFO - Open directory for files ... 04:02:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:02:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:02:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:01 INFO - (blobuploader) - INFO - Done attempting. 04:02:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:02:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:02:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:02:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:02:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:02:02 INFO - (blobuploader) - INFO - Done attempting. 04:02:02 INFO - (blobuploader) - INFO - Iteration through files over. 04:02:02 INFO - Return code: 0 04:02:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:02:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:02:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c6d8b63dc1fae41c8a5d378f9d984e7ef8fa1504c80308025d5179c4953e16b6f27b36b23e0653ad38bad1e6a865a219e9e01fc6911cf1a61cfb3598fb07cbd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07f2247a9734e37082a2f77a2ababc0305887023693fbdf3243c306fb2458b33db233ef0caceabba9460fd6e87d5ba6715b3c64376f6f2e2b7cc4aadd077da99"} 04:02:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:02:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:02:02 INFO - Contents: 04:02:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c6d8b63dc1fae41c8a5d378f9d984e7ef8fa1504c80308025d5179c4953e16b6f27b36b23e0653ad38bad1e6a865a219e9e01fc6911cf1a61cfb3598fb07cbd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07f2247a9734e37082a2f77a2ababc0305887023693fbdf3243c306fb2458b33db233ef0caceabba9460fd6e87d5ba6715b3c64376f6f2e2b7cc4aadd077da99"} 04:02:02 INFO - Running post-run listener: copy_logs_to_upload_dir 04:02:02 INFO - Copying logs to upload dir... 04:02:02 INFO - mkdir: /builds/slave/test/build/upload/logs 04:02:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.080064 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-09 04:02:01.591274) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 04:02:01.594871) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c6d8b63dc1fae41c8a5d378f9d984e7ef8fa1504c80308025d5179c4953e16b6f27b36b23e0653ad38bad1e6a865a219e9e01fc6911cf1a61cfb3598fb07cbd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07f2247a9734e37082a2f77a2ababc0305887023693fbdf3243c306fb2458b33db233ef0caceabba9460fd6e87d5ba6715b3c64376f6f2e2b7cc4aadd077da99"} build_url:https://queue.taskcluster.net/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011240 build_url: 'https://queue.taskcluster.net/v1/task/dZaR2WBKSuCN7BE3nEKI0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c6d8b63dc1fae41c8a5d378f9d984e7ef8fa1504c80308025d5179c4953e16b6f27b36b23e0653ad38bad1e6a865a219e9e01fc6911cf1a61cfb3598fb07cbd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07f2247a9734e37082a2f77a2ababc0305887023693fbdf3243c306fb2458b33db233ef0caceabba9460fd6e87d5ba6715b3c64376f6f2e2b7cc4aadd077da99"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 04:02:01.619456) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:02:01.619775) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1462790484.816106-755202281 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 04:02:01.703420) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 04:02:01.703743) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 04:02:01.704030) ========= ========= Total master_lag: 0.16 =========