builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1464031832.84 results: success (0) buildid: 20160523104044 builduid: 8bfc5daffab44767b7efa10e51005c3a revision: 6ac30d36c92309de1e179a1dd230c04e14a97f7f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:32.844961) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:32.845369) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:32.845659) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:32.873453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:32.873752) ========= 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=62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 12:30:33-- 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% 46.5M=0s 2016-05-23 12:30:33 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076382 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:32.965225) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:32.965760) ========= 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=62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016392 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:33.018986) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:33.019299) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6ac30d36c92309de1e179a1dd230c04e14a97f7f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6ac30d36c92309de1e179a1dd230c04e14a97f7f --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=62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 12:30:33,926 truncating revision to first 12 chars 2016-05-23 12:30:33,926 Setting DEBUG logging. 2016-05-23 12:30:33,926 attempt 1/10 2016-05-23 12:30:33,926 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6ac30d36c923?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 12:30:34,543 unpacking tar archive at: fx-team-6ac30d36c923/testing/mozharness/ program finished with exit code 0 elapsedTime=0.882187 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:33.914533) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:33.914862) ========= script_repo_revision: 6ac30d36c92309de1e179a1dd230c04e14a97f7f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:33.915259) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:33.915547) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 12:30:33.924128) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-23 12:30:33.924403) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:30:34 INFO - MultiFileLogger online at 20160523 12:30:34 in /builds/slave/test 12:30:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:30:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:30:34 INFO - {'append_to_log': False, 12:30:34 INFO - 'base_work_dir': '/builds/slave/test', 12:30:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:30:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:30:34 INFO - 'branch': 'Fx-Team-Non-PGO', 12:30:34 INFO - 'buildbot_json_path': 'buildprops.json', 12:30:34 INFO - 'config_files': ('talos/linux_config.py',), 12:30:34 INFO - 'default_actions': ('clobber', 12:30:34 INFO - 'read-buildbot-config', 12:30:34 INFO - 'download-and-extract', 12:30:34 INFO - 'populate-webroot', 12:30:34 INFO - 'create-virtualenv', 12:30:34 INFO - 'install', 12:30:34 INFO - 'run-tests'), 12:30:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:30:34 INFO - 'download_minidump_stackwalk': True, 12:30:34 INFO - 'download_symbols': 'ondemand', 12:30:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:30:34 INFO - 'tooltool.py': '/tools/tooltool.py', 12:30:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:30:34 INFO - '/tools/misc-python/virtualenv.py')}, 12:30:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:30:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:30:34 INFO - 'installer_path': 'installer.exe', 12:30:34 INFO - 'log_level': 'info', 12:30:34 INFO - 'log_name': 'talos', 12:30:34 INFO - 'log_to_console': True, 12:30:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:30:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:30:34 INFO - 'opt_config_files': (), 12:30:34 INFO - 'pip_index': False, 12:30:34 INFO - 'sps_profile': False, 12:30:34 INFO - 'sps_profile_interval': 0, 12:30:34 INFO - 'suite': 'dromaeojs-e10s', 12:30:34 INFO - 'system_bits': '32', 12:30:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:30:34 INFO - 'title': 'talos-linux64-ix-018', 12:30:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:30:34 INFO - 'use_talos_json': True, 12:30:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:30:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:30:34 INFO - 'work_dir': 'build'} 12:30:34 INFO - ##### 12:30:34 INFO - ##### Running clobber step. 12:30:34 INFO - ##### 12:30:34 INFO - Running pre-action listener: _resource_record_pre_action 12:30:34 INFO - Running main action method: clobber 12:30:34 INFO - rmtree: /builds/slave/test/build 12:30:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:30:35 INFO - Running post-action listener: _resource_record_post_action 12:30:35 INFO - ##### 12:30:35 INFO - ##### Finished clobber step (success) 12:30:35 INFO - ##### 12:30:35 INFO - ##### 12:30:35 INFO - ##### Running read-buildbot-config step. 12:30:35 INFO - ##### 12:30:35 INFO - Running pre-action listener: _resource_record_pre_action 12:30:35 INFO - Running main action method: read_buildbot_config 12:30:35 INFO - Using buildbot properties: 12:30:35 INFO - { 12:30:35 INFO - "project": "", 12:30:35 INFO - "product": "firefox", 12:30:35 INFO - "script_repo_revision": "production", 12:30:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:30:35 INFO - "repository": "", 12:30:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 12:30:35 INFO - "buildid": "20160523104044", 12:30:35 INFO - "pgo_build": "False", 12:30:35 INFO - "basedir": "/builds/slave/test", 12:30:35 INFO - "buildnumber": 1322, 12:30:35 INFO - "slavename": "talos-linux64-ix-018", 12:30:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:30:35 INFO - "platform": "ubuntu64_hw", 12:30:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:30:35 INFO - "branch": "fx-team", 12:30:35 INFO - "repo_path": "integration/fx-team", 12:30:35 INFO - "revision": "6ac30d36c92309de1e179a1dd230c04e14a97f7f", 12:30:35 INFO - "stage_platform": "linux64", 12:30:35 INFO - "builduid": "8bfc5daffab44767b7efa10e51005c3a", 12:30:35 INFO - "slavebuilddir": "test" 12:30:35 INFO - } 12:30:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 12:30:35 INFO - Running post-action listener: _resource_record_post_action 12:30:35 INFO - ##### 12:30:35 INFO - ##### Finished read-buildbot-config step (success) 12:30:35 INFO - ##### 12:30:35 INFO - ##### 12:30:35 INFO - ##### Running download-and-extract step. 12:30:35 INFO - ##### 12:30:35 INFO - Running pre-action listener: _resource_record_pre_action 12:30:35 INFO - Running main action method: download_and_extract 12:30:35 INFO - mkdir: /builds/slave/test/build/tests 12:30:35 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')]} 12:30:35 INFO - https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:30:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:30:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:30:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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 12:30:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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 12:30:36 INFO - Downloaded 1361 bytes. 12:30:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 12:30:36 INFO - Using the following test package requirements: 12:30:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:30:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:30:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:30:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:36 INFO - u'jsshell-linux-x86_64.zip'], 12:30:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:30:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 12:30:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:30:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:30:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:30:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 12:30:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:30:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:30:36 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')]} 12:30:36 INFO - https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:30:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:30:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:30:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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 12:30:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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 12:30:40 INFO - Downloaded 22814444 bytes. 12:30:40 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'] 12:30:40 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 12:30:41 INFO - Return code: 0 12:30:41 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 12:30:41 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')]} 12:30:41 INFO - https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:30:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:30:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 12:30:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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 12:30:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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 12:30:43 INFO - Downloaded 22814444 bytes. 12:30:43 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'] 12:30:43 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 12:30:45 INFO - Return code: 0 12:30:45 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')]} 12:30:45 INFO - https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:30:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:30:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 12:30:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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 12:30:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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 12:30:46 INFO - Downloaded 10840359 bytes. 12:30:46 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'] 12:30:46 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 12:30:47 INFO - Return code: 0 12:30: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')]} 12:30:47 INFO - https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:30:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:30:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:30:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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 12:30:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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 12:30:48 INFO - Downloaded 54814831 bytes. 12:30:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:30:48 INFO - mkdir: /builds/slave/test/properties 12:30:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:30:48 INFO - Writing to file /builds/slave/test/properties/build_url 12:30:48 INFO - Contents: 12:30:48 INFO - build_url:https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 12:30:49 INFO - Running post-action listener: _resource_record_post_action 12:30:49 INFO - Running post-action listener: set_extra_try_arguments 12:30:49 INFO - ##### 12:30:49 INFO - ##### Finished download-and-extract step (success) 12:30:49 INFO - ##### 12:30:49 INFO - ##### 12:30:49 INFO - ##### Running populate-webroot step. 12:30:49 INFO - ##### 12:30:49 INFO - Running pre-action listener: _resource_record_pre_action 12:30:49 INFO - Running main action method: populate_webroot 12:30:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:30:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:30:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:30:49 INFO - '--tppagecycles', 12:30:49 INFO - '7'], 12:30:49 INFO - 'tests': ['tsvgm']}}, 12:30:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:30:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:30:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:30:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:30:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:30:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:30:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:49 INFO - 'talos_options': ['--disable-e10s'], 12:30:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:30:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:30:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:49 INFO - 'talos_options': ['--disable-e10s'], 12:30:49 INFO - 'tests': ['damp', 'tps']}, 12:30:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:49 INFO - 'tests': ['damp', 'tps']}, 12:30:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:30:49 INFO - 'tests': ['dromaeo_dom']}, 12:30:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:30:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:30:49 INFO - 'tests': ['a11yr', 12:30:49 INFO - 'ts_paint', 12:30:49 INFO - 'tpaint', 12:30:49 INFO - 'sessionrestore', 12:30:49 INFO - 'sessionrestore_no_auto_restore', 12:30:49 INFO - 'tabpaint']}, 12:30:49 INFO - 'other-e10s': {'tests': ['a11yr', 12:30:49 INFO - 'ts_paint', 12:30:49 INFO - 'tpaint', 12:30:49 INFO - 'sessionrestore', 12:30:49 INFO - 'sessionrestore_no_auto_restore', 12:30:49 INFO - 'tabpaint']}, 12:30:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:30:49 INFO - 'ts_paint', 12:30:49 INFO - 'tpaint', 12:30:49 INFO - 'sessionrestore', 12:30:49 INFO - 'sessionrestore_no_auto_restore', 12:30:49 INFO - 'tabpaint']}, 12:30:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:30:49 INFO - 'ts_paint', 12:30:49 INFO - 'tpaint', 12:30:49 INFO - 'sessionrestore', 12:30:49 INFO - 'sessionrestore_no_auto_restore', 12:30:49 INFO - 'tabpaint']}, 12:30:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:30:49 INFO - 'tests': ['a11yr', 12:30:49 INFO - 'ts_paint', 12:30:49 INFO - 'tpaint', 12:30:49 INFO - 'sessionrestore', 12:30:49 INFO - 'sessionrestore_no_auto_restore', 12:30:49 INFO - 'tabpaint']}, 12:30:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:30:49 INFO - 'tests': ['a11yr', 12:30:49 INFO - 'ts_paint', 12:30:49 INFO - 'tpaint', 12:30:49 INFO - 'sessionrestore', 12:30:49 INFO - 'sessionrestore_no_auto_restore', 12:30:49 INFO - 'tabpaint']}, 12:30:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:30:49 INFO - 'tests': ['tsvgx', 12:30:49 INFO - 'tsvgr_opacity', 12:30:49 INFO - 'tart', 12:30:49 INFO - 'tscrollx', 12:30:49 INFO - 'cart']}, 12:30:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:30:49 INFO - 'tsvgr_opacity', 12:30:49 INFO - 'tart', 12:30:49 INFO - 'tscrollx', 12:30:49 INFO - 'cart']}, 12:30:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:49 INFO - 'talos_options': ['--disable-e10s'], 12:30:49 INFO - 'tests': ['tp5o']}, 12:30:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:49 INFO - 'tests': ['tp5o']}, 12:30:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:49 INFO - 'talos_options': ['--disable-e10s', 12:30:49 INFO - '--xperf_path', 12:30:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:30:49 INFO - 'tests': ['tp5n']}, 12:30:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:30:49 INFO - 'talos_options': ['--xperf_path', 12:30:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:30:49 INFO - 'tests': ['tp5n']}}, 12:30:49 INFO - 'talos.zip': {'path': '', 12:30:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:30:49 INFO - Running post-action listener: _resource_record_post_action 12:30:49 INFO - ##### 12:30:49 INFO - ##### Finished populate-webroot step (success) 12:30:49 INFO - ##### 12:30:49 INFO - ##### 12:30:49 INFO - ##### Running create-virtualenv step. 12:30:49 INFO - ##### 12:30:49 INFO - Running pre-action listener: _resource_record_pre_action 12:30:49 INFO - Running main action method: create_virtualenv 12:30:49 INFO - Creating virtualenv /builds/slave/test/build/venv 12:30:49 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 12:30:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:30:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:30:49 INFO - Using real prefix '/usr' 12:30:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:30:49 INFO - Installing distribute.............................................................................................................................................................................................done. 12:30:51 INFO - Installing pip.................done. 12:30:51 INFO - Return code: 0 12:30:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:30: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')]} 12:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30: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')]} 12:30:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:51 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 0x7f91829d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf769c0>, '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 0xf778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf77d50>, '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': '62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061', '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 12:30:51 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 12:30:51 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 12:30:51 INFO - Using env: {'DISPLAY': ':0', 12:30:51 INFO - 'HOME': '/home/cltbld', 12:30:51 INFO - 'LANG': 'en_US.UTF-8', 12:30:51 INFO - 'LANGUAGE': 'en_US:en', 12:30:51 INFO - 'LOGNAME': 'cltbld', 12:30:51 INFO - 'MAIL': '/var/mail/cltbld', 12:30:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:51 INFO - 'MOZ_NO_REMOTE': '1', 12:30:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:51 INFO - 'NO_EM_RESTART': '1', 12:30:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:51 INFO - 'PWD': '/builds/slave/test', 12:30:51 INFO - 'SHELL': '/bin/bash', 12:30:51 INFO - 'SHLVL': '1', 12:30:51 INFO - 'TERM': 'linux', 12:30:51 INFO - 'TMOUT': '86400', 12:30:51 INFO - 'USER': 'cltbld', 12:30:51 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061', 12:30:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:51 INFO - '_': '/tools/buildbot/bin/python'} 12:30:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:51 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 12:30:51 INFO - Cleaning up... 12:30:51 INFO - Return code: 0 12:30:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:30: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')]} 12:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30: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')]} 12:30:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:51 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91829d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf769c0>, '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 0xf778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf77d50>, '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': '62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061', '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 12:30:51 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>=3.1.1'] in /builds/slave/test/build 12:30:51 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>=3.1.1 12:30:51 INFO - Using env: {'DISPLAY': ':0', 12:30:51 INFO - 'HOME': '/home/cltbld', 12:30:51 INFO - 'LANG': 'en_US.UTF-8', 12:30:51 INFO - 'LANGUAGE': 'en_US:en', 12:30:51 INFO - 'LOGNAME': 'cltbld', 12:30:51 INFO - 'MAIL': '/var/mail/cltbld', 12:30:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:51 INFO - 'MOZ_NO_REMOTE': '1', 12:30:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:51 INFO - 'NO_EM_RESTART': '1', 12:30:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:51 INFO - 'PWD': '/builds/slave/test', 12:30:51 INFO - 'SHELL': '/bin/bash', 12:30:51 INFO - 'SHLVL': '1', 12:30:51 INFO - 'TERM': 'linux', 12:30:51 INFO - 'TMOUT': '86400', 12:30:51 INFO - 'USER': 'cltbld', 12:30:51 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061', 12:30:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:51 INFO - '_': '/tools/buildbot/bin/python'} 12:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:52 INFO - Downloading/unpacking psutil>=3.1.1 12:30: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 12:30: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 12:30: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 12:30: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 12:30: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 12:30: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 12:30:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:30:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:30:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:30:54 INFO - Installing collected packages: psutil 12:30:54 INFO - Running setup.py install for psutil 12:30:54 INFO - building 'psutil._psutil_linux' extension 12:30:54 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 12:30:54 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 12:30:54 INFO - building 'psutil._psutil_posix' extension 12:30:54 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 12:30:54 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 12:30:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:30:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:30:54 INFO - Successfully installed psutil 12:30:54 INFO - Cleaning up... 12:30:54 INFO - Return code: 0 12:30:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:30: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')]} 12:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30: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')]} 12:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:54 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91829d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf769c0>, '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 0xf778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf77d50>, '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': '62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061', '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 12:30:54 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.3'] in /builds/slave/test/build 12:30:54 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.3 12:30:54 INFO - Using env: {'DISPLAY': ':0', 12:30:54 INFO - 'HOME': '/home/cltbld', 12:30:54 INFO - 'LANG': 'en_US.UTF-8', 12:30:54 INFO - 'LANGUAGE': 'en_US:en', 12:30:54 INFO - 'LOGNAME': 'cltbld', 12:30:54 INFO - 'MAIL': '/var/mail/cltbld', 12:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:54 INFO - 'MOZ_NO_REMOTE': '1', 12:30:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:54 INFO - 'NO_EM_RESTART': '1', 12:30:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:54 INFO - 'PWD': '/builds/slave/test', 12:30:54 INFO - 'SHELL': '/bin/bash', 12:30:54 INFO - 'SHLVL': '1', 12:30:54 INFO - 'TERM': 'linux', 12:30:54 INFO - 'TMOUT': '86400', 12:30:54 INFO - 'USER': 'cltbld', 12:30:54 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061', 12:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:54 INFO - '_': '/tools/buildbot/bin/python'} 12:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:30:54 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 12:30:54 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 12:30:54 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 12:30:54 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 12:30:54 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 12:30:54 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 12:30:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:30:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:30:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:30:56 INFO - Installing collected packages: mozsystemmonitor 12:30:56 INFO - Running setup.py install for mozsystemmonitor 12:30:56 INFO - Successfully installed mozsystemmonitor 12:30:56 INFO - Cleaning up... 12:30:56 INFO - Return code: 0 12:30:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:30:56 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')]} 12:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:56 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')]} 12:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30: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', '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 0x7f91829d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf769c0>, '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 0xf778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf77d50>, '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': '62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061', '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 12:30: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:30: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 blobuploader==1.2.4 12:30:57 INFO - Using env: {'DISPLAY': ':0', 12:30:57 INFO - 'HOME': '/home/cltbld', 12:30:57 INFO - 'LANG': 'en_US.UTF-8', 12:30:57 INFO - 'LANGUAGE': 'en_US:en', 12:30:57 INFO - 'LOGNAME': 'cltbld', 12:30:57 INFO - 'MAIL': '/var/mail/cltbld', 12:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:57 INFO - 'MOZ_NO_REMOTE': '1', 12:30:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:30:57 INFO - 'NO_EM_RESTART': '1', 12:30:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:57 INFO - 'PWD': '/builds/slave/test', 12:30:57 INFO - 'SHELL': '/bin/bash', 12:30:57 INFO - 'SHLVL': '1', 12:30:57 INFO - 'TERM': 'linux', 12:30:57 INFO - 'TMOUT': '86400', 12:30:57 INFO - 'USER': 'cltbld', 12:30:57 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061', 12:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:57 INFO - '_': '/tools/buildbot/bin/python'} 12:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:57 INFO - Downloading/unpacking blobuploader==1.2.4 12:30: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 12:30: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 12:30: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 12:30: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 12:30: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 12:30: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 12:30:59 INFO - Downloading blobuploader-1.2.4.tar.gz 12:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:30:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:30: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 12:30: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 12:30: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 12:30: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 12:30: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 12:30: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 12:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:30:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:30: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 12:30: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 12:30: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 12:30: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 12:30: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 12:30: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 12:30:59 INFO - Downloading docopt-0.6.1.tar.gz 12:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:30:59 INFO - Installing collected packages: blobuploader, requests, docopt 12:30:59 INFO - Running setup.py install for blobuploader 12:30:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:30:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:30:59 INFO - Running setup.py install for requests 12:31:00 INFO - Running setup.py install for docopt 12:31:00 INFO - Successfully installed blobuploader requests docopt 12:31:00 INFO - Cleaning up... 12:31:00 INFO - Return code: 0 12:31:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31:00 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')]} 12:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:00 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')]} 12:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:00 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 0x7f91829d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf769c0>, '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 0xf778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf77d50>, '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': '62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061', '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 12:31:00 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 12:31:00 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 12:31:00 INFO - Using env: {'DISPLAY': ':0', 12:31:00 INFO - 'HOME': '/home/cltbld', 12:31:00 INFO - 'LANG': 'en_US.UTF-8', 12:31:00 INFO - 'LANGUAGE': 'en_US:en', 12:31:00 INFO - 'LOGNAME': 'cltbld', 12:31:00 INFO - 'MAIL': '/var/mail/cltbld', 12:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:00 INFO - 'MOZ_NO_REMOTE': '1', 12:31:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:00 INFO - 'NO_EM_RESTART': '1', 12:31:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:00 INFO - 'PWD': '/builds/slave/test', 12:31:00 INFO - 'SHELL': '/bin/bash', 12:31:00 INFO - 'SHLVL': '1', 12:31:00 INFO - 'TERM': 'linux', 12:31:00 INFO - 'TMOUT': '86400', 12:31:00 INFO - 'USER': 'cltbld', 12:31:00 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061', 12:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:00 INFO - '_': '/tools/buildbot/bin/python'} 12:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:31:00 INFO - Running setup.py (path:/tmp/pip-0f16M8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:31:00 INFO - Running setup.py (path:/tmp/pip-uO0Qup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:31:00 INFO - Running setup.py (path:/tmp/pip-xyd_jI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:31:00 INFO - Running setup.py (path:/tmp/pip-0zWWfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:31:00 INFO - Running setup.py (path:/tmp/pip-kua87v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:31:01 INFO - Running setup.py (path:/tmp/pip-p1AdrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:31:01 INFO - Running setup.py (path:/tmp/pip-28ynM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:31:01 INFO - Running setup.py (path:/tmp/pip-qKw9BV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:31:01 INFO - Running setup.py (path:/tmp/pip-M8gqhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:31:01 INFO - Running setup.py (path:/tmp/pip-d9xfqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:31:01 INFO - Running setup.py (path:/tmp/pip-YDP9I9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:31:01 INFO - Running setup.py (path:/tmp/pip-Vh081_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:31:01 INFO - Running setup.py (path:/tmp/pip-dxT5Ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:31:01 INFO - Running setup.py (path:/tmp/pip-uUa0mQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:01 INFO - Running setup.py (path:/tmp/pip-APnweM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:31:01 INFO - Running setup.py (path:/tmp/pip-Xmt2P9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:31:01 INFO - Running setup.py (path:/tmp/pip-h46teD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:31:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:31:01 INFO - Running setup.py install for manifestparser 12:31:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:31:01 INFO - Running setup.py install for mozcrash 12:31:02 INFO - Running setup.py install for mozdebug 12:31:02 INFO - Running setup.py install for mozdevice 12:31:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:31:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:31:02 INFO - Running setup.py install for mozfile 12:31:02 INFO - Running setup.py install for mozhttpd 12:31:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:31:02 INFO - Running setup.py install for mozinfo 12:31:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:31:02 INFO - Running setup.py install for mozInstall 12:31:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:31:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:31:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:31:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:31:02 INFO - Running setup.py install for mozleak 12:31:02 INFO - Running setup.py install for mozlog 12:31:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:31:02 INFO - Running setup.py install for moznetwork 12:31:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:31:03 INFO - Running setup.py install for mozprocess 12:31:03 INFO - Running setup.py install for mozprofile 12:31:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:31:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:31:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:31:03 INFO - Running setup.py install for mozrunner 12:31:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:31:03 INFO - Running setup.py install for mozscreenshot 12:31:03 INFO - Running setup.py install for moztest 12:31:03 INFO - Running setup.py install for mozversion 12:31:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:31:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:31:03 INFO - Cleaning up... 12:31:03 INFO - Return code: 0 12:31:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31:03 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')]} 12:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:03 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')]} 12:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:03 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 0x7f91829d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf769c0>, '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 0xf778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf77d50>, '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': '62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061', '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 12:31:03 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 12:31:03 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 12:31:03 INFO - Using env: {'DISPLAY': ':0', 12:31:03 INFO - 'HOME': '/home/cltbld', 12:31:03 INFO - 'LANG': 'en_US.UTF-8', 12:31:03 INFO - 'LANGUAGE': 'en_US:en', 12:31:03 INFO - 'LOGNAME': 'cltbld', 12:31:03 INFO - 'MAIL': '/var/mail/cltbld', 12:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:03 INFO - 'MOZ_NO_REMOTE': '1', 12:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:03 INFO - 'NO_EM_RESTART': '1', 12:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:03 INFO - 'PWD': '/builds/slave/test', 12:31:03 INFO - 'SHELL': '/bin/bash', 12:31:03 INFO - 'SHLVL': '1', 12:31:03 INFO - 'TERM': 'linux', 12:31:03 INFO - 'TMOUT': '86400', 12:31:03 INFO - 'USER': 'cltbld', 12:31:03 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061', 12:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:03 INFO - '_': '/tools/buildbot/bin/python'} 12:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:31:03 INFO - Running setup.py (path:/tmp/pip-bAE8kT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:31:03 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)) 12:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:31:03 INFO - Running setup.py (path:/tmp/pip-xJIDnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:31:04 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)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:31:04 INFO - Running setup.py (path:/tmp/pip-NPclAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:31:04 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)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:31:04 INFO - Running setup.py (path:/tmp/pip-W3grxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:31:04 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)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:31:04 INFO - Running setup.py (path:/tmp/pip-xuKwP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:31:04 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)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:31:04 INFO - Running setup.py (path:/tmp/pip-uoywrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:31:04 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)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:31:04 INFO - Running setup.py (path:/tmp/pip-wBC1Vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:31:04 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)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:31:04 INFO - Running setup.py (path:/tmp/pip-rerKYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:31:04 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)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:31:04 INFO - Running setup.py (path:/tmp/pip-ZV0Wkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:31:04 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)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:31:04 INFO - Running setup.py (path:/tmp/pip-nxeVR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:31:04 INFO - Running setup.py (path:/tmp/pip-J4cy9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:31:04 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)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:31:04 INFO - Running setup.py (path:/tmp/pip-QJkckX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:31:04 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)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:31:04 INFO - Running setup.py (path:/tmp/pip-Fkk52u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:31:04 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)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:31:04 INFO - Running setup.py (path:/tmp/pip-7iXi9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:31:04 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)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:04 INFO - Running setup.py (path:/tmp/pip-s19HxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:31:04 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)) 12:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:31:04 INFO - Running setup.py (path:/tmp/pip-5GtyA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:31:05 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)) 12:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:31:05 INFO - Running setup.py (path:/tmp/pip-rKY1Le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:31:05 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)) 12:31:05 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)) 12:31:05 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)) 12:31:05 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)) 12:31:05 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)) 12:31:05 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)) 12:31:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:31:05 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 12:31:05 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 12:31:05 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 12:31:05 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 12:31:05 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 12:31:05 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 12:31:07 INFO - Downloading blessings-1.6.tar.gz 12:31:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:31:07 INFO - Installing collected packages: blessings 12:31:07 INFO - Running setup.py install for blessings 12:31:07 INFO - Successfully installed blessings 12:31:07 INFO - Cleaning up... 12:31:07 INFO - Return code: 0 12:31:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:31:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:31:07 INFO - Reading from file tmpfile_stdout 12:31:07 INFO - Current package versions: 12:31:07 INFO - argparse == 1.2.1 12:31:07 INFO - blessings == 1.6 12:31:07 INFO - blobuploader == 1.2.4 12:31:07 INFO - docopt == 0.6.1 12:31:07 INFO - manifestparser == 1.1 12:31:07 INFO - mozInstall == 1.12 12:31:07 INFO - mozcrash == 0.17 12:31:07 INFO - mozdebug == 0.1 12:31:07 INFO - mozdevice == 0.48 12:31:07 INFO - mozfile == 1.2 12:31:07 INFO - mozhttpd == 0.7 12:31:07 INFO - mozinfo == 0.9 12:31:07 INFO - mozleak == 0.1 12:31:07 INFO - mozlog == 3.2 12:31:07 INFO - moznetwork == 0.27 12:31:07 INFO - mozprocess == 0.22 12:31:07 INFO - mozprofile == 0.28 12:31:07 INFO - mozrunner == 6.11 12:31:07 INFO - mozscreenshot == 0.1 12:31:07 INFO - mozsystemmonitor == 0.3 12:31:07 INFO - moztest == 0.7 12:31:07 INFO - mozversion == 1.4 12:31:07 INFO - psutil == 3.1.1 12:31:07 INFO - requests == 1.2.3 12:31:07 INFO - wsgiref == 0.1.2 12:31:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:31:07 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')]} 12:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:07 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')]} 12:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:07 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 0x7f91829d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf769c0>, '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 0xf778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf77d50>, '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': '62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061', '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 12:31:07 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 12:31:07 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 12:31:07 INFO - Using env: {'DISPLAY': ':0', 12:31:07 INFO - 'HOME': '/home/cltbld', 12:31:07 INFO - 'LANG': 'en_US.UTF-8', 12:31:07 INFO - 'LANGUAGE': 'en_US:en', 12:31:07 INFO - 'LOGNAME': 'cltbld', 12:31:07 INFO - 'MAIL': '/var/mail/cltbld', 12:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:07 INFO - 'MOZ_NO_REMOTE': '1', 12:31:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:07 INFO - 'NO_EM_RESTART': '1', 12:31:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:07 INFO - 'PWD': '/builds/slave/test', 12:31:07 INFO - 'SHELL': '/bin/bash', 12:31:07 INFO - 'SHLVL': '1', 12:31:07 INFO - 'TERM': 'linux', 12:31:07 INFO - 'TMOUT': '86400', 12:31:07 INFO - 'USER': 'cltbld', 12:31:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061', 12:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:07 INFO - '_': '/tools/buildbot/bin/python'} 12:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:07 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)) 12:31:07 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)) 12:31:07 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)) 12:31:07 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)) 12:31:07 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)) 12:31:07 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)) 12:31:07 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)) 12:31:07 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)) 12:31:07 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)) 12:31:07 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)) 12:31:07 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)) 12:31:07 INFO - Cleaning up... 12:31:07 INFO - Return code: 0 12:31:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:31:07 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')]} 12:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:07 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')]} 12:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:07 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 0x7f91829d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf769c0>, '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 0xf778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf77d50>, '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': '62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061', '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 12:31:07 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 12:31:07 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 12:31:07 INFO - Using env: {'DISPLAY': ':0', 12:31:07 INFO - 'HOME': '/home/cltbld', 12:31:07 INFO - 'LANG': 'en_US.UTF-8', 12:31:07 INFO - 'LANGUAGE': 'en_US:en', 12:31:07 INFO - 'LOGNAME': 'cltbld', 12:31:07 INFO - 'MAIL': '/var/mail/cltbld', 12:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:07 INFO - 'MOZ_NO_REMOTE': '1', 12:31:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:07 INFO - 'NO_EM_RESTART': '1', 12:31:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:07 INFO - 'PWD': '/builds/slave/test', 12:31:07 INFO - 'SHELL': '/bin/bash', 12:31:07 INFO - 'SHLVL': '1', 12:31:07 INFO - 'TERM': 'linux', 12:31:07 INFO - 'TMOUT': '86400', 12:31:07 INFO - 'USER': 'cltbld', 12:31:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061', 12:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:07 INFO - '_': '/tools/buildbot/bin/python'} 12:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:07 INFO - Downloading/unpacking jsonschema 12:31:07 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 12:31:07 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 12:31:07 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 12:31:07 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 12:31:07 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 12:31:07 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 12:31:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:31:09 INFO - Downloading/unpacking functools32 (from jsonschema) 12:31:09 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 12:31:09 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 12:31:09 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 12:31:09 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 12:31:09 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 12:31:09 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 12:31:09 INFO - Downloading functools32-3.2.3-2.tar.gz 12:31:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:31:10 INFO - warning: no files found matching '*.txt' 12:31:10 INFO - no previously-included directories found matching 'build' 12:31:10 INFO - no previously-included directories found matching 'dist' 12:31:10 INFO - no previously-included directories found matching '.git*' 12:31:10 INFO - Installing collected packages: jsonschema, functools32 12:31:10 INFO - Running setup.py install for functools32 12:31:10 INFO - warning: no files found matching '*.txt' 12:31:10 INFO - no previously-included directories found matching 'build' 12:31:10 INFO - no previously-included directories found matching 'dist' 12:31:10 INFO - no previously-included directories found matching '.git*' 12:31:10 INFO - Successfully installed jsonschema functools32 12:31:10 INFO - Cleaning up... 12:31:10 INFO - Return code: 0 12:31:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:31:10 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')]} 12:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:10 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')]} 12:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:10 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 0x7f91829d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf769c0>, '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 0xf778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf77d50>, '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': '62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061', '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 12:31:10 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 12:31:10 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 12:31:10 INFO - Using env: {'DISPLAY': ':0', 12:31:10 INFO - 'HOME': '/home/cltbld', 12:31:10 INFO - 'LANG': 'en_US.UTF-8', 12:31:10 INFO - 'LANGUAGE': 'en_US:en', 12:31:10 INFO - 'LOGNAME': 'cltbld', 12:31:10 INFO - 'MAIL': '/var/mail/cltbld', 12:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:10 INFO - 'MOZ_NO_REMOTE': '1', 12:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:10 INFO - 'NO_EM_RESTART': '1', 12:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:10 INFO - 'PWD': '/builds/slave/test', 12:31:10 INFO - 'SHELL': '/bin/bash', 12:31:10 INFO - 'SHLVL': '1', 12:31:10 INFO - 'TERM': 'linux', 12:31:10 INFO - 'TMOUT': '86400', 12:31:10 INFO - 'USER': 'cltbld', 12:31:10 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061', 12:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:10 INFO - '_': '/tools/buildbot/bin/python'} 12:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:10 INFO - Downloading/unpacking flake8 12:31:10 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 12:31:10 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 12:31:10 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 12:31:10 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 12:31:10 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 12:31:10 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 12:31:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:31:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:31:12 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 12:31:12 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 12:31:12 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 12:31:12 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 12:31:12 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 12:31:12 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 12:31:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:31:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:31:12 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 12:31:12 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 12:31:12 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 12:31:12 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 12:31:12 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 12:31:12 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 12:31:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:31:12 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 12:31:12 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 12:31:12 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 12:31:12 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 12:31:12 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 12:31:12 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 12:31:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:31:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:31:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:31:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:31:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:31:13 INFO - no previously-included directories found matching 'docs/_build' 12:31:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:31:13 INFO - Running setup.py install for pep8 12:31:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:31:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:31:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:31:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:31:13 INFO - no previously-included directories found matching 'docs/_build' 12:31:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:31:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:31:13 INFO - Cleaning up... 12:31:13 INFO - Return code: 0 12:31:13 INFO - Running post-action listener: _resource_record_post_action 12:31:13 INFO - Running post-action listener: _start_resource_monitoring 12:31:13 INFO - Starting resource monitoring. 12:31:13 INFO - ##### 12:31:13 INFO - ##### Finished create-virtualenv step (success) 12:31:13 INFO - ##### 12:31:13 INFO - ##### 12:31:13 INFO - ##### Running install step. 12:31:13 INFO - ##### 12:31:13 INFO - Running pre-action listener: _resource_record_pre_action 12:31:13 INFO - Running main action method: install 12:31:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:31:13 INFO - Reading from file tmpfile_stdout 12:31:13 INFO - Detecting whether we're running mozinstall >=1.0... 12:31:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:31:13 INFO - Reading from file tmpfile_stdout 12:31:13 INFO - Output received: 12:31:13 INFO - Usage: mozinstall [options] installer 12:31:13 INFO - Options: 12:31:13 INFO - -h, --help show this help message and exit 12:31:13 INFO - -d DEST, --destination=DEST 12:31:13 INFO - Directory to install application into. [default: 12:31:13 INFO - "/builds/slave/test"] 12:31:13 INFO - --app=APP Application being installed. [default: firefox] 12:31:13 INFO - mkdir: /builds/slave/test/build/application 12:31:13 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'] 12:31:13 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 12:31:29 INFO - Reading from file tmpfile_stdout 12:31:29 INFO - Output received: 12:31:29 INFO - /builds/slave/test/build/application/firefox/firefox 12:31:29 INFO - Running post-action listener: _resource_record_post_action 12:31:29 INFO - ##### 12:31:29 INFO - ##### Finished install step (success) 12:31:29 INFO - ##### 12:31:29 INFO - ##### 12:31:29 INFO - ##### Running run-tests step. 12:31:29 INFO - ##### 12:31:29 INFO - Running pre-action listener: _resource_record_pre_action 12:31:29 INFO - Running main action method: run_tests 12:31:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:31:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:31:29 INFO - Python 2.7.3 12:31:29 INFO - Return code: 0 12:31:29 INFO - grabbing minidump binary from tooltool 12:31:29 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')]} 12:31:29 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf769c0>, '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 0xf778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf77d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:31:29 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 12:31:29 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 12:31:29 INFO - Calling ['/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'] with output_timeout 600 12:31:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:31:29 INFO - Return code: 0 12:31:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:31:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:31:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:31:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:31:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:31:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:31:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:31:30 INFO - Return code: 0 12:31:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 12:31:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 12:31:30 INFO - Using env: {'DISPLAY': ':0', 12:31:30 INFO - 'HOME': '/home/cltbld', 12:31:30 INFO - 'LANG': 'en_US.UTF-8', 12:31:30 INFO - 'LANGUAGE': 'en_US:en', 12:31:30 INFO - 'LOGNAME': 'cltbld', 12:31:30 INFO - 'MAIL': '/var/mail/cltbld', 12:31:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:31:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:31:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:30 INFO - 'MOZ_NO_REMOTE': '1', 12:31:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:31:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:30 INFO - 'NO_EM_RESTART': '1', 12:31:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:31:30 INFO - 'PWD': '/builds/slave/test', 12:31:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:31:30 INFO - 'SHELL': '/bin/bash', 12:31:30 INFO - 'SHLVL': '1', 12:31:30 INFO - 'TERM': 'linux', 12:31:30 INFO - 'TMOUT': '86400', 12:31:30 INFO - 'USER': 'cltbld', 12:31:30 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061', 12:31:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:30 INFO - '_': '/tools/buildbot/bin/python'} 12:31:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 12:31:30 INFO - mozversion application_buildid: 20160523104044 12:31:30 INFO - mozversion application_changeset: 6ac30d36c92309de1e179a1dd230c04e14a97f7f 12:31:30 INFO - mozversion application_display_name: Nightly 12:31:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:31:30 INFO - mozversion application_name: Firefox 12:31:30 INFO - mozversion application_remotingname: firefox 12:31:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:31:30 INFO - mozversion application_vendor: Mozilla 12:31:30 INFO - mozversion application_version: 49.0a1 12:31:30 INFO - mozversion platform_buildid: 20160523104044 12:31:30 INFO - mozversion platform_changeset: 6ac30d36c92309de1e179a1dd230c04e14a97f7f 12:31:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:31:30 INFO - mozversion platform_version: 49.0a1 12:31:30 INFO - using testdate: 1464031890 12:31:30 INFO - actual date: 1464031890 12:31:30 INFO - starting webserver on 'localhost:55462' 12:31:30 INFO - SUITE-START | Running 2 tests 12:31:30 INFO - TEST-START | dromaeo_css 12:31:30 INFO - operating with platform_type : linux_ 12:31:30 INFO - Initialising browser for dromaeo_css test... 12:31:30 INFO - TEST-INFO | started process 2880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0nUcDV/profile http://localhost:55462/getInfo.html) 12:31:34 INFO - PROCESS | 2880 | 12:31:34 INFO - PROCESS | 2880 | (process:2956): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:31:35 INFO - PROCESS | 2880 | __metrics Screen width/height:1600/1200 12:31:35 INFO - PROCESS | 2880 | colorDepth:24 12:31:35 INFO - PROCESS | 2880 | Browser inner width/height: 1024/697 12:31:35 INFO - PROCESS | 2880 | __metrics 12:31:35 ERROR - PROCESS | 2880 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 12:31:36 INFO - TEST-INFO | 2880: exit 0 12:31:36 INFO - Browser initialized. 12:31:36 INFO - Running cycle 1/1 for dromaeo_css test... 12:31:36 INFO - TEST-INFO | started process 3007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0nUcDV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:31:38 INFO - PROCESS | 3007 | 12:31:38 INFO - PROCESS | 3007 | (process:3067): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:31:48 INFO - PROCESS | 3007 | RSS: Main: 165728256 12:31:48 INFO - PROCESS | 3007 | 12:32:38 INFO - PROCESS | 3007 | 1464031958345 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] 12:34:50 INFO - PROCESS | 3007 | Cycle 1(1): loaded http://localhost:55462/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55462/tests/dromaeo/cssquery-ext.html) 12:34:51 INFO - PROCESS | 3007 | RSS: Main: 168230912 12:34:51 INFO - PROCESS | 3007 | 12:37:53 INFO - PROCESS | 3007 | Cycle 1(1): loaded http://localhost:55462/tests/dromaeo/cssquery-ext.html (next: http://localhost:55462/tests/dromaeo/cssquery-jquery.html) 12:37:54 INFO - PROCESS | 3007 | RSS: Main: 167362560 12:37:54 INFO - PROCESS | 3007 | 12:40:56 INFO - PROCESS | 3007 | Cycle 1(1): loaded http://localhost:55462/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55462/tests/dromaeo/cssquery-mootools.html) 12:40:56 INFO - PROCESS | 3007 | RSS: Main: 168640512 12:40:56 INFO - PROCESS | 3007 | 12:43:58 INFO - PROCESS | 3007 | Cycle 1(1): loaded http://localhost:55462/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55462/tests/dromaeo/cssquery-prototype.html) 12:43:59 INFO - PROCESS | 3007 | RSS: Main: 165998592 12:43:59 INFO - PROCESS | 3007 | 12:47:02 INFO - PROCESS | 3007 | Cycle 1(1): loaded http://localhost:55462/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55462/tests/dromaeo/cssquery-yui.html) 12:47:02 INFO - PROCESS | 3007 | RSS: Main: 167440384 12:47:02 INFO - PROCESS | 3007 | 12:50:05 INFO - PROCESS | 3007 | Cycle 1(1): loaded http://localhost:55462/tests/dromaeo/cssquery-yui.html (next: http://localhost:55462/tests/dromaeo/cssquery-dojo.html) 12:50:05 INFO - PROCESS | 3007 | RSS: Main: 169443328 12:50:05 INFO - PROCESS | 3007 | 12:50:05 INFO - PROCESS | 3007 | __start_tp_report 12:50:05 INFO - PROCESS | 3007 | _x_x_mozilla_page_load 12:50:05 INFO - PROCESS | 3007 | _x_x_mozilla_page_load_details 12:50:05 INFO - PROCESS | 3007 | |i|pagename|runs| 12:50:05 INFO - PROCESS | 3007 | |0;dojo.html;2672.719364466731;2699.703032666406;2701.5407380745273;2716.918492445226;2728.6452761141036;4648.511906249846;4695.319178719088;4724.574788269055;4781.474037855842;4829.951700482994;4652.488226295113;4749.8812529686775;4784.473707892138;4851.63612729045;4884.072026314998;4355.978220108903;4366.345048242757;4446.844360447369;4475.373447717306;4478.395416618748;4172.144710334374;4554.635629149677;4569.885752856172;4583.404157459526;4610;4362.280223763075;4429.490608580022;4438.400815889846;4492.460904691458;4501.617362524189;4470.396496472967;4470.709403888737;4478.910421791578;4494.662900282459;4496.100779844044;4483.14820184164;4496.662750293741;4507.211238033331;4518.344839998214;4553.840615578439;4689.249720044776;4701.835435759732;4717.693349932243;4725.40932383452;4759.452662943771;5121.897562048775;5143.434222235551;5153.768080436389;5156.664816786934;5184.611154163453;5083.517065878736;5212.166053431432;5213.582913366921;5214.270002199695;5221.477852214786;4755.548222918817;4797.7601119943865;4810.11012962603;4814.15752243356;4819.349387832668;5262.97368513155;5289.444608316071;5291.629585928948;5323.095073837457;5362.758675859595;4909.509049095133;4946.3817022872145;5072.036313100499;5081.568066714371;5087.465816089331;5098.490150984946;5107.642465027412;5119.513646203604;5128.769205385766;5181.1969144782615;4944.554990050912;4998.975005125024;5043.823466178739;5096.184610462308;5097.949020509747;4955.603551715854;5026.949730502722;5066.493350664904;5077.086124497626;5143.691378517301;4265;4294.677899157576;4299.828006879752;4304.935425968613;4305.935410968838;3746.3818469952153;3761.6990640748672;3767.566729826105;3795.886123416302;3800.961990380061;4493.370928070073;4498.865034048984;4499.752513611717;4500.617447516932;4508.571685689854;5090.796368145307;5095.439501654815;5109.335786347751;5166.844994650167;5222.895542089137;4448.777561121931;4456.821727130943;4476.35092911526;4478.843240486633;4483.798229079634;4540.5913467787395;4560;4584.908301833944;4590.540945905383;4634.050019745944;4734.053189362141;4796.784144713496;4872.4640289567415;4923.286123512143;4936.506349365035;5224.947750522598;5240.921386179134;5251.737413129252;5252.133397989289;5257.158854583248;4928.482509336612;4948.430930443045;4951.702897826142;4962.3052772611145;4991.625628077836;4988.326575912205;4993.201087825931;5016.097102521581;5043.9747801260755;5065.189569668835;5105.974470127774;5112.079825631422;5124.5131712487255;5141.2288156775285;5180.896382072262;4844.733539655353;4996.950030499794;5000.749962501787;5001.699898006132;5002.724850133132;4856.247281671346;4944.258361245842;4966.428860681068;5003.323886498064;5017.4731653175895;4918.754062296799;4940.827071052496;4959.60323174138;4964.826231081895;4980.128477516348;5086.669366491166;5087.542121209109;5089.338386009795;5097.209932460474;5108.795648174031;4817.662763606514;4886.804527818847;4912.238603016538;4916.606671466346;4920.704757714549 12:50:05 INFO - PROCESS | 3007 | |1;ext.html;556.7119386529153;592.786596825143;594.7620951619351;610.6702380714414;611.626907586372;34642.307153856906;38524.80737596315;38644.42033369498;38732.80633596835;38735.41896871546;39653.206935861264;40284;40393.596064039426;40447.595524044824;40507.797461012655;7696.769096927102;7869.2130786921425;7876.527408355489;7895.171007044264;7903.881441778378;7684.346830519385;7691.769246922573;7740.767776966672;7795.727149549767;7805.063392392921;7823.843523129534;7876.094249161334;7913.485623434458;7918.564478953655;7938;7795.532268063906;7803.687852485894;7877.842443151134;7911.248431399008;7916.722914698015;7692.807679807994;7765.1458339582605;7802.843943121163;7818.218178182193;7826.765197044041;29702.85148574265;36476.81761591202;36806.63193368086;36885.446718299245;36989.07527311812;3106.176863131272;3111.8132912025126;3169.4453470642547;3267.2158681916408;3353.832308384571;27636;27934.301642458897;29021.56467652987;29284.41431171386;29660.110196694135;3430.7255419566377;3534;3611.7652352596997;3668.3580373434543;3724.6089160638285;270524;271248;271672;272695.6365218181;273372;29900.700992990227;30724.84637576798;59906.70046649739;60045.69977150086;60495.09257361143;35417.46873796895;35541.28917421637;35657.10857228538;35818.28363432717;35836.82081589627;10709.250352475408;10771.407572583583;10773;10777.353358798497;10797;8938.597763100675;8941.374103812801;8963.417377870548;9053.366264361432;9062.320325975446;8201.097879233279;8228.518866603948;8247.711330103417;8316.501009939302;8329.541875196923;3217.549543063973;3231.159898426426;3232.175795172216;3277.7705560611007;3278.5573947517255;893.8659201119884;924.8890133184061;973.1241882305982;989.4162444157981;1008.1581879131007;27496.312592185357;28504;28848;28853.85573072121;28930.566041509395;968.8352979993418;984.6996666016934;992.950352482373;1051.8422236664562;1052.3317693264678;14536.345864436125;14730.55808325752;14886.851131488547;15095.54713358601;15202.619934501505;384234;388622;389122;392051;392493;49919.750401248486;50503.24245136326;50622.999999999265;50655;50687.49312506901;1207.2092779229795;1211.6546784166646;1222.0468034932767;1222.7309991801967;1230.4585982167816;26719.732802671726;27760.167194984184;27864.442711145257;28406.147815565568;28504.287392815346;42406.57593424026;42587.57412425836;42679.14641707211;43122.78438607787;43252;329686;332084;332384;332861;332861;25414.872925635253;25764.355891102874;26206.475870482864;26264.868675657264;26288.211353659422;42723.35914961216;43031.35452968271;43215.35176972411;43420.782896085315;43578.78210609053;35705.46441803323;36244.4563331545;36732.632673672924;36771;36974.81512592528;36298.637013630585;36387.7251047407;36396.27207455889;36407.27185456329;37157;35554.28891422209;36098.63901361058;36432.635673643985;36668.63331366652;36831.263374732895;30680.232994175323;31803.74635329393;31934.36131277315;31944.68055319417;32145.357092857543;25297.62053569161;25471.36321591975;25499.6175057378;25620.35949101213;25649 12:50:05 INFO - PROCESS | 3007 | |2;jquery.html;361.8480238299914;367.48735513958036;369.2154172383683;376.38855184504683;376.56694800978886;15841.445549405773;17220.655586888253;17233.741493877602;17587.56031099223;17712.822871771277;15861.444849430272;16894.74657880133;17446.65106697865;17646.029468379234;17661.646767064653;5068.239764035397;5241.056609810233;5254.31693879797;5259.894802103956;5282.894342113174;3753.662170404663;5155.613329000321;5807.767689292445;6119.938800611982;6124.418180272889;6107.053406721965;6127.080937859335;6163.722632481549;6164.660943648098;6173.81478555644;5190.610704197182;5457.972710136443;5515.696636684981;5586.190002449622;5604.775808967636;5211.583073354161;5407;5410;5419.458054194589;5428.891422171574;12512.562060327844;12569.874301256961;12601;12697.682557936034;12731.42708578107;1816.8092350303293;2030.147338117994;2148.1622167354744;2388.2596395117394;2412.867292298923;8437.915620843774;9156.679516216967;9413.811723765555;11017.008469237808;13665.726685466334;1700.3368686212386;1758.7625670534442;1776.1317364077133;1784.9553761155946;1814.963700725978;70478.64760676216;71309.2869071313;72187.2781272191;72342.91485627773;72719.27280727177;10190.949045254727;10290.3825770454;10346.948265258625;10403.531841067019;10525.421101839473;14200.502982395567;14244.715105697827;14261.288645362623;14292;14322.925780566498;6385.904211436832;6402.103705481143;6526.988316810902;6593.274739778621;6600.86798264032;5747.482726554546;5877.118432235114;5945.494632956247;5981.611195272293;5981.910271345933;4417.734935903856;4483.887902802391;4528.592426681615;4558.270676691714;4582.335561343587;1711.2812618700175;1756;1803.386848471526;1844.6310737852484;1865.1513561329562;403.7819577428215;405.45466347762215;408.96114869087984;414.1447910065765;787.9645415956296;10627.202959777893;10838.837417438745;10886.346819190874;10932.672019839418;10974.615888444026;414.9875503734893;420.9200251952119;436.73577485621377;438.5132502921754;441.1397774339986;5787.07406814916;5811.3316968548315;5837.532997360286;5893.351731309553;5916.911246331309;410773;411716;414001;417805;426876;74614;77532.22467775363;79637.60181199056;85576;87228.56385718031;962.0812124421021;962.119660510625;965.6234068713208;996.3025881882567;1001.5743309093606;15564.377424902877;15832.683346332778;16032.438864639682;16220.188990550188;16303.510894673178;34636.82681586576;35811.462828058124;36089.27821443609;36153;36730.63269367272;50673.74663126661;50761.746191270286;50937.490625093276;51915.740421297654;52569.47430525646;7405.740799072222;7533.2466753324225;7568.205338439385;7734.7679569613;7734.806629834299;10418.739531511774;10827.13382929348;10882.843417876025;11163.720906977065;11581.594644187413;10039.19686425099;10351.63769268072;10411.895881041093;10614.097801686943;10666.786664266827;10483.52824122901;10643.94678026605;10659.840102398315;10745.516451759533;10965.451727413756;10028.799424011333;10207.336523125972;10426.947865260929;10558.524866381185;10622.73443163927;7633.580153091633;7691.730789422567;7789;7822.4524283299625;7928.246816552418;7811.687532498637;10136.898631013595;10159.441230732085;10383.688489345332;10416.270861039655 12:50:05 INFO - PROCESS | 3007 | |3;mootools.html;1294.3851670456534;1437.1592618318284;1566.2325460524346;1764.126757255159;1786.8742692103972;6906.75826346078;7495.70017199312;7519.887201691965;8030.036395632532;8053.35573154147;7714.922850771491;7853.332466740334;7953.284204421601;7984.2015798420125;8003.8799418008775;2182.596219699353;2218.6117429449782;2226.810721088709;2231.0964059555827;2242.9887850560726;2181.214762685432;2197.099189332374;2217.944551386212;2230.130249202804;2237.5636750833596;2116.703661487393;2127.4894025433864;2144.924927627533;2164.6644770060666;2214.9224777132804;2126.8192203662707;2132.8400369972237;2136.6154092263387;2140.090461553841;2142.442964829148;2092.1422216891156;2124.1397234120204;2151.505153814616;2155.4180371299663;2165.1988764157204;7832.334251588622;7848.372130229568;7882.172371900925;7895;7898.842023159562;4322.567743225683;4416.823327066945;4427.490838553543;4434.046679963823;4440.733555986619;2828.3918957424253;2898.2029941765973;2963.9110826675233;2982.135180797566;2990.5364668476423;881.3125761905724;926.7080869526078;927.1516562345446;948.1940350701917;970.7864269860619;10375.42935138567;10403.635872744493;10406.531706073245;10413.323133996266;10422.166226701922;4005.2590270799997;4234.364845273234;4265.914681706348;4273.1026484438;4275.48694156697;9047.276217902552;9083.500407477652;9104.044075372123;9104.544772761335;9104.772380690403;4263.680223983214;4356.346548017823;4368.650507959355;4431.778411079433;4454.10917816438;3408.1820363112674;3905.3946638271113;3918.412238164241;3920.862769803043;4112.732672376286;3657.231981283907;3712.7215458840697;3806.657400833938;3823.445600387928;3846.2692088503095;1211.8061110222498;1221.3160630047203;1227.3495047624774;1239.7086684629105;1239.9566015189425;806.395203597302;819.3527113580324;828.6561077152915;858;867.1631875240423;5147.948520514822;5156.329677142023;5220.399654039758;5351.518363347317;5353.9196912046355;401.770990535392;423.472776393386;423.8791944295861;427.83528341588715;432.47670318914464;3558.217192217708;3587.982060089683;3593.083763640255;3646.0520264731363;3666.908327291839;8973.865392019125;9059.909400906039;9180.632774689071;9211.677591284273;9238.076192380708;9006.819863602823;9041.321900857462;9085.182333590008;9105.317101217435;9128.634854605874;6777.423918966943;6817.0796942413135;6833.180018397824;7145.39264162552;7173.210946795848;5057.393112826484;5106.591472682102;5109.463506331782;5148.279240906201;5179.81870634526;8296.668133274601;8546.957265213883;8549.615267312862;8569.057403685714;8626.051134375088;8954.449279412425;8980.101989800967;9102.544872756469;9244.491552964651;9267.397619154734;6124.724387402666;6184.319724830355;6305.558610897193;6666.133402657623;6776.728930842711;7569.772906812805;7599.354054905395;7610.429217808576;7629.656665450179;7645.235476452533;6432.485401167989;6698.531102822755;6780.830479237861;6892.793216203522;7111;6579.901301480578;6751.729930802713;6757.3242675732035;6808.693608787716;6826.829329266808;6246.437820596168;6403.135576697086;6440.066190402459;6461.289258181502;6494.415502604788;4733.952660473489;4750.192467280502;4874.2444921037295;4879.04858552593;4879.56083952446;4779.928301075417;4783.904321913473;4832.275158726219;4836.298736683091;4858.587020103189 12:50:05 INFO - PROCESS | 3007 | |4;prototype.html;299.2578405554225;303.7554768411429;304.9756019518439;311.4254200999156;312.42981558655447;4979.402471703401;4979.8008079676765;4982.202847544394;5006.048850718361;5065.797368105276;4849.175640141176;4907.26391041344;4911.72985485799;4913.31213630092;4960.751962401874;3714.7028237740915;3719.5350581177354;3876.9612303876884;3880.592537783534;3880.961190388088;3870.20660764544;3875.147467557133;3892.377219644857;3894.636877093009;3938.2911076006308;3829.8468061277517;3858.84564617415;3882.4758657581287;3883.3204189266908;3919.451816532468;3810.6570408663074;3884.902152837464;3890.591487893787;3913.4912461380122;3916.784576848272;3422.3155368926314;3440.6215316315183;3441;3442.5524681791458;3463.2727127303297;4731.952680473186;4750.144973904696;4751.477337492873;4756.952430475685;4758.119747846659;4421.955780442218;4438.844640437569;4444.955550444519;4446.266366049598;4491.719859839963;4823.662343635947;5134.4095429025765;5145.948540514584;5165.9225111623355;5193.610479214074;3626.184108575576;3639.29033838399;3647.689946354563;3680.687141592941;3715.0898029982827;5486.91769623456;5492.670439773587;5500.779968801243;5509.118541033456;5521.917171242394;3711.758735682172;3780.584135745066;3788.734788564829;3789.5831458539537;3791.279656865187;3786.8295926683363;3822.7132965027736;3826.5025546678753;3840.2127563849344;3843.385058390644;4359.825606975749;4359.891002724958;4384.386185933972;4398.054418300081;4414.139242847614;5017.67385119966;5133.926367648389;5162.019216348882;5194.662346947436;5228.529432351107;1304.9934750326188;1312.8884044856104;1323.4772264955288;1323.847757507899;1334.5796074236584;827.6027506796651;832.7751507093051;851.0935853316322;854.6068808348106;854.7606670132373;4537.228671125917;4655.534446555317;4657.976710116428;4659.2312268476;4660.650451216173;5372;5373.677579345252;5378.2470454136455;5389.649672771257;5424.755885985141;4484.977575112103;4621.584057434847;4621.815127394933;4625.814967401334;4656.976715116402;2800.6919238883706;2826.1662809471254;2832.787540934397;2833.844138572398;2844.33158207821;5070.569001634903;5078.542931136141;5080.314157588752;5085.364329458817;5103.106956282636;5325.600579956519;5403.594730395236;5463.448758307132;5469.453054694499;5506.476884695948;5009.348784657971;5032.899342013139;5037.19404895215;5069.31564238823;5099.6685215460875;5300.542350853546;5352.571794256372;5359.196120581944;5399.946000539944;5414.783408663609;5131.56381707559;5268.209768534751;5300.3639563252655;5331.1341030640515;5335.359756829205;5060.595152387874;5090.4655011223285;5091.516305950929;5108.131617624938;5142.588592912483;3716.1267102230413;3727.7763334200035;3765.868194613285;3770.7171962103503;3783.4892289540558;5178.533931946143;5281.603879709114;5382.461753824587;5383.67697938125;5411.675299482044;5122.257272695364;5202.427732949448;5205.193195054772;5212.5569326607665;5224.440024388098;5153.845384638467;5165.870853228549;5195.636305458582;5205.3753549572775;5223.3209682741;4949.727764972961;5057.439405263451;5068.822591209438;5070.645054846125;5136.101182293009;4938.75306234694;5038.823641172541;5114.616403769806;5183.663061900965;5204.854931914972;5100.974495127649;5107.565856902205;5112.463191364853;5115.590752739698;5119.48805119485 12:50:05 INFO - PROCESS | 3007 | |5;yui.html;664.4153145232195;745.7129005332947;746.298479429336;754.0009487429157;760.608286732333;11505.769884602314;11696.122790790681;11983.580574679889;12012;12066.215695979767;12125.818112728317;12185.207961482498;12186.390680465985;12198.451069701863;12216.022718182547;611.4038812158154;782.307657722915;784.2667106255641;795.2087672765606;796.8366484870617;806.9515829050247;808.5754978636234;809.1503920883079;811.7118422959853;811.7443005453264;841.1630427724423;842.928351090155;843.026304618167;844.9450785698909;846.0524212881551;838.7651457591884;840.6259214649483;841.4951029382382;842.1620487614802;842.9620667069996;614.0298328640737;614.241411856357;614.3764079459353;615.129591627846;616.8951278282702;11807.173497855154;11822.408879556075;11825.349605771678;11857.110716696283;11882.881171188264;12680.429380677799;12874.742505149845;12995.090343675947;13020.544280950216;13174.407151678197;10038.397696138181;10152.644657436955;10285.537150828231;10355.948220258926;10370.688879333633;3251.3822373748912;3361.781484203519;3391.440412331987;3441.380551500729;3457.6369481204365;49402;49428;49678.7516062421;50063.24905126426;50503.494965050246;9668;9975.301728879054;10138.341007834468;10147.64483243083;10471.528781204865;17900.820991790177;17911.10444477771;18003.909980450015;18011.18949647269;18129.728054079198;6609.239937407164;6702.932970670328;6723.495737819683;6724.092247546617;6789.422899053537;3632.800195989193;3645.5078564394;3650.7444478886755;3695.611960744137;3725.962740372616;2756.8759405826786;2815.056955919749;2849.2591926099362;2850.5296626056884;2855.8429286389032;481.7494902650602;499.07421732685344;503.5593855376546;506.36704119850185;506.61750378464023;566.9886602267932;621.5462712220104;623.3143542103741;632.3518393646457;657.9111570351076;7412.555246685216;7545.320921117016;7679.500832445873;7746.612669366509;7757.7672669819995;484.6558943150332;552.3951273355669;565.8953093677683;581.4795757796749;584.1617279204355;3778.244351129785;3866.994581408798;3916.353801622757;3931.331673615492;3942.448057271984;57527;58297;59363.406365935785;59462.40537594655;59700.402995970355;52365.73817130966;52368.21447678288;52570.47429525656;52770.736146319025;54555.72722136364;19099.61800764005;19554.21783128659;24994.875025624755;48288;50014.749926250865;7325.890111648223;7519.510757147423;7581.696732130653;7609.505382150364;7650.972745270266;32729.509057364634;32731.34537309288;33010.504842427865;33318.333633326714;33361.165970850925;40009.79995100006;43307;43381.56618433775;43596;43772.56227437685;10304.742381440525;10312.793744125225;10326.432046237529;10374.636887708893;10398.896011039793;10494.737631559272;10533.57865685364;10622.52198651078;10929.56281748721;11030.834537482106;9966.92282822248;10009.5495702695;10100.797984040424;10102.191824653863;10222.1822254218;9945.453000085065;9946.950265248628;10106.797864042825;10166.74583135398;10239.129673977795;10101.44442055694;10116.595336186765;10117.140043096419;10276.280660353703;10408;8416.795646312748;8499.787505312417;8670.78323041929;8832.293416526534;8975.057618949917;8745.56272186401;8751.343649226206;8786.472811631322;8798.780030499289;8898.243649289883 12:50:05 INFO - PROCESS | 3007 | __end_tp_report 12:50:05 INFO - PROCESS | 3007 | __start_cc_report 12:50:05 INFO - PROCESS | 3007 | _x_x_mozilla_cycle_collect,385 12:50:05 INFO - PROCESS | 3007 | __end_cc_report 12:50:05 INFO - PROCESS | 3007 | __startTimestamp1464033005429__endTimestamp 12:50:05 INFO - PROCESS | 3007 | 12:50:05 INFO - PROCESS | 3007 | ------- Summary: start ------- 12:50:05 INFO - PROCESS | 3007 | Number of tests: 6 12:50:05 INFO - PROCESS | 3007 | 12:50:05 INFO - PROCESS | 3007 | [#0] dojo.html Cycles:165 Average:4752.06 Median:4909.51 stddev:493.49 (10.1%) stddev-sans-first:467.27 12:50:05 INFO - PROCESS | 3007 | Values: 2672.7 2699.7 2701.5 2716.9 2728.6 4648.5 4695.3 4724.6 4781.5 4830.0 4652.5 4749.9 4784.5 4851.6 4884.1 4356.0 4366.3 4446.8 4475.4 4478.4 4172.1 4554.6 4569.9 4583.4 4610.0 4362.3 4429.5 4438.4 4492.5 4501.6 4470.4 4470.7 4478.9 4494.7 4496.1 4483.1 4496.7 4507.2 4518.3 4553.8 4689.2 4701.8 4717.7 4725.4 4759.5 5121.9 5143.4 5153.8 5156.7 5184.6 5083.5 5212.2 5213.6 5214.3 5221.5 4755.5 4797.8 4810.1 4814.2 4819.3 5263.0 5289.4 5291.6 5323.1 5362.8 4909.5 4946.4 5072.0 5081.6 5087.5 5098.5 5107.6 5119.5 5128.8 5181.2 4944.6 4999.0 5043.8 5096.2 5097.9 4955.6 5026.9 5066.5 5077.1 5143.7 4265.0 4294.7 4299.8 4304.9 4305.9 3746.4 3761.7 3767.6 3795.9 3801.0 4493.4 4498.9 4499.8 4500.6 4508.6 5090.8 5095.4 5109.3 5166.8 5222.9 4448.8 4456.8 4476.4 4478.8 4483.8 4540.6 4560.0 4584.9 4590.5 4634.1 4734.1 4796.8 4872.5 4923.3 4936.5 5224.9 5240.9 5251.7 5252.1 5257.2 4928.5 4948.4 4951.7 4962.3 4991.6 4988.3 4993.2 5016.1 5044.0 5065.2 5106.0 5112.1 5124.5 5141.2 5180.9 4844.7 4997.0 5000.7 5001.7 5002.7 4856.2 4944.3 4966.4 5003.3 5017.5 4918.8 4940.8 4959.6 4964.8 4980.1 5086.7 5087.5 5089.3 5097.2 5108.8 4817.7 4886.8 4912.2 4916.6 4920.7 12:50:05 INFO - PROCESS | 3007 | 12:50:05 INFO - PROCESS | 3007 | [#1] ext.html Cycles:180 Average:47235.97 Median:20168.50 stddev:88329.76 (438.0%) stddev-sans-first:88508.02 12:50:05 INFO - PROCESS | 3007 | Values: 556.7 592.8 594.8 610.7 611.6 34642.3 38524.8 38644.4 38732.8 38735.4 39653.2 40284.0 40393.6 40447.6 40507.8 7696.8 7869.2 7876.5 7895.2 7903.9 7684.3 7691.8 7740.8 7795.7 7805.1 7823.8 7876.1 7913.5 7918.6 7938.0 7795.5 7803.7 7877.8 7911.2 7916.7 7692.8 7765.1 7802.8 7818.2 7826.8 29702.9 36476.8 36806.6 36885.4 36989.1 3106.2 3111.8 3169.4 3267.2 3353.8 27636.0 27934.3 29021.6 29284.4 29660.1 3430.7 3534.0 3611.8 3668.4 3724.6 270524.0 271248.0 271672.0 272695.6 273372.0 29900.7 30724.8 59906.7 60045.7 60495.1 35417.5 35541.3 35657.1 35818.3 35836.8 10709.3 10771.4 10773.0 10777.4 10797.0 8938.6 8941.4 8963.4 9053.4 9062.3 8201.1 8228.5 8247.7 8316.5 8329.5 3217.5 3231.2 3232.2 3277.8 3278.6 893.9 924.9 973.1 989.4 1008.2 27496.3 28504.0 28848.0 28853.9 28930.6 968.8 984.7 993.0 1051.8 1052.3 14536.3 14730.6 14886.9 15095.5 15202.6 384234.0 388622.0 389122.0 392051.0 392493.0 49919.8 50503.2 50623.0 50655.0 50687.5 1207.2 1211.7 1222.0 1222.7 1230.5 26719.7 27760.2 27864.4 28406.1 28504.3 42406.6 42587.6 42679.1 43122.8 43252.0 329686.0 332084.0 332384.0 332861.0 332861.0 25414.9 25764.4 26206.5 26264.9 26288.2 42723.4 43031.4 43215.4 43420.8 43578.8 35705.5 36244.5 36732.6 36771.0 36974.8 36298.6 36387.7 36396.3 36407.3 37157.0 35554.3 36098.6 36432.6 36668.6 36831.3 30680.2 31803.7 31934.4 31944.7 32145.4 25297.6 25471.4 25499.6 25620.4 25649.0 12:50:05 INFO - PROCESS | 3007 | 12:50:05 INFO - PROCESS | 3007 | [#2] jquery.html Cycles:180 Average:24745.27 Median:205590.98 stddev:68788.62 (33.5%) stddev-sans-first:68957.22 12:50:05 INFO - PROCESS | 3007 | Values: 361.8 367.5 369.2 376.4 376.6 15841.4 17220.7 17233.7 17587.6 17712.8 15861.4 16894.7 17446.7 17646.0 17661.6 5068.2 5241.1 5254.3 5259.9 5282.9 3753.7 5155.6 5807.8 6119.9 6124.4 6107.1 6127.1 6163.7 6164.7 6173.8 5190.6 5458.0 5515.7 5586.2 5604.8 5211.6 5407.0 5410.0 5419.5 5428.9 12512.6 12569.9 12601.0 12697.7 12731.4 1816.8 2030.1 2148.2 2388.3 2412.9 8437.9 9156.7 9413.8 11017.0 13665.7 1700.3 1758.8 1776.1 1785.0 1815.0 70478.6 71309.3 72187.3 72342.9 72719.3 10190.9 10290.4 10346.9 10403.5 10525.4 14200.5 14244.7 14261.3 14292.0 14322.9 6385.9 6402.1 6527.0 6593.3 6600.9 5747.5 5877.1 5945.5 5981.6 5981.9 4417.7 4483.9 4528.6 4558.3 4582.3 1711.3 1756.0 1803.4 1844.6 1865.2 403.8 405.5 409.0 414.1 788.0 10627.2 10838.8 10886.3 10932.7 10974.6 415.0 420.9 436.7 438.5 441.1 5787.1 5811.3 5837.5 5893.4 5916.9 410773.0 411716.0 414001.0 417805.0 426876.0 74614.0 77532.2 79637.6 85576.0 87228.6 962.1 962.1 965.6 996.3 1001.6 15564.4 15832.7 16032.4 16220.2 16303.5 34636.8 35811.5 36089.3 36153.0 36730.6 50673.7 50761.7 50937.5 51915.7 52569.5 7405.7 7533.2 7568.2 7734.8 7734.8 10418.7 10827.1 10882.8 11163.7 11581.6 10039.2 10351.6 10411.9 10614.1 10666.8 10483.5 10643.9 10659.8 10745.5 10965.5 10028.8 10207.3 10426.9 10558.5 10622.7 7633.6 7691.7 7789.0 7822.5 7928.2 7811.7 10136.9 10159.4 10383.7 10416.3 12:50:05 INFO - PROCESS | 3007 | 12:50:05 INFO - PROCESS | 3007 | [#3] mootools.html Cycles:180 Average:5072.90 Median:5081.99 stddev:2820.70 (55.5%) stddev-sans-first:2814.32 12:50:05 INFO - PROCESS | 3007 | Values: 1294.4 1437.2 1566.2 1764.1 1786.9 6906.8 7495.7 7519.9 8030.0 8053.4 7714.9 7853.3 7953.3 7984.2 8003.9 2182.6 2218.6 2226.8 2231.1 2243.0 2181.2 2197.1 2217.9 2230.1 2237.6 2116.7 2127.5 2144.9 2164.7 2214.9 2126.8 2132.8 2136.6 2140.1 2142.4 2092.1 2124.1 2151.5 2155.4 2165.2 7832.3 7848.4 7882.2 7895.0 7898.8 4322.6 4416.8 4427.5 4434.0 4440.7 2828.4 2898.2 2963.9 2982.1 2990.5 881.3 926.7 927.2 948.2 970.8 10375.4 10403.6 10406.5 10413.3 10422.2 4005.3 4234.4 4265.9 4273.1 4275.5 9047.3 9083.5 9104.0 9104.5 9104.8 4263.7 4356.3 4368.7 4431.8 4454.1 3408.2 3905.4 3918.4 3920.9 4112.7 3657.2 3712.7 3806.7 3823.4 3846.3 1211.8 1221.3 1227.3 1239.7 1240.0 806.4 819.4 828.7 858.0 867.2 5147.9 5156.3 5220.4 5351.5 5353.9 401.8 423.5 423.9 427.8 432.5 3558.2 3588.0 3593.1 3646.1 3666.9 8973.9 9059.9 9180.6 9211.7 9238.1 9006.8 9041.3 9085.2 9105.3 9128.6 6777.4 6817.1 6833.2 7145.4 7173.2 5057.4 5106.6 5109.5 5148.3 5179.8 8296.7 8547.0 8549.6 8569.1 8626.1 8954.4 8980.1 9102.5 9244.5 9267.4 6124.7 6184.3 6305.6 6666.1 6776.7 7569.8 7599.4 7610.4 7629.7 7645.2 6432.5 6698.5 6780.8 6892.8 7111.0 6579.9 6751.7 6757.3 6808.7 6826.8 6246.4 6403.1 6440.1 6461.3 6494.4 4734.0 4750.2 4874.2 4879.0 4879.6 4779.9 4783.9 4832.3 4836.3 4858.6 12:50:05 INFO - PROCESS | 3007 | 12:50:05 INFO - PROCESS | 3007 | [#4] prototype.html Cycles:180 Average:4315.41 Median:4944.24 stddev:1258.27 (25.4%) stddev-sans-first:1225.16 12:50:05 INFO - PROCESS | 3007 | Values: 299.3 303.8 305.0 311.4 312.4 4979.4 4979.8 4982.2 5006.0 5065.8 4849.2 4907.3 4911.7 4913.3 4960.8 3714.7 3719.5 3877.0 3880.6 3881.0 3870.2 3875.1 3892.4 3894.6 3938.3 3829.8 3858.8 3882.5 3883.3 3919.5 3810.7 3884.9 3890.6 3913.5 3916.8 3422.3 3440.6 3441.0 3442.6 3463.3 4732.0 4750.1 4751.5 4757.0 4758.1 4422.0 4438.8 4445.0 4446.3 4491.7 4823.7 5134.4 5145.9 5165.9 5193.6 3626.2 3639.3 3647.7 3680.7 3715.1 5486.9 5492.7 5500.8 5509.1 5521.9 3711.8 3780.6 3788.7 3789.6 3791.3 3786.8 3822.7 3826.5 3840.2 3843.4 4359.8 4359.9 4384.4 4398.1 4414.1 5017.7 5133.9 5162.0 5194.7 5228.5 1305.0 1312.9 1323.5 1323.8 1334.6 827.6 832.8 851.1 854.6 854.8 4537.2 4655.5 4658.0 4659.2 4660.7 5372.0 5373.7 5378.2 5389.6 5424.8 4485.0 4621.6 4621.8 4625.8 4657.0 2800.7 2826.2 2832.8 2833.8 2844.3 5070.6 5078.5 5080.3 5085.4 5103.1 5325.6 5403.6 5463.4 5469.5 5506.5 5009.3 5032.9 5037.2 5069.3 5099.7 5300.5 5352.6 5359.2 5399.9 5414.8 5131.6 5268.2 5300.4 5331.1 5335.4 5060.6 5090.5 5091.5 5108.1 5142.6 3716.1 3727.8 3765.9 3770.7 3783.5 5178.5 5281.6 5382.5 5383.7 5411.7 5122.3 5202.4 5205.2 5212.6 5224.4 5153.8 5165.9 5195.6 5205.4 5223.3 4949.7 5057.4 5068.8 5070.6 5136.1 4938.8 5038.8 5114.6 5183.7 5204.9 5101.0 5107.6 5112.5 5115.6 5119.5 12:50:05 INFO - PROCESS | 3007 | 12:50:05 INFO - PROCESS | 3007 | [#5] yui.html Cycles:180 Average:12994.36 Median:24943.33 stddev:15731.77 (63.1%) stddev-sans-first:15748.65 12:50:05 INFO - PROCESS | 3007 | Values: 664.4 745.7 746.3 754.0 760.6 11505.8 11696.1 11983.6 12012.0 12066.2 12125.8 12185.2 12186.4 12198.5 12216.0 611.4 782.3 784.3 795.2 796.8 807.0 808.6 809.2 811.7 811.7 841.2 842.9 843.0 844.9 846.1 838.8 840.6 841.5 842.2 843.0 614.0 614.2 614.4 615.1 616.9 11807.2 11822.4 11825.3 11857.1 11882.9 12680.4 12874.7 12995.1 13020.5 13174.4 10038.4 10152.6 10285.5 10355.9 10370.7 3251.4 3361.8 3391.4 3441.4 3457.6 49402.0 49428.0 49678.8 50063.2 50503.5 9668.0 9975.3 10138.3 10147.6 10471.5 17900.8 17911.1 18003.9 18011.2 18129.7 6609.2 6702.9 6723.5 6724.1 6789.4 3632.8 3645.5 3650.7 3695.6 3726.0 2756.9 2815.1 2849.3 2850.5 2855.8 481.7 499.1 503.6 506.4 506.6 567.0 621.5 623.3 632.4 657.9 7412.6 7545.3 7679.5 7746.6 7757.8 484.7 552.4 565.9 581.5 584.2 3778.2 3867.0 3916.4 3931.3 3942.4 57527.0 58297.0 59363.4 59462.4 59700.4 52365.7 52368.2 52570.5 52770.7 54555.7 19099.6 19554.2 24994.9 48288.0 50014.7 7325.9 7519.5 7581.7 7609.5 7651.0 32729.5 32731.3 33010.5 33318.3 33361.2 40009.8 43307.0 43381.6 43596.0 43772.6 10304.7 10312.8 10326.4 10374.6 10398.9 10494.7 10533.6 10622.5 10929.6 11030.8 9966.9 10009.5 10100.8 10102.2 10222.2 9945.5 9947.0 10106.8 10166.7 10239.1 10101.4 10116.6 10117.1 10276.3 10408.0 8416.8 8499.8 8670.8 8832.3 8975.1 8745.6 8751.3 8786.5 8798.8 8898.2 12:50:05 INFO - PROCESS | 3007 | -------- Summary: end -------- 12:50:05 INFO - PROCESS | 3007 | 12:50:05 INFO - PROCESS | 3007 | 12:50:05 INFO - PROCESS | 3007 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0042,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 12:50:05 INFO - PROCESS | 3007 | 12:50:05 INFO - PROCESS | 3007 | 12:50:05 INFO - PROCESS | 3007 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 12:50:05 INFO - PROCESS | 3007 | 12:50:06 INFO - TEST-INFO | 3007: exit 0 12:50:06 INFO - TEST-OK | dromaeo_css | took 1115560ms 12:50:06 INFO - TEST-START | kraken 12:50:06 INFO - operating with platform_type : linux_ 12:50:06 INFO - Initialising browser for kraken test... 12:50:06 INFO - TEST-INFO | started process 3294 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjqP6gl/profile http://localhost:55462/getInfo.html) 12:50:10 INFO - PROCESS | 3294 | 12:50:10 INFO - PROCESS | 3294 | (process:3361): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:50:10 INFO - PROCESS | 3294 | __metrics Screen width/height:1600/1200 12:50:10 INFO - PROCESS | 3294 | colorDepth:24 12:50:10 INFO - PROCESS | 3294 | Browser inner width/height: 1024/697 12:50:10 INFO - PROCESS | 3294 | __metrics 12:50:11 ERROR - PROCESS | 3294 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 12:50:12 INFO - TEST-INFO | 3294: exit 0 12:50:12 INFO - Browser initialized. 12:50:12 INFO - Running cycle 1/1 for kraken test... 12:50:12 INFO - TEST-INFO | started process 3412 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjqP6gl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:50:14 INFO - PROCESS | 3412 | 12:50:14 INFO - PROCESS | 3412 | (process:3472): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:50:24 INFO - PROCESS | 3412 | RSS: Main: 165068800 12:50:24 INFO - PROCESS | 3412 | 12:50:26 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55462/tests/kraken/driver.html?testName=audio-beat-detection) 12:50:27 INFO - PROCESS | 3412 | RSS: Main: 168632320 12:50:27 INFO - PROCESS | 3412 | 12:50:30 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55462/tests/kraken/driver.html?testName=audio-dft) 12:50:31 INFO - PROCESS | 3412 | RSS: Main: 168767488 12:50:31 INFO - PROCESS | 3412 | 12:50:34 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55462/tests/kraken/driver.html?testName=audio-fft) 12:50:35 INFO - PROCESS | 3412 | RSS: Main: 164200448 12:50:35 INFO - PROCESS | 3412 | 12:50:37 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55462/tests/kraken/driver.html?testName=audio-oscillator) 12:50:37 INFO - PROCESS | 3412 | RSS: Main: 165244928 12:50:37 INFO - PROCESS | 3412 | 12:50:40 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55462/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:50:40 INFO - PROCESS | 3412 | RSS: Main: 164847616 12:50:40 INFO - PROCESS | 3412 | 12:50:44 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55462/tests/kraken/driver.html?testName=imaging-darkroom) 12:50:44 INFO - PROCESS | 3412 | RSS: Main: 165298176 12:50:44 INFO - PROCESS | 3412 | 12:50:48 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55462/tests/kraken/driver.html?testName=imaging-desaturate) 12:50:49 INFO - PROCESS | 3412 | RSS: Main: 163942400 12:50:49 INFO - PROCESS | 3412 | 12:50:52 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55462/tests/kraken/driver.html?testName=json-parse-financial) 12:50:52 INFO - PROCESS | 3412 | RSS: Main: 164597760 12:50:52 INFO - PROCESS | 3412 | 12:50:54 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55462/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:50:55 INFO - PROCESS | 3412 | RSS: Main: 165056512 12:50:55 INFO - PROCESS | 3412 | 12:50:57 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55462/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:50:57 INFO - PROCESS | 3412 | RSS: Main: 165498880 12:50:57 INFO - PROCESS | 3412 | 12:50:59 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55462/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:51:00 INFO - PROCESS | 3412 | RSS: Main: 166125568 12:51:00 INFO - PROCESS | 3412 | 12:51:03 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:51:04 INFO - PROCESS | 3412 | RSS: Main: 165457920 12:51:04 INFO - PROCESS | 3412 | 12:51:07 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:51:07 INFO - PROCESS | 3412 | RSS: Main: 165801984 12:51:07 INFO - PROCESS | 3412 | 12:51:09 INFO - PROCESS | 3412 | Cycle 1(1): loaded http://localhost:55462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55462/tests/kraken/driver.html?testName=ai-astar) 12:51:09 INFO - PROCESS | 3412 | RSS: Main: 167882752 12:51:09 INFO - PROCESS | 3412 | 12:51:09 INFO - PROCESS | 3412 | __start_tp_report 12:51:09 INFO - PROCESS | 3412 | _x_x_mozilla_page_load 12:51:09 INFO - PROCESS | 3412 | _x_x_mozilla_page_load_details 12:51:09 INFO - PROCESS | 3412 | |i|pagename|runs| 12:51:09 INFO - PROCESS | 3412 | |0;ai-astar;116;109;115;115;116;115;116;116;115;113 12:51:09 INFO - PROCESS | 3412 | |1;audio-beat-detection;164;132;173;210;137;160;153;133;190;132 12:51:09 INFO - PROCESS | 3412 | |2;audio-dft;163;163;166;172;164;163;162;161;165;163 12:51:09 INFO - PROCESS | 3412 | |3;audio-fft;75;76;75;168;76;75;75;75;162;79 12:51:09 INFO - PROCESS | 3412 | |4;audio-oscillator;94;94;166;94;95;94;139;96;94;140 12:51:09 INFO - PROCESS | 3412 | |5;imaging-gaussian-blur;117;117;117;117;117;117;120;118;117;117 12:51:09 INFO - PROCESS | 3412 | |6;imaging-darkroom;149;147;147;148;148;147;147;146;147;147 12:51:09 INFO - PROCESS | 3412 | |7;imaging-desaturate;96;95;95;95;96;96;96;95;94;95 12:51:09 INFO - PROCESS | 3412 | |8;json-parse-financial;66;67;66;65;66;66;67;66;67;65 12:51:09 INFO - PROCESS | 3412 | |9;json-stringify-tinderbox;65;69;64;64;64;64;65;64;64;65 12:51:09 INFO - PROCESS | 3412 | |10;stanford-crypto-aes;84;82;83;88;82;84;85;84;141;88 12:51:09 INFO - PROCESS | 3412 | |11;stanford-crypto-ccm;132;139;140;130;130;130;134;131;160;150 12:51:09 INFO - PROCESS | 3412 | |12;stanford-crypto-pbkdf2;174;172;174;171;177;171;170;170;174;175 12:51:09 INFO - PROCESS | 3412 | |13;stanford-crypto-sha256-iterative;68;67;72;67;67;68;69;73;66;68 12:51:09 INFO - PROCESS | 3412 | __end_tp_report 12:51:09 INFO - PROCESS | 3412 | __start_cc_report 12:51:09 INFO - PROCESS | 3412 | _x_x_mozilla_cycle_collect,929 12:51:09 INFO - PROCESS | 3412 | __end_cc_report 12:51:09 INFO - PROCESS | 3412 | __startTimestamp1464033069859__endTimestamp 12:51:09 INFO - PROCESS | 3412 | 12:51:09 INFO - PROCESS | 3412 | ------- Summary: start ------- 12:51:09 INFO - PROCESS | 3412 | Number of tests: 14 12:51:09 INFO - PROCESS | 3412 | 12:51:09 INFO - PROCESS | 3412 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.50 stddev:2.17 (1.9%) stddev-sans-first:2.24 12:51:09 INFO - PROCESS | 3412 | Values: 116.0 109.0 115.0 115.0 116.0 115.0 116.0 116.0 115.0 113.0 12:51:09 INFO - PROCESS | 3412 | 12:51:09 INFO - PROCESS | 3412 | [#1] audio-beat-detection Cycles:10 Average:158.40 Median:162.00 stddev:26.74 (16.5%) stddev-sans-first:28.28 12:51:09 INFO - PROCESS | 3412 | Values: 164.0 132.0 173.0 210.0 137.0 160.0 153.0 133.0 190.0 132.0 12:51:09 INFO - PROCESS | 3412 | 12:51:09 INFO - PROCESS | 3412 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:3.08 (1.9%) stddev-sans-first:3.24 12:51:09 INFO - PROCESS | 3412 | Values: 163.0 163.0 166.0 172.0 164.0 163.0 162.0 161.0 165.0 163.0 12:51:09 INFO - PROCESS | 3412 | 12:51:09 INFO - PROCESS | 3412 | [#3] audio-fft Cycles:10 Average:93.60 Median:75.00 stddev:37.68 (50.2%) stddev-sans-first:39.36 12:51:09 INFO - PROCESS | 3412 | Values: 75.0 76.0 75.0 168.0 76.0 75.0 75.0 75.0 162.0 79.0 12:51:09 INFO - PROCESS | 3412 | 12:51:09 INFO - PROCESS | 3412 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:94.00 stddev:27.03 (28.8%) stddev-sans-first:27.99 12:51:09 INFO - PROCESS | 3412 | Values: 94.0 94.0 166.0 94.0 95.0 94.0 139.0 96.0 94.0 140.0 12:51:09 INFO - PROCESS | 3412 | 12:51:09 INFO - PROCESS | 3412 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 12:51:09 INFO - PROCESS | 3412 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 120.0 118.0 117.0 117.0 12:51:09 INFO - PROCESS | 3412 | 12:51:09 INFO - PROCESS | 3412 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.60 12:51:09 INFO - PROCESS | 3412 | Values: 149.0 147.0 147.0 148.0 148.0 147.0 147.0 146.0 147.0 147.0 12:51:09 INFO - PROCESS | 3412 | 12:51:09 INFO - PROCESS | 3412 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 12:51:09 INFO - PROCESS | 3412 | Values: 96.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 94.0 95.0 12:51:09 INFO - PROCESS | 3412 | 12:51:09 INFO - PROCESS | 3412 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 12:51:09 INFO - PROCESS | 3412 | Values: 66.0 67.0 66.0 65.0 66.0 66.0 67.0 66.0 67.0 65.0 12:51:09 INFO - PROCESS | 3412 | 12:51:09 INFO - PROCESS | 3412 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:64.50 stddev:1.55 (2.4%) stddev-sans-first:1.64 12:51:09 INFO - PROCESS | 3412 | Values: 65.0 69.0 64.0 64.0 64.0 64.0 65.0 64.0 64.0 65.0 12:51:09 INFO - PROCESS | 3412 | 12:51:09 INFO - PROCESS | 3412 | [#10] stanford-crypto-aes Cycles:10 Average:90.10 Median:84.00 stddev:18.01 (21.4%) stddev-sans-first:18.97 12:51:09 INFO - PROCESS | 3412 | Values: 84.0 82.0 83.0 88.0 82.0 84.0 85.0 84.0 141.0 88.0 12:51:09 INFO - PROCESS | 3412 | 12:51:09 INFO - PROCESS | 3412 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:136.50 stddev:10.13 (7.4%) stddev-sans-first:10.54 12:51:09 INFO - PROCESS | 3412 | Values: 132.0 139.0 140.0 130.0 130.0 130.0 134.0 131.0 160.0 150.0 12:51:09 INFO - PROCESS | 3412 | 12:51:09 INFO - PROCESS | 3412 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:174.00 stddev:2.35 (1.3%) stddev-sans-first:2.45 12:51:09 INFO - PROCESS | 3412 | Values: 174.0 172.0 174.0 171.0 177.0 171.0 170.0 170.0 174.0 175.0 12:51:09 INFO - PROCESS | 3412 | 12:51:09 INFO - PROCESS | 3412 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.00 stddev:2.27 (3.3%) stddev-sans-first:2.40 12:51:09 INFO - PROCESS | 3412 | Values: 68.0 67.0 72.0 67.0 67.0 68.0 69.0 73.0 66.0 68.0 12:51:09 INFO - PROCESS | 3412 | -------- Summary: end -------- 12:51:09 INFO - PROCESS | 3412 | 12:51:11 INFO - TEST-INFO | 3412: exit 0 12:51:11 INFO - TEST-OK | kraken | took 64929ms 12:51:11 INFO - SUITE-END | took 1180s 12:51:11 INFO - Completed test suite (00:19:40) 12:51:11 INFO - javascript benchmark 12:51:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6178.690362587114, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2672.719364466731, 2699.703032666406, 2701.5407380745273, 2716.918492445226, 2728.6452761141036, 4648.511906249846, 4695.319178719088, 4724.574788269055, 4781.474037855842, 4829.951700482994, 4652.488226295113, 4749.8812529686775, 4784.473707892138, 4851.63612729045, 4884.072026314998, 4355.978220108903, 4366.345048242757, 4446.844360447369, 4475.373447717306, 4478.395416618748, 4172.144710334374, 4554.635629149677, 4569.885752856172, 4583.404157459526, 4610.0, 4362.280223763075, 4429.490608580022, 4438.400815889846, 4492.460904691458, 4501.617362524189, 4470.396496472967, 4470.709403888737, 4478.910421791578, 4494.662900282459, 4496.100779844044, 4483.14820184164, 4496.662750293741, 4507.211238033331, 4518.344839998214, 4553.840615578439, 4689.249720044776, 4701.835435759732, 4717.693349932243, 4725.40932383452, 4759.452662943771, 5121.897562048775, 5143.434222235551, 5153.768080436389, 5156.664816786934, 5184.611154163453, 5083.517065878736, 5212.166053431432, 5213.582913366921, 5214.270002199695, 5221.477852214786, 4755.548222918817, 4797.7601119943865, 4810.11012962603, 4814.15752243356, 4819.349387832668, 5262.97368513155, 5289.444608316071, 5291.629585928948, 5323.095073837457, 5362.758675859595, 4909.509049095133, 4946.3817022872145, 5072.036313100499, 5081.568066714371, 5087.465816089331, 5098.490150984946, 5107.642465027412, 5119.513646203604, 5128.769205385766, 5181.1969144782615, 4944.554990050912, 4998.975005125024, 5043.823466178739, 5096.184610462308, 5097.949020509747, 4955.603551715854, 5026.949730502722, 5066.493350664904, 5077.086124497626, 5143.691378517301, 4265.0, 4294.677899157576, 4299.828006879752, 4304.935425968613, 4305.935410968838, 3746.3818469952153, 3761.6990640748672, 3767.566729826105, 3795.886123416302, 3800.961990380061, 4493.370928070073, 4498.865034048984, 4499.752513611717, 4500.617447516932, 4508.571685689854, 5090.796368145307, 5095.439501654815, 5109.335786347751, 5166.844994650167, 5222.895542089137, 4448.777561121931, 4456.821727130943, 4476.35092911526, 4478.843240486633, 4483.798229079634, 4540.5913467787395, 4560.0, 4584.908301833944, 4590.540945905383, 4634.050019745944, 4734.053189362141, 4796.784144713496, 4872.4640289567415, 4923.286123512143, 4936.506349365035, 5224.947750522598, 5240.921386179134, 5251.737413129252, 5252.133397989289, 5257.158854583248, 4928.482509336612, 4948.430930443045, 4951.702897826142, 4962.3052772611145, 4991.625628077836, 4988.326575912205, 4993.201087825931, 5016.097102521581, 5043.9747801260755, 5065.189569668835, 5105.974470127774, 5112.079825631422, 5124.5131712487255, 5141.2288156775285, 5180.896382072262, 4844.733539655353, 4996.950030499794, 5000.749962501787, 5001.699898006132, 5002.724850133132, 4856.247281671346, 4944.258361245842, 4966.428860681068, 5003.323886498064, 5017.4731653175895, 4918.754062296799, 4940.827071052496, 4959.60323174138, 4964.826231081895, 4980.128477516348, 5086.669366491166, 5087.542121209109, 5089.338386009795, 5097.209932460474, 5108.795648174031, 4817.662763606514, 4886.804527818847, 4912.238603016538, 4916.606671466346, 4920.704757714549], "value": 4720.917965202868, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.7119386529153, 592.786596825143, 594.7620951619351, 610.6702380714414, 611.626907586372, 34642.307153856906, 38524.80737596315, 38644.42033369498, 38732.80633596835, 38735.41896871546, 39653.206935861264, 40284.0, 40393.596064039426, 40447.595524044824, 40507.797461012655, 7696.769096927102, 7869.2130786921425, 7876.527408355489, 7895.171007044264, 7903.881441778378, 7684.346830519385, 7691.769246922573, 7740.767776966672, 7795.727149549767, 7805.063392392921, 7823.843523129534, 7876.094249161334, 7913.485623434458, 7918.564478953655, 7938.0, 7795.532268063906, 7803.687852485894, 7877.842443151134, 7911.248431399008, 7916.722914698015, 7692.807679807994, 7765.1458339582605, 7802.843943121163, 7818.218178182193, 7826.765197044041, 29702.85148574265, 36476.81761591202, 36806.63193368086, 36885.446718299245, 36989.07527311812, 3106.176863131272, 3111.8132912025126, 3169.4453470642547, 3267.2158681916408, 3353.832308384571, 27636.0, 27934.301642458897, 29021.56467652987, 29284.41431171386, 29660.110196694135, 3430.7255419566377, 3534.0, 3611.7652352596997, 3668.3580373434543, 3724.6089160638285, 270524.0, 271248.0, 271672.0, 272695.6365218181, 273372.0, 29900.700992990227, 30724.84637576798, 59906.70046649739, 60045.69977150086, 60495.09257361143, 35417.46873796895, 35541.28917421637, 35657.10857228538, 35818.28363432717, 35836.82081589627, 10709.250352475408, 10771.407572583583, 10773.0, 10777.353358798497, 10797.0, 8938.597763100675, 8941.374103812801, 8963.417377870548, 9053.366264361432, 9062.320325975446, 8201.097879233279, 8228.518866603948, 8247.711330103417, 8316.501009939302, 8329.541875196923, 3217.549543063973, 3231.159898426426, 3232.175795172216, 3277.7705560611007, 3278.5573947517255, 893.8659201119884, 924.8890133184061, 973.1241882305982, 989.4162444157981, 1008.1581879131007, 27496.312592185357, 28504.0, 28848.0, 28853.85573072121, 28930.566041509395, 968.8352979993418, 984.6996666016934, 992.950352482373, 1051.8422236664562, 1052.3317693264678, 14536.345864436125, 14730.55808325752, 14886.851131488547, 15095.54713358601, 15202.619934501505, 384234.0, 388622.0, 389122.0, 392051.0, 392493.0, 49919.750401248486, 50503.24245136326, 50622.999999999265, 50655.0, 50687.49312506901, 1207.2092779229795, 1211.6546784166646, 1222.0468034932767, 1222.7309991801967, 1230.4585982167816, 26719.732802671726, 27760.167194984184, 27864.442711145257, 28406.147815565568, 28504.287392815346, 42406.57593424026, 42587.57412425836, 42679.14641707211, 43122.78438607787, 43252.0, 329686.0, 332084.0, 332384.0, 332861.0, 332861.0, 25414.872925635253, 25764.355891102874, 26206.475870482864, 26264.868675657264, 26288.211353659422, 42723.35914961216, 43031.35452968271, 43215.35176972411, 43420.782896085315, 43578.78210609053, 35705.46441803323, 36244.4563331545, 36732.632673672924, 36771.0, 36974.81512592528, 36298.637013630585, 36387.7251047407, 36396.27207455889, 36407.27185456329, 37157.0, 35554.28891422209, 36098.63901361058, 36432.635673643985, 36668.63331366652, 36831.263374732895, 30680.232994175323, 31803.74635329393, 31934.36131277315, 31944.68055319417, 32145.357092857543, 25297.62053569161, 25471.36321591975, 25499.6175057378, 25620.35949101213, 25649.0], "value": 16480.89737101572, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.8480238299914, 367.48735513958036, 369.2154172383683, 376.38855184504683, 376.56694800978886, 15841.445549405773, 17220.655586888253, 17233.741493877602, 17587.56031099223, 17712.822871771277, 15861.444849430272, 16894.74657880133, 17446.65106697865, 17646.029468379234, 17661.646767064653, 5068.239764035397, 5241.056609810233, 5254.31693879797, 5259.894802103956, 5282.894342113174, 3753.662170404663, 5155.613329000321, 5807.767689292445, 6119.938800611982, 6124.418180272889, 6107.053406721965, 6127.080937859335, 6163.722632481549, 6164.660943648098, 6173.81478555644, 5190.610704197182, 5457.972710136443, 5515.696636684981, 5586.190002449622, 5604.775808967636, 5211.583073354161, 5407.0, 5410.0, 5419.458054194589, 5428.891422171574, 12512.562060327844, 12569.874301256961, 12601.0, 12697.682557936034, 12731.42708578107, 1816.8092350303293, 2030.147338117994, 2148.1622167354744, 2388.2596395117394, 2412.867292298923, 8437.915620843774, 9156.679516216967, 9413.811723765555, 11017.008469237808, 13665.726685466334, 1700.3368686212386, 1758.7625670534442, 1776.1317364077133, 1784.9553761155946, 1814.963700725978, 70478.64760676216, 71309.2869071313, 72187.2781272191, 72342.91485627773, 72719.27280727177, 10190.949045254727, 10290.3825770454, 10346.948265258625, 10403.531841067019, 10525.421101839473, 14200.502982395567, 14244.715105697827, 14261.288645362623, 14292.0, 14322.925780566498, 6385.904211436832, 6402.103705481143, 6526.988316810902, 6593.274739778621, 6600.86798264032, 5747.482726554546, 5877.118432235114, 5945.494632956247, 5981.611195272293, 5981.910271345933, 4417.734935903856, 4483.887902802391, 4528.592426681615, 4558.270676691714, 4582.335561343587, 1711.2812618700175, 1756.0, 1803.386848471526, 1844.6310737852484, 1865.1513561329562, 403.7819577428215, 405.45466347762215, 408.96114869087984, 414.1447910065765, 787.9645415956296, 10627.202959777893, 10838.837417438745, 10886.346819190874, 10932.672019839418, 10974.615888444026, 414.9875503734893, 420.9200251952119, 436.73577485621377, 438.5132502921754, 441.1397774339986, 5787.07406814916, 5811.3316968548315, 5837.532997360286, 5893.351731309553, 5916.911246331309, 410773.0, 411716.0, 414001.0, 417805.0, 426876.0, 74614.0, 77532.22467775363, 79637.60181199056, 85576.0, 87228.56385718031, 962.0812124421021, 962.119660510625, 965.6234068713208, 996.3025881882567, 1001.5743309093606, 15564.377424902877, 15832.683346332778, 16032.438864639682, 16220.188990550188, 16303.510894673178, 34636.82681586576, 35811.462828058124, 36089.27821443609, 36153.0, 36730.63269367272, 50673.74663126661, 50761.746191270286, 50937.490625093276, 51915.740421297654, 52569.47430525646, 7405.740799072222, 7533.2466753324225, 7568.205338439385, 7734.7679569613, 7734.806629834299, 10418.739531511774, 10827.13382929348, 10882.843417876025, 11163.720906977065, 11581.594644187413, 10039.19686425099, 10351.63769268072, 10411.895881041093, 10614.097801686943, 10666.786664266827, 10483.52824122901, 10643.94678026605, 10659.840102398315, 10745.516451759533, 10965.451727413756, 10028.799424011333, 10207.336523125972, 10426.947865260929, 10558.524866381185, 10622.73443163927, 7633.580153091633, 7691.730789422567, 7789.0, 7822.4524283299625, 7928.246816552418, 7811.687532498637, 10136.898631013595, 10159.441230732085, 10383.688489345332, 10416.270861039655], "value": 7710.207395814926, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1294.3851670456534, 1437.1592618318284, 1566.2325460524346, 1764.126757255159, 1786.8742692103972, 6906.75826346078, 7495.70017199312, 7519.887201691965, 8030.036395632532, 8053.35573154147, 7714.922850771491, 7853.332466740334, 7953.284204421601, 7984.2015798420125, 8003.8799418008775, 2182.596219699353, 2218.6117429449782, 2226.810721088709, 2231.0964059555827, 2242.9887850560726, 2181.214762685432, 2197.099189332374, 2217.944551386212, 2230.130249202804, 2237.5636750833596, 2116.703661487393, 2127.4894025433864, 2144.924927627533, 2164.6644770060666, 2214.9224777132804, 2126.8192203662707, 2132.8400369972237, 2136.6154092263387, 2140.090461553841, 2142.442964829148, 2092.1422216891156, 2124.1397234120204, 2151.505153814616, 2155.4180371299663, 2165.1988764157204, 7832.334251588622, 7848.372130229568, 7882.172371900925, 7895.0, 7898.842023159562, 4322.567743225683, 4416.823327066945, 4427.490838553543, 4434.046679963823, 4440.733555986619, 2828.3918957424253, 2898.2029941765973, 2963.9110826675233, 2982.135180797566, 2990.5364668476423, 881.3125761905724, 926.7080869526078, 927.1516562345446, 948.1940350701917, 970.7864269860619, 10375.42935138567, 10403.635872744493, 10406.531706073245, 10413.323133996266, 10422.166226701922, 4005.2590270799997, 4234.364845273234, 4265.914681706348, 4273.1026484438, 4275.48694156697, 9047.276217902552, 9083.500407477652, 9104.044075372123, 9104.544772761335, 9104.772380690403, 4263.680223983214, 4356.346548017823, 4368.650507959355, 4431.778411079433, 4454.10917816438, 3408.1820363112674, 3905.3946638271113, 3918.412238164241, 3920.862769803043, 4112.732672376286, 3657.231981283907, 3712.7215458840697, 3806.657400833938, 3823.445600387928, 3846.2692088503095, 1211.8061110222498, 1221.3160630047203, 1227.3495047624774, 1239.7086684629105, 1239.9566015189425, 806.395203597302, 819.3527113580324, 828.6561077152915, 858.0, 867.1631875240423, 5147.948520514822, 5156.329677142023, 5220.399654039758, 5351.518363347317, 5353.9196912046355, 401.770990535392, 423.472776393386, 423.8791944295861, 427.83528341588715, 432.47670318914464, 3558.217192217708, 3587.982060089683, 3593.083763640255, 3646.0520264731363, 3666.908327291839, 8973.865392019125, 9059.909400906039, 9180.632774689071, 9211.677591284273, 9238.076192380708, 9006.819863602823, 9041.321900857462, 9085.182333590008, 9105.317101217435, 9128.634854605874, 6777.423918966943, 6817.0796942413135, 6833.180018397824, 7145.39264162552, 7173.210946795848, 5057.393112826484, 5106.591472682102, 5109.463506331782, 5148.279240906201, 5179.81870634526, 8296.668133274601, 8546.957265213883, 8549.615267312862, 8569.057403685714, 8626.051134375088, 8954.449279412425, 8980.101989800967, 9102.544872756469, 9244.491552964651, 9267.397619154734, 6124.724387402666, 6184.319724830355, 6305.558610897193, 6666.133402657623, 6776.728930842711, 7569.772906812805, 7599.354054905395, 7610.429217808576, 7629.656665450179, 7645.235476452533, 6432.485401167989, 6698.531102822755, 6780.830479237861, 6892.793216203522, 7111.0, 6579.901301480578, 6751.729930802713, 6757.3242675732035, 6808.693608787716, 6826.829329266808, 6246.437820596168, 6403.135576697086, 6440.066190402459, 6461.289258181502, 6494.415502604788, 4733.952660473489, 4750.192467280502, 4874.2444921037295, 4879.04858552593, 4879.56083952446, 4779.928301075417, 4783.904321913473, 4832.275158726219, 4836.298736683091, 4858.587020103189], "value": 4041.38033490504, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.2578405554225, 303.7554768411429, 304.9756019518439, 311.4254200999156, 312.42981558655447, 4979.402471703401, 4979.8008079676765, 4982.202847544394, 5006.048850718361, 5065.797368105276, 4849.175640141176, 4907.26391041344, 4911.72985485799, 4913.31213630092, 4960.751962401874, 3714.7028237740915, 3719.5350581177354, 3876.9612303876884, 3880.592537783534, 3880.961190388088, 3870.20660764544, 3875.147467557133, 3892.377219644857, 3894.636877093009, 3938.2911076006308, 3829.8468061277517, 3858.84564617415, 3882.4758657581287, 3883.3204189266908, 3919.451816532468, 3810.6570408663074, 3884.902152837464, 3890.591487893787, 3913.4912461380122, 3916.784576848272, 3422.3155368926314, 3440.6215316315183, 3441.0, 3442.5524681791458, 3463.2727127303297, 4731.952680473186, 4750.144973904696, 4751.477337492873, 4756.952430475685, 4758.119747846659, 4421.955780442218, 4438.844640437569, 4444.955550444519, 4446.266366049598, 4491.719859839963, 4823.662343635947, 5134.4095429025765, 5145.948540514584, 5165.9225111623355, 5193.610479214074, 3626.184108575576, 3639.29033838399, 3647.689946354563, 3680.687141592941, 3715.0898029982827, 5486.91769623456, 5492.670439773587, 5500.779968801243, 5509.118541033456, 5521.917171242394, 3711.758735682172, 3780.584135745066, 3788.734788564829, 3789.5831458539537, 3791.279656865187, 3786.8295926683363, 3822.7132965027736, 3826.5025546678753, 3840.2127563849344, 3843.385058390644, 4359.825606975749, 4359.891002724958, 4384.386185933972, 4398.054418300081, 4414.139242847614, 5017.67385119966, 5133.926367648389, 5162.019216348882, 5194.662346947436, 5228.529432351107, 1304.9934750326188, 1312.8884044856104, 1323.4772264955288, 1323.847757507899, 1334.5796074236584, 827.6027506796651, 832.7751507093051, 851.0935853316322, 854.6068808348106, 854.7606670132373, 4537.228671125917, 4655.534446555317, 4657.976710116428, 4659.2312268476, 4660.650451216173, 5372.0, 5373.677579345252, 5378.2470454136455, 5389.649672771257, 5424.755885985141, 4484.977575112103, 4621.584057434847, 4621.815127394933, 4625.814967401334, 4656.976715116402, 2800.6919238883706, 2826.1662809471254, 2832.787540934397, 2833.844138572398, 2844.33158207821, 5070.569001634903, 5078.542931136141, 5080.314157588752, 5085.364329458817, 5103.106956282636, 5325.600579956519, 5403.594730395236, 5463.448758307132, 5469.453054694499, 5506.476884695948, 5009.348784657971, 5032.899342013139, 5037.19404895215, 5069.31564238823, 5099.6685215460875, 5300.542350853546, 5352.571794256372, 5359.196120581944, 5399.946000539944, 5414.783408663609, 5131.56381707559, 5268.209768534751, 5300.3639563252655, 5331.1341030640515, 5335.359756829205, 5060.595152387874, 5090.4655011223285, 5091.516305950929, 5108.131617624938, 5142.588592912483, 3716.1267102230413, 3727.7763334200035, 3765.868194613285, 3770.7171962103503, 3783.4892289540558, 5178.533931946143, 5281.603879709114, 5382.461753824587, 5383.67697938125, 5411.675299482044, 5122.257272695364, 5202.427732949448, 5205.193195054772, 5212.5569326607665, 5224.440024388098, 5153.845384638467, 5165.870853228549, 5195.636305458582, 5205.3753549572775, 5223.3209682741, 4949.727764972961, 5057.439405263451, 5068.822591209438, 5070.645054846125, 5136.101182293009, 4938.75306234694, 5038.823641172541, 5114.616403769806, 5183.663061900965, 5204.854931914972, 5100.974495127649, 5107.565856902205, 5112.463191364853, 5115.590752739698, 5119.48805119485], "value": 3911.902655847209, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.4153145232195, 745.7129005332947, 746.298479429336, 754.0009487429157, 760.608286732333, 11505.769884602314, 11696.122790790681, 11983.580574679889, 12012.0, 12066.215695979767, 12125.818112728317, 12185.207961482498, 12186.390680465985, 12198.451069701863, 12216.022718182547, 611.4038812158154, 782.307657722915, 784.2667106255641, 795.2087672765606, 796.8366484870617, 806.9515829050247, 808.5754978636234, 809.1503920883079, 811.7118422959853, 811.7443005453264, 841.1630427724423, 842.928351090155, 843.026304618167, 844.9450785698909, 846.0524212881551, 838.7651457591884, 840.6259214649483, 841.4951029382382, 842.1620487614802, 842.9620667069996, 614.0298328640737, 614.241411856357, 614.3764079459353, 615.129591627846, 616.8951278282702, 11807.173497855154, 11822.408879556075, 11825.349605771678, 11857.110716696283, 11882.881171188264, 12680.429380677799, 12874.742505149845, 12995.090343675947, 13020.544280950216, 13174.407151678197, 10038.397696138181, 10152.644657436955, 10285.537150828231, 10355.948220258926, 10370.688879333633, 3251.3822373748912, 3361.781484203519, 3391.440412331987, 3441.380551500729, 3457.6369481204365, 49402.0, 49428.0, 49678.7516062421, 50063.24905126426, 50503.494965050246, 9668.0, 9975.301728879054, 10138.341007834468, 10147.64483243083, 10471.528781204865, 17900.820991790177, 17911.10444477771, 18003.909980450015, 18011.18949647269, 18129.728054079198, 6609.239937407164, 6702.932970670328, 6723.495737819683, 6724.092247546617, 6789.422899053537, 3632.800195989193, 3645.5078564394, 3650.7444478886755, 3695.611960744137, 3725.962740372616, 2756.8759405826786, 2815.056955919749, 2849.2591926099362, 2850.5296626056884, 2855.8429286389032, 481.7494902650602, 499.07421732685344, 503.5593855376546, 506.36704119850185, 506.61750378464023, 566.9886602267932, 621.5462712220104, 623.3143542103741, 632.3518393646457, 657.9111570351076, 7412.555246685216, 7545.320921117016, 7679.500832445873, 7746.612669366509, 7757.7672669819995, 484.6558943150332, 552.3951273355669, 565.8953093677683, 581.4795757796749, 584.1617279204355, 3778.244351129785, 3866.994581408798, 3916.353801622757, 3931.331673615492, 3942.448057271984, 57527.0, 58297.0, 59363.406365935785, 59462.40537594655, 59700.402995970355, 52365.73817130966, 52368.21447678288, 52570.47429525656, 52770.736146319025, 54555.72722136364, 19099.61800764005, 19554.21783128659, 24994.875025624755, 48288.0, 50014.749926250865, 7325.890111648223, 7519.510757147423, 7581.696732130653, 7609.505382150364, 7650.972745270266, 32729.509057364634, 32731.34537309288, 33010.504842427865, 33318.333633326714, 33361.165970850925, 40009.79995100006, 43307.0, 43381.56618433775, 43596.0, 43772.56227437685, 10304.742381440525, 10312.793744125225, 10326.432046237529, 10374.636887708893, 10398.896011039793, 10494.737631559272, 10533.57865685364, 10622.52198651078, 10929.56281748721, 11030.834537482106, 9966.92282822248, 10009.5495702695, 10100.797984040424, 10102.191824653863, 10222.1822254218, 9945.453000085065, 9946.950265248628, 10106.797864042825, 10166.74583135398, 10239.129673977795, 10101.44442055694, 10116.595336186765, 10117.140043096419, 10276.280660353703, 10408.0, 8416.795646312748, 8499.787505312417, 8670.78323041929, 8832.293416526534, 8975.057618949917, 8745.56272186401, 8751.343649226206, 8786.472811631322, 8798.780030499289, 8898.243649289883], "value": 5865.999440391583, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1601.2999999999995, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 115.0, 115.0, 116.0, 115.0, 116.0, 116.0, 115.0, 113.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 132.0, 173.0, 210.0, 137.0, 160.0, 153.0, 133.0, 190.0, 132.0], "value": 158.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 166.0, 172.0, 164.0, 163.0, 162.0, 161.0, 165.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 168.0, 76.0, 75.0, 75.0, 75.0, 162.0, 79.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 166.0, 94.0, 95.0, 94.0, 139.0, 96.0, 94.0, 140.0], "value": 110.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 120.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 94.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 65.0, 66.0, 66.0, 67.0, 66.0, 67.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 83.0, 88.0, 82.0, 84.0, 85.0, 84.0, 141.0, 88.0], "value": 90.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 139.0, 140.0, 130.0, 130.0, 130.0, 134.0, 131.0, 160.0, 150.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 174.0, 171.0, 177.0, 171.0, 170.0, 170.0, 174.0, 175.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 72.0, 67.0, 67.0, 68.0, 69.0, 73.0, 66.0, 68.0], "value": 68.5, "unit": "score"}]}]} 12:51:11 INFO - Return code: 0 12:51:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:51:11 ERROR - # TBPL SUCCESS # 12:51:11 INFO - Running post-action listener: _resource_record_post_action 12:51:11 INFO - ##### 12:51:11 INFO - ##### Finished run-tests step (success) 12:51:11 INFO - ##### 12:51:11 INFO - Running post-run listener: _resource_record_post_run 12:51:11 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 12288; Write bytes: 545247232; Read time: 236; Write time: 565616 12:51:11 INFO - TinderboxPrint: CPU usage
13.3% 12:51:11 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 236 12:51:11 INFO - TinderboxPrint: I/O write bytes / time
545,247,232 / 565,616 12:51:11 INFO - TinderboxPrint: CPU idle
8,285.8 (86.7%) 12:51:11 INFO - TinderboxPrint: CPU user
1,225.8 (12.8%) 12:51:11 INFO - TinderboxPrint: Swap in / out
0 / 0 12:51:11 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 236736512; Read time: 196; Write time: 308444 12:51:11 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 8192; Write bytes: 296525824; Read time: 40; Write time: 255356 12:51:12 INFO - Running post-run listener: _upload_blobber_files 12:51:12 INFO - Blob upload gear active. 12:51:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:51:12 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 12:51:12 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:51:12 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:51:12 INFO - (blobuploader) - INFO - Open directory for files ... 12:51:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:51:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:51:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:51:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:51:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:51:14 INFO - (blobuploader) - INFO - Done attempting. 12:51:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:51:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:51:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:51:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:51:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:51:15 INFO - (blobuploader) - INFO - Done attempting. 12:51:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:51:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:51:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:51:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:51:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:51:18 INFO - (blobuploader) - INFO - Done attempting. 12:51:18 INFO - (blobuploader) - INFO - Iteration through files over. 12:51:18 INFO - Return code: 0 12:51:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:51:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:51:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b0f835c9ef7358d936fe378ebf8b85dd9a1dc00ee3ae42b75e561041ca58a5c2a2a71058770f6ec81d1750c386e37786672f06de4527b3cd58c4dda9c833a237", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/496c9d51342316359ee64c0114d83929d6307599c8599171d43680240db6e5bf445f903c57062da05d51915487e67177754f92359bf93435a27d118f0734ca02", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2a5a612f23f64fe8cd765844445893809c52301f36b64ad1ae58be503b7ae6f32ca15347584c28e8198f442d59951578ba823a33d65d894c835fdc84be7188be"} 12:51:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:51:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:51:18 INFO - Contents: 12:51:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b0f835c9ef7358d936fe378ebf8b85dd9a1dc00ee3ae42b75e561041ca58a5c2a2a71058770f6ec81d1750c386e37786672f06de4527b3cd58c4dda9c833a237", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/496c9d51342316359ee64c0114d83929d6307599c8599171d43680240db6e5bf445f903c57062da05d51915487e67177754f92359bf93435a27d118f0734ca02", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2a5a612f23f64fe8cd765844445893809c52301f36b64ad1ae58be503b7ae6f32ca15347584c28e8198f442d59951578ba823a33d65d894c835fdc84be7188be"} 12:51:18 INFO - Running post-run listener: copy_logs_to_upload_dir 12:51:18 INFO - Copying logs to upload dir... 12:51:18 INFO - mkdir: /builds/slave/test/build/upload/logs 12:51:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.121356 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-23 12:51:18.070166) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 12:51:18.074179) ========= 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=62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061 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/Fx-Team-Non-PGO/sha512/b0f835c9ef7358d936fe378ebf8b85dd9a1dc00ee3ae42b75e561041ca58a5c2a2a71058770f6ec81d1750c386e37786672f06de4527b3cd58c4dda9c833a237", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/496c9d51342316359ee64c0114d83929d6307599c8599171d43680240db6e5bf445f903c57062da05d51915487e67177754f92359bf93435a27d118f0734ca02", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2a5a612f23f64fe8cd765844445893809c52301f36b64ad1ae58be503b7ae6f32ca15347584c28e8198f442d59951578ba823a33d65d894c835fdc84be7188be"} build_url:https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/RMeCu3iTTFWg1Lf5rFa5ng/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/Fx-Team-Non-PGO/sha512/b0f835c9ef7358d936fe378ebf8b85dd9a1dc00ee3ae42b75e561041ca58a5c2a2a71058770f6ec81d1750c386e37786672f06de4527b3cd58c4dda9c833a237", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/496c9d51342316359ee64c0114d83929d6307599c8599171d43680240db6e5bf445f903c57062da05d51915487e67177754f92359bf93435a27d118f0734ca02", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2a5a612f23f64fe8cd765844445893809c52301f36b64ad1ae58be503b7ae6f32ca15347584c28e8198f442d59951578ba823a33d65d894c835fdc84be7188be"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 12:51:18.103506) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 12:51:18.103840) ========= 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=62c568580acbfdaac3eec7be000001dc-1464030081.442647-1766627061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 12:51:18.188375) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 12:51:18.188707) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 12:51:18.189007) ========= ========= Total master_lag: 0.19 =========