builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1464883633.68 results: success (0) buildid: 20160602074854 builduid: fb5540662f084481ae7af33147d81f7a revision: 0b1b9a827cb00e2051e2df795b1316856d1c190f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 09:07:13.682156) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 09:07:13.682640) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 09:07:13.682932) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 09:07:14.068090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 09:07:14.068480) ========= 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=20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 09:07:14-- 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% 227M=0s 2016-06-02 09:07:14 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155738 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 09:07:14.238564) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 09:07:14.238903) ========= 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=20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.104651 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 09:07:14.355399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 09:07:14.355754) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0b1b9a827cb00e2051e2df795b1316856d1c190f --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 0b1b9a827cb00e2051e2df795b1316856d1c190f --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=20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 09:07:14,411 truncating revision to first 12 chars 2016-06-02 09:07:14,411 Setting DEBUG logging. 2016-06-02 09:07:14,411 attempt 1/10 2016-06-02 09:07:14,411 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0b1b9a827cb0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 09:07:15,723 unpacking tar archive at: fx-team-0b1b9a827cb0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.671008 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 09:07:16.040015) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 09:07:16.040338) ========= script_repo_revision: 0b1b9a827cb00e2051e2df795b1316856d1c190f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 09:07:16.040761) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 09:07:16.041029) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 09:07:16.051534) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-02 09:07:16.051889) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:07:16 INFO - MultiFileLogger online at 20160602 09:07:16 in /builds/slave/test 09:07:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 09:07:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:07:16 INFO - {'append_to_log': False, 09:07:16 INFO - 'base_work_dir': '/builds/slave/test', 09:07:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:07:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:07:16 INFO - 'branch': 'Fx-Team-Non-PGO', 09:07:16 INFO - 'buildbot_json_path': 'buildprops.json', 09:07:16 INFO - 'config_files': ('talos/linux_config.py',), 09:07:16 INFO - 'default_actions': ('clobber', 09:07:16 INFO - 'read-buildbot-config', 09:07:16 INFO - 'download-and-extract', 09:07:16 INFO - 'populate-webroot', 09:07:16 INFO - 'create-virtualenv', 09:07:16 INFO - 'install', 09:07:16 INFO - 'run-tests'), 09:07:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:07:16 INFO - 'download_minidump_stackwalk': True, 09:07:16 INFO - 'download_symbols': 'ondemand', 09:07:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:07:16 INFO - 'tooltool.py': '/tools/tooltool.py', 09:07:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:07:16 INFO - '/tools/misc-python/virtualenv.py')}, 09:07:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:07:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:07:16 INFO - 'installer_path': 'installer.exe', 09:07:16 INFO - 'log_level': 'info', 09:07:16 INFO - 'log_name': 'talos', 09:07:16 INFO - 'log_to_console': True, 09:07:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:07:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:07:16 INFO - 'opt_config_files': (), 09:07:16 INFO - 'pip_index': False, 09:07:16 INFO - 'sps_profile': False, 09:07:16 INFO - 'sps_profile_interval': 0, 09:07:16 INFO - 'suite': 'dromaeojs', 09:07:16 INFO - 'system_bits': '32', 09:07:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:07:16 INFO - 'title': 'talos-linux64-ix-015', 09:07:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:07:16 INFO - 'use_talos_json': True, 09:07:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:07:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:07:16 INFO - 'work_dir': 'build'} 09:07:16 INFO - ##### 09:07:16 INFO - ##### Running clobber step. 09:07:16 INFO - ##### 09:07:16 INFO - Running pre-action listener: _resource_record_pre_action 09:07:16 INFO - Running main action method: clobber 09:07:16 INFO - rmtree: /builds/slave/test/build 09:07:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:07:22 INFO - Running post-action listener: _resource_record_post_action 09:07:22 INFO - ##### 09:07:22 INFO - ##### Finished clobber step (success) 09:07:22 INFO - ##### 09:07:22 INFO - ##### 09:07:22 INFO - ##### Running read-buildbot-config step. 09:07:22 INFO - ##### 09:07:22 INFO - Running pre-action listener: _resource_record_pre_action 09:07:22 INFO - Running main action method: read_buildbot_config 09:07:22 INFO - Using buildbot properties: 09:07:22 INFO - { 09:07:22 INFO - "project": "", 09:07:22 INFO - "product": "firefox", 09:07:22 INFO - "script_repo_revision": "production", 09:07:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:07:22 INFO - "repository": "", 09:07:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:07:22 INFO - "buildid": "20160602074854", 09:07:22 INFO - "pgo_build": "False", 09:07:22 INFO - "basedir": "/builds/slave/test", 09:07:22 INFO - "buildnumber": 3038, 09:07:22 INFO - "slavename": "talos-linux64-ix-015", 09:07:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:07:22 INFO - "platform": "ubuntu64_hw", 09:07:22 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:07:22 INFO - "branch": "fx-team", 09:07:22 INFO - "repo_path": "integration/fx-team", 09:07:22 INFO - "revision": "0b1b9a827cb00e2051e2df795b1316856d1c190f", 09:07:22 INFO - "stage_platform": "linux64", 09:07:22 INFO - "builduid": "fb5540662f084481ae7af33147d81f7a", 09:07:22 INFO - "slavebuilddir": "test" 09:07:22 INFO - } 09:07:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 09:07:22 INFO - Running post-action listener: _resource_record_post_action 09:07:22 INFO - ##### 09:07:22 INFO - ##### Finished read-buildbot-config step (success) 09:07:22 INFO - ##### 09:07:22 INFO - ##### 09:07:22 INFO - ##### Running download-and-extract step. 09:07:22 INFO - ##### 09:07:22 INFO - Running pre-action listener: _resource_record_pre_action 09:07:22 INFO - Running main action method: download_and_extract 09:07:22 INFO - mkdir: /builds/slave/test/build/tests 09:07:22 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')]} 09:07:22 INFO - https://queue.taskcluster.net/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:07:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:07:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:07:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIB-ojWZR_2EpnBzwYbbWw/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 09:07:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIB-ojWZR_2EpnBzwYbbWw/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 09:07:23 INFO - Downloaded 1361 bytes. 09:07:23 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:07:23 INFO - Using the following test package requirements: 09:07:23 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:07:23 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:07:23 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:07:23 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:23 INFO - u'jsshell-linux-x86_64.zip'], 09:07:23 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:07:23 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:07:23 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:07:23 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:07:23 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:07:23 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:07:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:07:23 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:07:23 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')]} 09:07:23 INFO - https://queue.taskcluster.net/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:07:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:07:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:07:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIB-ojWZR_2EpnBzwYbbWw/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 09:07:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIB-ojWZR_2EpnBzwYbbWw/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 09:07:24 INFO - Downloaded 22866922 bytes. 09:07:24 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'] 09:07:24 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 09:07:25 INFO - Return code: 0 09:07:25 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 09:07:25 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')]} 09:07:25 INFO - https://queue.taskcluster.net/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:07:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:07:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:07:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIB-ojWZR_2EpnBzwYbbWw/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 09:07:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIB-ojWZR_2EpnBzwYbbWw/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 09:07:26 INFO - Downloaded 22866922 bytes. 09:07:26 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'] 09:07:26 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 09:07:28 INFO - Return code: 0 09:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:28 INFO - https://queue.taskcluster.net/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:07:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:07:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:07:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIB-ojWZR_2EpnBzwYbbWw/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 09:07:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIB-ojWZR_2EpnBzwYbbWw/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 09:07:30 INFO - Downloaded 10834055 bytes. 09:07:30 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'] 09:07:30 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 09:07:30 INFO - Return code: 0 09:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:30 INFO - https://queue.taskcluster.net/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:07:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:07:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:07:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIB-ojWZR_2EpnBzwYbbWw/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 09:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bIB-ojWZR_2EpnBzwYbbWw/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 09:07:32 INFO - Downloaded 55087433 bytes. 09:07:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:07:32 INFO - mkdir: /builds/slave/test/properties 09:07:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:07:32 INFO - Writing to file /builds/slave/test/properties/build_url 09:07:32 INFO - Contents: 09:07:32 INFO - build_url:https://queue.taskcluster.net/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:07:33 INFO - Running post-action listener: _resource_record_post_action 09:07:33 INFO - Running post-action listener: set_extra_try_arguments 09:07:33 INFO - ##### 09:07:33 INFO - ##### Finished download-and-extract step (success) 09:07:33 INFO - ##### 09:07:33 INFO - ##### 09:07:33 INFO - ##### Running populate-webroot step. 09:07:33 INFO - ##### 09:07:33 INFO - Running pre-action listener: _resource_record_pre_action 09:07:33 INFO - Running main action method: populate_webroot 09:07:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:07:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:07:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:07:33 INFO - '--tppagecycles', 09:07:33 INFO - '7'], 09:07:33 INFO - 'tests': ['tsvgm']}}, 09:07:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:07:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:07:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:07:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:07:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:07:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:07:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:33 INFO - 'talos_options': ['--disable-e10s'], 09:07:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:33 INFO - 'talos_options': ['--disable-e10s'], 09:07:33 INFO - 'tests': ['damp', 'tps']}, 09:07:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:33 INFO - 'tests': ['damp', 'tps']}, 09:07:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:07:33 INFO - 'tests': ['dromaeo_dom']}, 09:07:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:07:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:07:33 INFO - 'tests': ['a11yr', 09:07:33 INFO - 'ts_paint', 09:07:33 INFO - 'tpaint', 09:07:33 INFO - 'sessionrestore', 09:07:33 INFO - 'sessionrestore_no_auto_restore', 09:07:33 INFO - 'tabpaint']}, 09:07:33 INFO - 'other-e10s': {'tests': ['a11yr', 09:07:33 INFO - 'ts_paint', 09:07:33 INFO - 'tpaint', 09:07:33 INFO - 'sessionrestore', 09:07:33 INFO - 'sessionrestore_no_auto_restore', 09:07:33 INFO - 'tabpaint']}, 09:07:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:07:33 INFO - 'ts_paint', 09:07:33 INFO - 'tpaint', 09:07:33 INFO - 'sessionrestore', 09:07:33 INFO - 'sessionrestore_no_auto_restore', 09:07:33 INFO - 'tabpaint']}, 09:07:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:07:33 INFO - 'ts_paint', 09:07:33 INFO - 'tpaint', 09:07:33 INFO - 'sessionrestore', 09:07:33 INFO - 'sessionrestore_no_auto_restore', 09:07:33 INFO - 'tabpaint']}, 09:07:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:07:33 INFO - 'tests': ['a11yr', 09:07:33 INFO - 'ts_paint', 09:07:33 INFO - 'tpaint', 09:07:33 INFO - 'sessionrestore', 09:07:33 INFO - 'sessionrestore_no_auto_restore', 09:07:33 INFO - 'tabpaint']}, 09:07:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:07:33 INFO - 'tests': ['a11yr', 09:07:33 INFO - 'ts_paint', 09:07:33 INFO - 'tpaint', 09:07:33 INFO - 'sessionrestore', 09:07:33 INFO - 'sessionrestore_no_auto_restore', 09:07:33 INFO - 'tabpaint']}, 09:07:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:07:33 INFO - 'tests': ['tsvgx', 09:07:33 INFO - 'tsvgr_opacity', 09:07:33 INFO - 'tart', 09:07:33 INFO - 'tscrollx', 09:07:33 INFO - 'cart']}, 09:07:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:07:33 INFO - 'tsvgr_opacity', 09:07:33 INFO - 'tart', 09:07:33 INFO - 'tscrollx', 09:07:33 INFO - 'cart']}, 09:07:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:33 INFO - 'talos_options': ['--disable-e10s'], 09:07:33 INFO - 'tests': ['tp5o']}, 09:07:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:33 INFO - 'tests': ['tp5o']}, 09:07:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:33 INFO - 'talos_options': ['--disable-e10s', 09:07:33 INFO - '--xperf_path', 09:07:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:33 INFO - 'tests': ['tp5n']}, 09:07:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:33 INFO - 'talos_options': ['--xperf_path', 09:07:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:33 INFO - 'tests': ['tp5n']}}, 09:07:33 INFO - 'talos.zip': {'path': '', 09:07:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:07:33 INFO - Running post-action listener: _resource_record_post_action 09:07:33 INFO - ##### 09:07:33 INFO - ##### Finished populate-webroot step (success) 09:07:33 INFO - ##### 09:07:33 INFO - ##### 09:07:33 INFO - ##### Running create-virtualenv step. 09:07:33 INFO - ##### 09:07:33 INFO - Running pre-action listener: _resource_record_pre_action 09:07:33 INFO - Running main action method: create_virtualenv 09:07:33 INFO - Creating virtualenv /builds/slave/test/build/venv 09:07:33 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 09:07:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:07:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:07:33 INFO - Using real prefix '/usr' 09:07:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:07:34 INFO - Installing distribute.............................................................................................................................................................................................done. 09:07:36 INFO - Installing pip.................done. 09:07:36 INFO - Return code: 0 09:07:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:07: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')]} 09:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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')]} 09:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:36 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 0x7fbd9c145f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194a9c0>, '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 0x194b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194bd50>, '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': '20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353', '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 09:07:36 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 09:07:36 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 09:07:36 INFO - Using env: {'DISPLAY': ':0', 09:07:36 INFO - 'HOME': '/home/cltbld', 09:07:36 INFO - 'LANG': 'en_US.UTF-8', 09:07:36 INFO - 'LANGUAGE': 'en_US:en', 09:07:36 INFO - 'LOGNAME': 'cltbld', 09:07:36 INFO - 'MAIL': '/var/mail/cltbld', 09:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:36 INFO - 'MOZ_NO_REMOTE': '1', 09:07:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:36 INFO - 'NO_EM_RESTART': '1', 09:07:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:36 INFO - 'PWD': '/builds/slave/test', 09:07:36 INFO - 'SHELL': '/bin/bash', 09:07:36 INFO - 'SHLVL': '1', 09:07:36 INFO - 'TERM': 'linux', 09:07:36 INFO - 'TMOUT': '86400', 09:07:36 INFO - 'USER': 'cltbld', 09:07:36 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353', 09:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:36 INFO - '_': '/tools/buildbot/bin/python'} 09:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:36 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 09:07:36 INFO - Cleaning up... 09:07:36 INFO - Return code: 0 09:07:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:07: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')]} 09:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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')]} 09:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:36 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 0x7fbd9c145f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194a9c0>, '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 0x194b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194bd50>, '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': '20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353', '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 09:07:36 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 09:07:36 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 09:07:36 INFO - Using env: {'DISPLAY': ':0', 09:07:36 INFO - 'HOME': '/home/cltbld', 09:07:36 INFO - 'LANG': 'en_US.UTF-8', 09:07:36 INFO - 'LANGUAGE': 'en_US:en', 09:07:36 INFO - 'LOGNAME': 'cltbld', 09:07:36 INFO - 'MAIL': '/var/mail/cltbld', 09:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:36 INFO - 'MOZ_NO_REMOTE': '1', 09:07:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:36 INFO - 'NO_EM_RESTART': '1', 09:07:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:36 INFO - 'PWD': '/builds/slave/test', 09:07:36 INFO - 'SHELL': '/bin/bash', 09:07:36 INFO - 'SHLVL': '1', 09:07:36 INFO - 'TERM': 'linux', 09:07:36 INFO - 'TMOUT': '86400', 09:07:36 INFO - 'USER': 'cltbld', 09:07:36 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353', 09:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:36 INFO - '_': '/tools/buildbot/bin/python'} 09:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:36 INFO - Downloading/unpacking psutil>=3.1.1 09:07:36 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 09:07:36 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 09:07:36 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 09:07:36 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 09:07:36 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 09:07:36 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 09:07:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:07:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:07:39 INFO - Installing collected packages: psutil 09:07:39 INFO - Running setup.py install for psutil 09:07:39 INFO - building 'psutil._psutil_linux' extension 09:07:39 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 09:07:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:07:41 INFO - building 'psutil._psutil_posix' extension 09:07:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:07:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:07:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:07:41 INFO - Successfully installed psutil 09:07:41 INFO - Cleaning up... 09:07:41 INFO - Return code: 0 09:07:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:07: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')]} 09:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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')]} 09:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:41 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 0x7fbd9c145f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194a9c0>, '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 0x194b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194bd50>, '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': '20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353', '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 09:07:41 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 09:07:41 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 09:07:41 INFO - Using env: {'DISPLAY': ':0', 09:07:41 INFO - 'HOME': '/home/cltbld', 09:07:41 INFO - 'LANG': 'en_US.UTF-8', 09:07:41 INFO - 'LANGUAGE': 'en_US:en', 09:07:41 INFO - 'LOGNAME': 'cltbld', 09:07:41 INFO - 'MAIL': '/var/mail/cltbld', 09:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:41 INFO - 'MOZ_NO_REMOTE': '1', 09:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:41 INFO - 'NO_EM_RESTART': '1', 09:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:41 INFO - 'PWD': '/builds/slave/test', 09:07:41 INFO - 'SHELL': '/bin/bash', 09:07:41 INFO - 'SHLVL': '1', 09:07:41 INFO - 'TERM': 'linux', 09:07:41 INFO - 'TMOUT': '86400', 09:07:41 INFO - 'USER': 'cltbld', 09:07:41 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353', 09:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:41 INFO - '_': '/tools/buildbot/bin/python'} 09:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:07:41 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 09:07:41 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 09:07:41 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 09:07:41 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 09:07:41 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 09:07:41 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 09:07:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:07:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:07:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:07:43 INFO - Installing collected packages: mozsystemmonitor 09:07:43 INFO - Running setup.py install for mozsystemmonitor 09:07:43 INFO - Successfully installed mozsystemmonitor 09:07:43 INFO - Cleaning up... 09:07:43 INFO - Return code: 0 09:07:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:07:43 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')]} 09:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:43 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')]} 09:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:43 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 0x7fbd9c145f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194a9c0>, '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 0x194b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194bd50>, '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': '20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353', '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 09:07:43 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 09:07:43 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 09:07:43 INFO - Using env: {'DISPLAY': ':0', 09:07:43 INFO - 'HOME': '/home/cltbld', 09:07:43 INFO - 'LANG': 'en_US.UTF-8', 09:07:43 INFO - 'LANGUAGE': 'en_US:en', 09:07:43 INFO - 'LOGNAME': 'cltbld', 09:07:43 INFO - 'MAIL': '/var/mail/cltbld', 09:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:43 INFO - 'MOZ_NO_REMOTE': '1', 09:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:43 INFO - 'NO_EM_RESTART': '1', 09:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:43 INFO - 'PWD': '/builds/slave/test', 09:07:43 INFO - 'SHELL': '/bin/bash', 09:07:43 INFO - 'SHLVL': '1', 09:07:43 INFO - 'TERM': 'linux', 09:07:43 INFO - 'TMOUT': '86400', 09:07:43 INFO - 'USER': 'cltbld', 09:07:43 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353', 09:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:43 INFO - '_': '/tools/buildbot/bin/python'} 09:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:43 INFO - Downloading/unpacking blobuploader==1.2.4 09:07:43 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 09:07:43 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 09:07:43 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 09:07:43 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 09:07:43 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 09:07:43 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 09:07:45 INFO - Downloading blobuploader-1.2.4.tar.gz 09:07:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:07:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:07:45 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 09:07:45 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 09:07:45 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 09:07:45 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 09:07:45 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 09:07:45 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 09:07:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:07:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:46 INFO - Downloading docopt-0.6.1.tar.gz 09:07:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:07:46 INFO - Installing collected packages: blobuploader, requests, docopt 09:07:46 INFO - Running setup.py install for blobuploader 09:07:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:07:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:07:46 INFO - Running setup.py install for requests 09:07:47 INFO - Running setup.py install for docopt 09:07:47 INFO - Successfully installed blobuploader requests docopt 09:07:47 INFO - Cleaning up... 09:07:47 INFO - Return code: 0 09:07:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07: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')]} 09:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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')]} 09:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd9c145f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194a9c0>, '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 0x194b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194bd50>, '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': '20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353', '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 09:07:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:07:47 INFO - Using env: {'DISPLAY': ':0', 09:07:47 INFO - 'HOME': '/home/cltbld', 09:07:47 INFO - 'LANG': 'en_US.UTF-8', 09:07:47 INFO - 'LANGUAGE': 'en_US:en', 09:07:47 INFO - 'LOGNAME': 'cltbld', 09:07:47 INFO - 'MAIL': '/var/mail/cltbld', 09:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:47 INFO - 'MOZ_NO_REMOTE': '1', 09:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:47 INFO - 'NO_EM_RESTART': '1', 09:07:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:47 INFO - 'PWD': '/builds/slave/test', 09:07:47 INFO - 'SHELL': '/bin/bash', 09:07:47 INFO - 'SHLVL': '1', 09:07:47 INFO - 'TERM': 'linux', 09:07:47 INFO - 'TMOUT': '86400', 09:07:47 INFO - 'USER': 'cltbld', 09:07:47 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353', 09:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:47 INFO - '_': '/tools/buildbot/bin/python'} 09:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:07:47 INFO - Running setup.py (path:/tmp/pip-UlYyRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:07:47 INFO - Running setup.py (path:/tmp/pip-xVDTVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:07:47 INFO - Running setup.py (path:/tmp/pip-eYskxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:07:47 INFO - Running setup.py (path:/tmp/pip-xs9Lea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:07:47 INFO - Running setup.py (path:/tmp/pip-WbPacD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:07:47 INFO - Running setup.py (path:/tmp/pip-nrFOa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:07:47 INFO - Running setup.py (path:/tmp/pip-45UwBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:07:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:07:47 INFO - Running setup.py (path:/tmp/pip-BQwpSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:07:48 INFO - Running setup.py (path:/tmp/pip-AxLJcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:07:48 INFO - Running setup.py (path:/tmp/pip-dYiGsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:07:48 INFO - Running setup.py (path:/tmp/pip-FcgoAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:07:48 INFO - Running setup.py (path:/tmp/pip-c0BJpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:07:48 INFO - Running setup.py (path:/tmp/pip-R83txF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:07:48 INFO - Running setup.py (path:/tmp/pip-bnmKwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:48 INFO - Running setup.py (path:/tmp/pip-sOFeR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:07:48 INFO - Running setup.py (path:/tmp/pip-qwRMP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:07:48 INFO - Running setup.py (path:/tmp/pip-rPhwqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:07:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:07:48 INFO - Running setup.py install for manifestparser 09:07:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:07:48 INFO - Running setup.py install for mozcrash 09:07:48 INFO - Running setup.py install for mozdebug 09:07:48 INFO - Running setup.py install for mozdevice 09:07:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:07:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:07:49 INFO - Running setup.py install for mozfile 09:07:49 INFO - Running setup.py install for mozhttpd 09:07:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:07:49 INFO - Running setup.py install for mozinfo 09:07:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:07:49 INFO - Running setup.py install for mozInstall 09:07:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:07:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:07:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:07:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:07:49 INFO - Running setup.py install for mozleak 09:07:49 INFO - Running setup.py install for mozlog 09:07:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:07:49 INFO - Running setup.py install for moznetwork 09:07:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:07:49 INFO - Running setup.py install for mozprocess 09:07:49 INFO - Running setup.py install for mozprofile 09:07:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:07:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:07:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:07:50 INFO - Running setup.py install for mozrunner 09:07:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:07:50 INFO - Running setup.py install for mozscreenshot 09:07:50 INFO - Running setup.py install for moztest 09:07:50 INFO - Running setup.py install for mozversion 09:07:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:07:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:07:50 INFO - Cleaning up... 09:07:50 INFO - Return code: 0 09:07:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07:50 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')]} 09:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:50 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')]} 09:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:50 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 0x7fbd9c145f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194a9c0>, '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 0x194b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194bd50>, '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': '20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353', '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 09:07:50 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 09:07:50 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 09:07:50 INFO - Using env: {'DISPLAY': ':0', 09:07:50 INFO - 'HOME': '/home/cltbld', 09:07:50 INFO - 'LANG': 'en_US.UTF-8', 09:07:50 INFO - 'LANGUAGE': 'en_US:en', 09:07:50 INFO - 'LOGNAME': 'cltbld', 09:07:50 INFO - 'MAIL': '/var/mail/cltbld', 09:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:50 INFO - 'MOZ_NO_REMOTE': '1', 09:07:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:50 INFO - 'NO_EM_RESTART': '1', 09:07:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:50 INFO - 'PWD': '/builds/slave/test', 09:07:50 INFO - 'SHELL': '/bin/bash', 09:07:50 INFO - 'SHLVL': '1', 09:07:50 INFO - 'TERM': 'linux', 09:07:50 INFO - 'TMOUT': '86400', 09:07:50 INFO - 'USER': 'cltbld', 09:07:50 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353', 09:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:50 INFO - '_': '/tools/buildbot/bin/python'} 09:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:07:50 INFO - Running setup.py (path:/tmp/pip-6Qkiqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:07:50 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)) 09:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:07:50 INFO - Running setup.py (path:/tmp/pip-Of87FS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:07:50 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)) 09:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:07:50 INFO - Running setup.py (path:/tmp/pip-UygRvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:07:50 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)) 09:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:07:50 INFO - Running setup.py (path:/tmp/pip-O0Zv6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:07:50 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)) 09:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:07:50 INFO - Running setup.py (path:/tmp/pip-nym5MS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:07:51 INFO - Running setup.py (path:/tmp/pip-tNq9tM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:07:51 INFO - Running setup.py (path:/tmp/pip-9PfUcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:07:51 INFO - Running setup.py (path:/tmp/pip-aARZq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:07:51 INFO - Running setup.py (path:/tmp/pip-6HJh3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:07:51 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)) 09:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:07:51 INFO - Running setup.py (path:/tmp/pip-Mti2oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:07:51 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)) 09:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:07:51 INFO - Running setup.py (path:/tmp/pip-DcNLSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:07:51 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)) 09:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:07:51 INFO - Running setup.py (path:/tmp/pip-Fyzc8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:07:51 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)) 09:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:07:51 INFO - Running setup.py (path:/tmp/pip-DZufTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:07:51 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)) 09:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:07:51 INFO - Running setup.py (path:/tmp/pip-IYKNWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:07:51 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)) 09:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:51 INFO - Running setup.py (path:/tmp/pip-MzoSps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:07:51 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)) 09:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:07:51 INFO - Running setup.py (path:/tmp/pip-bjun4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:07:51 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)) 09:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:07:51 INFO - Running setup.py (path:/tmp/pip-IVxiqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:07:51 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)) 09:07:51 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)) 09:07:51 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)) 09:07:51 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)) 09:07:51 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)) 09:07:51 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)) 09:07:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:07:51 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 09:07:51 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 09:07:51 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 09:07:51 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 09:07:51 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 09:07:51 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 09:07:53 INFO - Downloading blessings-1.6.tar.gz 09:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:07:53 INFO - Installing collected packages: blessings 09:07:53 INFO - Running setup.py install for blessings 09:07:54 INFO - Successfully installed blessings 09:07:54 INFO - Cleaning up... 09:07:54 INFO - Return code: 0 09:07:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:07:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:07:54 INFO - Reading from file tmpfile_stdout 09:07:54 INFO - Current package versions: 09:07:54 INFO - argparse == 1.2.1 09:07:54 INFO - blessings == 1.6 09:07:54 INFO - blobuploader == 1.2.4 09:07:54 INFO - docopt == 0.6.1 09:07:54 INFO - manifestparser == 1.1 09:07:54 INFO - mozInstall == 1.12 09:07:54 INFO - mozcrash == 0.17 09:07:54 INFO - mozdebug == 0.1 09:07:54 INFO - mozdevice == 0.48 09:07:54 INFO - mozfile == 1.2 09:07:54 INFO - mozhttpd == 0.7 09:07:54 INFO - mozinfo == 0.9 09:07:54 INFO - mozleak == 0.1 09:07:54 INFO - mozlog == 3.2 09:07:54 INFO - moznetwork == 0.27 09:07:54 INFO - mozprocess == 0.22 09:07:54 INFO - mozprofile == 0.28 09:07:54 INFO - mozrunner == 6.11 09:07:54 INFO - mozscreenshot == 0.1 09:07:54 INFO - mozsystemmonitor == 0.3 09:07:54 INFO - moztest == 0.7 09:07:54 INFO - mozversion == 1.4 09:07:54 INFO - psutil == 3.1.1 09:07:54 INFO - requests == 1.2.3 09:07:54 INFO - wsgiref == 0.1.2 09:07:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:07: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')]} 09:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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')]} 09:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd9c145f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194a9c0>, '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 0x194b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194bd50>, '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': '20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353', '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 09:07:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:07:54 INFO - Using env: {'DISPLAY': ':0', 09:07:54 INFO - 'HOME': '/home/cltbld', 09:07:54 INFO - 'LANG': 'en_US.UTF-8', 09:07:54 INFO - 'LANGUAGE': 'en_US:en', 09:07:54 INFO - 'LOGNAME': 'cltbld', 09:07:54 INFO - 'MAIL': '/var/mail/cltbld', 09:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:54 INFO - 'MOZ_NO_REMOTE': '1', 09:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:54 INFO - 'NO_EM_RESTART': '1', 09:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:54 INFO - 'PWD': '/builds/slave/test', 09:07:54 INFO - 'SHELL': '/bin/bash', 09:07:54 INFO - 'SHLVL': '1', 09:07:54 INFO - 'TERM': 'linux', 09:07:54 INFO - 'TMOUT': '86400', 09:07:54 INFO - 'USER': 'cltbld', 09:07:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353', 09:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:54 INFO - '_': '/tools/buildbot/bin/python'} 09:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:54 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)) 09:07:54 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)) 09:07:54 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)) 09:07:54 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)) 09:07:54 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)) 09:07:54 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)) 09:07:54 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)) 09:07:54 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)) 09:07:54 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)) 09:07:54 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)) 09:07:54 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)) 09:07:54 INFO - Cleaning up... 09:07:54 INFO - Return code: 0 09:07:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:07: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')]} 09:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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')]} 09:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd9c145f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194a9c0>, '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 0x194b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194bd50>, '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': '20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353', '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 09:07: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', 'jsonschema'] in /builds/slave/test/build 09:07: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 jsonschema 09:07:54 INFO - Using env: {'DISPLAY': ':0', 09:07:54 INFO - 'HOME': '/home/cltbld', 09:07:54 INFO - 'LANG': 'en_US.UTF-8', 09:07:54 INFO - 'LANGUAGE': 'en_US:en', 09:07:54 INFO - 'LOGNAME': 'cltbld', 09:07:54 INFO - 'MAIL': '/var/mail/cltbld', 09:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:54 INFO - 'MOZ_NO_REMOTE': '1', 09:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:54 INFO - 'NO_EM_RESTART': '1', 09:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:54 INFO - 'PWD': '/builds/slave/test', 09:07:54 INFO - 'SHELL': '/bin/bash', 09:07:54 INFO - 'SHLVL': '1', 09:07:54 INFO - 'TERM': 'linux', 09:07:54 INFO - 'TMOUT': '86400', 09:07:54 INFO - 'USER': 'cltbld', 09:07:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353', 09:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:54 INFO - '_': '/tools/buildbot/bin/python'} 09:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:54 INFO - Downloading/unpacking jsonschema 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:07:56 INFO - Downloading/unpacking functools32 (from jsonschema) 09:07:56 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 09:07:56 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 09:07:56 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 09:07:56 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 09:07:56 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 09:07:56 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 09:07:56 INFO - Downloading functools32-3.2.3-2.tar.gz 09:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:07:56 INFO - warning: no files found matching '*.txt' 09:07:56 INFO - no previously-included directories found matching 'build' 09:07:56 INFO - no previously-included directories found matching 'dist' 09:07:56 INFO - no previously-included directories found matching '.git*' 09:07:56 INFO - Installing collected packages: jsonschema, functools32 09:07:56 INFO - Running setup.py install for functools32 09:07:57 INFO - warning: no files found matching '*.txt' 09:07:57 INFO - no previously-included directories found matching 'build' 09:07:57 INFO - no previously-included directories found matching 'dist' 09:07:57 INFO - no previously-included directories found matching '.git*' 09:07:57 INFO - Successfully installed jsonschema functools32 09:07:57 INFO - Cleaning up... 09:07:57 INFO - Return code: 0 09:07:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd9c145f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194a9c0>, '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 0x194b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194bd50>, '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': '20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353', '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 09:07:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:07:57 INFO - Using env: {'DISPLAY': ':0', 09:07:57 INFO - 'HOME': '/home/cltbld', 09:07:57 INFO - 'LANG': 'en_US.UTF-8', 09:07:57 INFO - 'LANGUAGE': 'en_US:en', 09:07:57 INFO - 'LOGNAME': 'cltbld', 09:07:57 INFO - 'MAIL': '/var/mail/cltbld', 09:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:57 INFO - 'MOZ_NO_REMOTE': '1', 09:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:57 INFO - 'NO_EM_RESTART': '1', 09:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:57 INFO - 'PWD': '/builds/slave/test', 09:07:57 INFO - 'SHELL': '/bin/bash', 09:07:57 INFO - 'SHLVL': '1', 09:07:57 INFO - 'TERM': 'linux', 09:07:57 INFO - 'TMOUT': '86400', 09:07:57 INFO - 'USER': 'cltbld', 09:07:57 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353', 09:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:57 INFO - '_': '/tools/buildbot/bin/python'} 09:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:57 INFO - Downloading/unpacking flake8 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:07:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:07:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:07:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:07:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:07:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:07:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:07:59 INFO - no previously-included directories found matching 'docs/_build' 09:08:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:08:00 INFO - Running setup.py install for pep8 09:08:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:08:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:08:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:08:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:08:00 INFO - no previously-included directories found matching 'docs/_build' 09:08:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:08:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:08:00 INFO - Cleaning up... 09:08:00 INFO - Return code: 0 09:08:00 INFO - Running post-action listener: _resource_record_post_action 09:08:00 INFO - Running post-action listener: _start_resource_monitoring 09:08:00 INFO - Starting resource monitoring. 09:08:00 INFO - ##### 09:08:00 INFO - ##### Finished create-virtualenv step (success) 09:08:00 INFO - ##### 09:08:00 INFO - ##### 09:08:00 INFO - ##### Running install step. 09:08:00 INFO - ##### 09:08:00 INFO - Running pre-action listener: _resource_record_pre_action 09:08:00 INFO - Running main action method: install 09:08:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:08:00 INFO - Reading from file tmpfile_stdout 09:08:00 INFO - Detecting whether we're running mozinstall >=1.0... 09:08:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:08:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:08:00 INFO - Reading from file tmpfile_stdout 09:08:00 INFO - Output received: 09:08:00 INFO - Usage: mozinstall [options] installer 09:08:00 INFO - Options: 09:08:00 INFO - -h, --help show this help message and exit 09:08:00 INFO - -d DEST, --destination=DEST 09:08:00 INFO - Directory to install application into. [default: 09:08:00 INFO - "/builds/slave/test"] 09:08:00 INFO - --app=APP Application being installed. [default: firefox] 09:08:00 INFO - mkdir: /builds/slave/test/build/application 09:08:00 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'] 09:08:00 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 09:08:16 INFO - Reading from file tmpfile_stdout 09:08:16 INFO - Output received: 09:08:16 INFO - /builds/slave/test/build/application/firefox/firefox 09:08:16 INFO - Running post-action listener: _resource_record_post_action 09:08:16 INFO - ##### 09:08:16 INFO - ##### Finished install step (success) 09:08:16 INFO - ##### 09:08:16 INFO - ##### 09:08:16 INFO - ##### Running run-tests step. 09:08:16 INFO - ##### 09:08:16 INFO - Running pre-action listener: _resource_record_pre_action 09:08:16 INFO - Running main action method: run_tests 09:08:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:08:16 INFO - Python 2.7.3 09:08:16 INFO - Return code: 0 09:08:16 INFO - grabbing minidump binary from tooltool 09:08:16 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')]} 09:08:16 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 0x194a9c0>, '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 0x194b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x194bd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:08:16 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 09:08:16 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 09:08:16 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 09:08:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:08:16 INFO - Return code: 0 09:08:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:08:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:08:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:08:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:08:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:08:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:08:17 INFO - Return code: 0 09:08:17 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:08:17 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:08:17 INFO - Using env: {'DISPLAY': ':0', 09:08:17 INFO - 'HOME': '/home/cltbld', 09:08:17 INFO - 'LANG': 'en_US.UTF-8', 09:08:17 INFO - 'LANGUAGE': 'en_US:en', 09:08:17 INFO - 'LOGNAME': 'cltbld', 09:08:17 INFO - 'MAIL': '/var/mail/cltbld', 09:08:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:08:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:17 INFO - 'MOZ_NO_REMOTE': '1', 09:08:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:08:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:17 INFO - 'NO_EM_RESTART': '1', 09:08:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:17 INFO - 'PWD': '/builds/slave/test', 09:08:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:08:17 INFO - 'SHELL': '/bin/bash', 09:08:17 INFO - 'SHLVL': '1', 09:08:17 INFO - 'TERM': 'linux', 09:08:17 INFO - 'TMOUT': '86400', 09:08:17 INFO - 'USER': 'cltbld', 09:08:17 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353', 09:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:17 INFO - '_': '/tools/buildbot/bin/python'} 09:08:17 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:08:17 INFO - mozversion application_buildid: 20160602074854 09:08:17 INFO - mozversion application_changeset: 0b1b9a827cb00e2051e2df795b1316856d1c190f 09:08:17 INFO - mozversion application_display_name: Nightly 09:08:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:08:17 INFO - mozversion application_name: Firefox 09:08:17 INFO - mozversion application_remotingname: firefox 09:08:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:08:17 INFO - mozversion application_vendor: Mozilla 09:08:17 INFO - mozversion application_version: 49.0a1 09:08:17 INFO - mozversion platform_buildid: 20160602074854 09:08:17 INFO - mozversion platform_changeset: 0b1b9a827cb00e2051e2df795b1316856d1c190f 09:08:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:08:17 INFO - mozversion platform_version: 49.0a1 09:08:17 INFO - using testdate: 1464883697 09:08:17 INFO - actual date: 1464883697 09:08:17 INFO - starting webserver on 'localhost:39159' 09:08:17 INFO - SUITE-START | Running 2 tests 09:08:17 INFO - TEST-START | dromaeo_css 09:08:17 INFO - operating with platform_type : linux_ 09:08:17 INFO - Initialising browser for dromaeo_css test... 09:08:17 INFO - TEST-INFO | started process 3327 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqlcKy8/profile http://localhost:39159/getInfo.html) 09:08:24 INFO - PROCESS | 3327 | __metrics Screen width/height:1600/1200 09:08:24 INFO - PROCESS | 3327 | colorDepth:24 09:08:24 INFO - PROCESS | 3327 | Browser inner width/height: 1024/697 09:08:24 INFO - PROCESS | 3327 | __metrics 09:08:25 ERROR - PROCESS | 3327 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:08:26 INFO - TEST-INFO | 3327: exit 0 09:08:26 INFO - Browser initialized. 09:08:26 INFO - Running cycle 1/1 for dromaeo_css test... 09:08:26 INFO - TEST-INFO | started process 3407 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqlcKy8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:08:37 INFO - PROCESS | 3407 | RSS: Main: 157093888 09:08:37 INFO - PROCESS | 3407 | 09:09:29 INFO - PROCESS | 3407 | 1464883769627 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] 09:11:41 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:39159/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39159/tests/dromaeo/cssquery-ext.html) 09:11:42 INFO - PROCESS | 3407 | RSS: Main: 241881088 09:11:42 INFO - PROCESS | 3407 | 09:14:45 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:39159/tests/dromaeo/cssquery-ext.html (next: http://localhost:39159/tests/dromaeo/cssquery-jquery.html) 09:14:45 INFO - PROCESS | 3407 | RSS: Main: 243097600 09:14:45 INFO - PROCESS | 3407 | 09:17:47 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:39159/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39159/tests/dromaeo/cssquery-mootools.html) 09:17:48 INFO - PROCESS | 3407 | RSS: Main: 247648256 09:17:48 INFO - PROCESS | 3407 | 09:20:50 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:39159/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39159/tests/dromaeo/cssquery-prototype.html) 09:20:51 INFO - PROCESS | 3407 | RSS: Main: 245657600 09:20:51 INFO - PROCESS | 3407 | 09:23:54 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:39159/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39159/tests/dromaeo/cssquery-yui.html) 09:23:55 INFO - PROCESS | 3407 | RSS: Main: 232038400 09:23:55 INFO - PROCESS | 3407 | 09:26:58 INFO - PROCESS | 3407 | Cycle 1(1): loaded http://localhost:39159/tests/dromaeo/cssquery-yui.html (next: http://localhost:39159/tests/dromaeo/cssquery-dojo.html) 09:26:58 INFO - PROCESS | 3407 | RSS: Main: 276467712 09:26:58 INFO - PROCESS | 3407 | 09:26:58 INFO - PROCESS | 3407 | __start_tp_report 09:26:58 INFO - PROCESS | 3407 | _x_x_mozilla_page_load 09:26:58 INFO - PROCESS | 3407 | _x_x_mozilla_page_load_details 09:26:58 INFO - PROCESS | 3407 | |i|pagename|runs| 09:26:58 INFO - PROCESS | 3407 | |0;dojo.html;2693.3132051326907;2705.567109262518;2724.8773805178766;2746.711595282495;2765.7234276572344;4708.0819240248165;4758.785854636541;4785.712857228568;4820.8071677132875;4859.805607775689;4731.266653668678;4764.118638051954;4808.855734327967;4810.759462026894;4839.588634966032;4422.778861056959;4430.26900561407;4445.977770111145;4449.377087207794;4547.818087276505;4446.599806017458;4513.052259025609;4524.886877828048;4561.201789686808;4565.452145742499;4361.43301370823;4457.754823484707;4498.392716983198;4514.706544074641;4520.11857687751;4392.758398288093;4394.846180383671;4413.955860441387;4415.381846541487;4464.352668863029;4372;4433.756143412111;4439.533848945846;4458.821647134111;4478.149151661174;4605.884852878671;4681.297805329194;4717.150912835688;4766.76166191689;4795.664303498756;5090.720010399426;5166.121759300928;5170.043541944715;5233.633645644806;5236.633435659505;5215.739213039333;5229.37247530295;5267.3942496613;5270.39390470097;5271.920921186185;4691.7184968901975;4840.854774356775;4861.465238823726;4903;4907.7546122694075;5182.818601348935;5211.42674305826;5227.60792940531;5288.894222115536;5350.384705758887;5053.519915608012;5058.873528161826;5082.872928176826;5109.284700141983;5110.28456016158;5046;5132.255822905732;5150.175971844487;5163.948360516347;5173.767180476812;5030.622703297267;5082.364704411949;5125.923111153335;5142.922856157161;5211.713355765393;5140.434552199255;5146.485351464824;5151.5878729701535;5154.329937108152;5154.7938082476285;4324.545922678073;4324.589164029412;4325.134973005412;4352.825886964486;4370.497392799869;3726.16161363691;3734.7945862977253;3745.232227393378;3776.811159442017;3778.3387907116144;4445.066536027406;4489.685721999429;4498.1003799239625;4522.683412161117;4524.117797029613;5177.792888284502;5203.635745497854;5206.140986737221;5207.557357624644;5266.97366513165;4326.15639950213;4366.388705581221;4436.733795972252;4487.910241795146;4547.113312903952;4563.634909207255;4617.2612382018715;4633.72197668141;4677.883052923704;4684.367610372624;4795.160846851717;4800.279958006257;4805.951940480621;4813;4857.757112144449;5109.514596113363;5129.076766182123;5139.331886854685;5141.408737995029;5178.119719647593;4696.8590942271785;4739.905201896012;4743.264793956942;4794.376731025084;4797.064572408486;5013.423456302572;5055.1153548128195;5057.6459647824295;5066.290719299374;5108.335916330853;5136.434992150935;5157.510036546522;5168.328117344721;5170.896582068262;5171;4872.853814385574;4929.06347793918;4953.900921981613;4974.626902982219;4984.775685094107;4968.850934471971;4989.800407983786;4995.925061124013;5005.049040682259;5040.36995375578;4901.044296362175;4926.605871530341;4929.507049295042;4940.110780059624;4985.900281994267;4999.975000125121;5032.496750324938;5045.2432135180015;5050.368703912011;5067.46791586878;4956.430010548833;4962.950370496249;4972.328735620789;4978.676386035041;5021.020900924284 09:26:58 INFO - PROCESS | 3407 | |1;ext.html;585.7920438244423;589.4488653109343;589.6845187824515;593.9613925094868;608.6743592178185;28108.578371324445;30601.846990765072;30628.234294142658;43801.342979855246;45840.3123953141;42787.57212427875;43195.35206971898;43263.78368108155;43342.783286083526;43394.56605433945;7634.274743899321;7799.454038217327;7823.921760782377;7829.765107046797;7836.843263134734;7621.314081732643;7686.346660533862;7741.806454838617;7744.883826742604;7746.992890924172;7767.184445633212;7801.648925798324;7803.531788092732;7804.960975195116;7805.960970195141;7751.7674469766;7784.065912090528;7794.259545343183;7795.844083118306;7797.454178207528;7700.730474433424;7783.494072885244;7784.805379865492;7787.143414224431;7787.96106019472;39203.60796392056;39222.803885980386;39604.60395396038;39623.20753584912;39711.80144099261;3039.133846853636;3184.68153184682;3520.3311370839715;3667.9266414671824;3793.279276937373;29836.850815746;29923.401531969455;30083.247918801986;30732;31113.22216944572;3321.368939901411;3488.180277634779;3497.090756403353;3519.0850378901414;3574.1779390740016;199312;266489;267054;267500;268265;32212;55759.72120139373;56192.43807561954;56338.1549276753;56488;32648.510272345935;34681.826590867386;34710.826445867606;34714.30571388558;34715.65284347175;12299;12302.876971230353;12349.32078735678;12353.444095015746;12365.07261955357;11364.772704546029;11421.42892855354;11442.656720298404;11444.885551144549;11454.48454819535;8065.39509536787;8065.435419520577;8098.109207987117;8139.267465927976;8153.633086511121;3138.6704396038544;3148.669389714047;3151.07043422191;3158.289384888428;3198.6321573018936;900.2707806676613;905.8143080668447;980.6273616026007;987.7530617345664;1067.1089640150406;27809.582856257173;29084.854575727408;29097.85451072731;29178.270543236587;29678.703212968026;871.2420194430886;963.9685536476044;1016.4561959351711;1021.3055122516612;1057.6351158850184;14957.70084598302;15131.621709457351;15160;15216.467423640119;15401.768973465407;367395;367634;368698;369515;369816;50956;51407.485925141016;51481.742591287555;51564.74217628888;51578;1080.2168427889874;1193.4032983508246;1237.7957636989795;1263.5640703957304;1264.8482182138018;28812.135635930954;29011.274718132216;29348;29821.701782981894;30117.247068822577;42949.35575966426;43053.13893722171;43196;43211.35182972195;43232.78383608062;295504.13487595407;297092;297184;297863;298306;22473.550528989657;24805.50388992246;25522.489550209262;25768;25860.35349116287;43430;43611.56388436075;43848.56151438445;44647.330290046324;44719;36471.45292820663;36931.81534092312;37604.435933460474;37753.81123094367;37780.811095944344;36553;36884.175694935264;37233.813830930674;37439.81280093582;37768.433473498466;36275;36648.63351366559;36871.815640921624;37472.625273748;37608.623913760515;31575.36849262956;32890.848820291176;33350.16624584405;33439.66560334365;33651.83174084114;25223;25329;25450.872745636152;25546.872265638554;25664.486710265315 09:26:58 INFO - PROCESS | 3407 | |2;jquery.html;371.407604870232;371.9869804556839;373.3652790256564;379.3740328458042;389.2856608124092;15612.609684757886;16645.33418663252;16867.493975180732;17043;17167.484975450727;15703.92148039261;16186.676266474664;16539.83460165398;16724.58188545287;16765.748513772272;4911.189653707143;5089.3638295213095;5095.79616815327;5097.311862898517;5113.335266415361;1496.1023385968385;3701.68535674468;3894.6494815466604;5618.775248990036;5937.346891841894;5934.406559344075;5937.4656280934705;5977.043673012319;5980.940190598082;5983.820485385424;5704.973104841127;5854.29748430189;5873.823785286449;5910.1430292607765;5925.851853703649;3394.728421726256;4909.803607855682;5163.225516172567;5262.578993680497;5274.472552744734;20023.599528009505;20654.896725516428;20694.5861082779;20725.378238652866;20778.376648700563;1939.5054261163314;2107.7786832382685;2490.414752533153;2527.5576774064466;2530.936726581832;6316.336784637593;12423.875761242452;13037.608871733863;13273.672632736649;13683.931580342034;1707.4621494229277;1762.7796525434321;1773.184335205807;1791.3730194431976;1829.067175740382;64000.679996600185;64803.35196648067;65077.67461162664;65337.346626534076;67012;9523.380980236401;9558.378705384128;9903.752406189758;9987.253505285958;10027.749306267402;13627.386767595284;13718.794218086736;13781.655458613413;13795.517156899461;13810;7084.326988936043;7100.964495177491;7333.523320984119;7394.149672787591;7480.812979675552;6641.933580664228;6816.556923799937;6845.349691779273;6933.965330173418;6974.511784175161;6190.473809726133;6242.344553821874;6282.340354262737;6283.08895210192;6306.558540902093;1573.5908663747507;1620.4328485030146;1635.1497221444781;1647.283431707211;1771.4588308171715;718.306833905284;880.6521424037469;906.4697152165925;907.4736652741394;932.9673461428818;15902.284397202153;16839.41062062822;17502.949823010662;17949.910250448665;18438.907805460887;878.547548012774;892.7366426904078;898.5507246376811;906.4380084347747;919.94940278284;9354.859677104849;9553.713388598353;9707.70876873695;9737.56180971858;9862.457564834003;336331;337553;339178;339657;354680;76404.61797690977;76856;76965.6151719249;77355;77488.22511774923;939.5631031570352;943.9858402123974;954.556131398889;963.2534785541121;974.848898420746;15166.848331516543;15406.537803865902;15410;15568.221588920282;15833;32647.34705305833;32920.176995575304;34497.65502344944;34599.65400346065;34923.78336027619;46098.30852537282;48660.270095949294;48727.26909096437;48834.511654884416;49111;7058.153021637437;7145.428365730833;7181.676824542804;7359.963200183965;7470.663820127998;9781.462019588991;11071.391073491035;11164.665060048212;11424.657260282205;11571.594994175164;9366.765830854283;9546.570404331684;9598.376105553116;9674;9807.754806129618;9883.555240014073;10065.798684026426;10112.089911907964;10183.13443357323;10402.063814256753;9722.173615242784;9731.41611503312;9784.266180036384;9963.352382095141;10125.392476451436;7335.266473352622;7382.815429614303;7447.515911465737;7463.477556570988;7540.17058123595;9818.165455936325;9828.459434731158;9853.704388868346;9934.403935763878;9993.900060999587 09:26:58 INFO - PROCESS | 3407 | |3;mootools.html;1236.5733821831477;1416.2918540729638;1433.2260579287183;1555.6810853774978;1753.7807774028254;6496.7401303947845;7217.530860494065;7432.999999999994;7448.106227252737;7636.312731854132;7362.9631851840795;7484.176740558534;7497;7503.737369192079;7508.887366689504;1873.4566975577065;1979.9505012374661;2059.073416962373;2182.683510890924;2217.024509215948;2262.4117729390314;2292.805111565519;2293.1515339324474;2295.391721193885;2297.5060362022164;2196.242296407737;2215.556888622274;2219.0679914435896;2221.9666704999436;2224.63293556563;1785.7589225454528;2075.2529089527757;2080.053575623088;2145.0454547726267;2145.4850835799452;2033.9288124915704;2043.6730123180369;2050.026237537158;2051.917923283067;2054.4042227753935;7205.315495027964;7235.204127545966;7241.384482319009;7249.71001159953;7261.092363454568;4431.889202769924;4537.614302784267;4541.364209010741;4555.40779698637;4557.316402539613;2735.288824905519;2885.75471084958;2910.1124157132067;2910.3451723362073;2920;942.2273735536862;975.6292608808678;992.8609994600762;1005.527402121002;1018.1549314069379;9757.463339516324;9780.657676981342;9802.166815820592;9851.064148905842;9884.258680598983;4062.857799977046;4218.303979843353;4252.48970123581;4253.723507972034;4284.700070995063;8452.154784521621;8492.532910689848;8502.702405415781;8516.1058088901;8519.403641745143;4526.162659907927;4530.546945305443;4530.773461326987;4535.433070866142;4570.634349252052;3602.5857026442295;3943.38877473992;4060.959390406117;4071.491063617048;4137.54487006429;3526.8060256685617;3557.288542291552;3591.9461208081375;3620.4931309616672;3640.508531348287;1118.5637601335486;1120.1598800899326;1120.551779288275;1134.2230572058168;1178.2105988987228;676.2763842688277;838.3125836813877;847.3560094328354;858.5020688000944;863.7840539865034;5002.399712034507;5013.097642424325;5043.167877300278;5056.26684130799;5132.871678208075;416.19466332646425;417.9393987871742;426.40942294921757;431.75008350824186;440.3856620015125;3554.8222588870453;3698.8335524901445;3787.886363409102;3794.392897136445;3807.4479200516325;8971.237444817132;8982.056884027083;9154.81690366189;9163.450192988443;9189.1729744322;9117.270618350516;9117.77205569866;9125.863112053325;9128.863067053999;9132.863007054899;6838.93161068383;6863.210730765826;7018.298170183043;7023.578585284899;7032.824179395556;5060.139776237975;5113.3097031900215;5171.50870667286;5248.422673505835;5281.075811733008;8235.50586964784;8334.20825021622;8378.204070613281;8462.915370846213;8499.660013599387;8477.067522572635;8479.830403392021;8556.529390883561;8613.741587752378;8628.180322869317;5725.885482290248;6208.50331973432;6402.071699603438;6411.743530258924;6547.541672082908;7174.210836808052;7193.388561972291;7223.747168849275;7263.891041634485;7265.854682906206;6403.711832967434;6446.613203207822;6491.415772580302;6708.563943343667;6787.762428314985;6254.405831446005;6322.33615470369;6465.741370345321;6529.281779004401;6542.803715888531;6076.635401875901;6149.2313460817395;6255.624662520263;6262.34245404226;6268.435840774352;4298.63461605767;4343.066240758252;4443.488998765183;4527.139843429738;4535.637149028136;4565.863024109282;4628.213203755302;4631.050634619827;4711.552402521755;4749.738764367855 09:26:58 INFO - PROCESS | 3407 | |4;prototype.html;297.9657339405968;302.42991960155115;303.14210783482747;303.4431817614678;305.8134537931861;4921.261810728392;4927.876803079925;4935.062338155748;4939.160342741738;4939.234418665113;4849.684770489925;4863.392075990501;4867.9026419471675;4890.486498917616;4893.1436998525205;3588.1388466767985;3698.3712768829228;3788.1287303920117;3828.4158193219605;3851.9422208666892;3780.621937806225;3819.9045023874487;3820.8853734387876;3830.731848770587;3835.7698538087666;3789.5073640426845;3802.448644946481;3804.4673745675627;3812.5615554211345;3822.159124992511;3555.471147406614;3666.431703086026;3821.2357528494135;3837.750546214515;3838.2899163654815;3363.697267245935;3386.136535183537;3386.339663765567;3396.2188696599674;3410.6759857813468;4658.417697787777;4669.766511674403;4673.509281525459;4683.250679891235;4691.1555919934735;4247.936280955788;4351.97824010878;4356.695031347807;4368.737875727435;4387.670924680661;5036.143855544567;5049.12200045974;5051.4845546335955;5092.949070509285;5113.002964421939;3678.70570354371;3681.226942342111;3699.4635777812337;3712.3317802795486;3720.479132921393;5105.923411148836;5307.522322990911;5345.412004679482;5367.141257398797;5376.086065368858;3761.8495260189834;3770.7933461292673;3771.981140094282;3778.9433158502643;3790.77255364679;3832.616738326201;3840.8271627776817;3852.114013776847;3854.4411060396087;3861.1119442528375;4350.129974005148;4368.453943257093;4388.253996820548;4389.297712366006;4393.1872603568445;4878.414590249193;5137.152369859006;5167.457416971239;5168.53483186515;5188.688678679291;1279.929603871796;1282.2114399644151;1288.1240756285629;1300.0704496285202;1301.1997621462922;787.8778789287669;811.7321283976273;816.7590560784582;817.2154731457867;818.2349503214514;4431.800568974404;4488.887777805516;4494.977525112419;4497.460304763384;4511.932321015187;5237.319148510745;5245.501677340647;5251.973740131351;5275.103232450492;5317.122674758699;4452;4523.253663145544;4531.909361812745;4537.863864084083;4539.319102134707;2655.933601659974;2794.972050279471;2801.9159425217276;2803.607494950668;2816.2396153038976;4865.9756701216265;4886.780094895738;4899.5590396863745;4908.9263661045115;4942.5304596063315;5284.867878303073;5389.27244821944;5400.756965936543;5442.673439593637;5444.455554444524;4899.608031357483;4915.95084049155;4937.481564435682;4943.184374578154;4948.678335908155;5257.710825904612;5279.419263881046;5287.123071309629;5291.894162116813;5303.204519322133;5056.62075344358;5119.622722572147;5152.613553983541;5173.663711858717;5210.192420174879;4915.18899381598;4938.30863679078;4950.183219768842;4951.603871690184;4951.876203094951;3768.2086761780333;3799.3731034379016;3802.752821066622;3805.2579746949077;3824.9235015300096;5013.674111182761;5205.323307969939;5232.816851410183;5244.269391101004;5265.842024739264;5041.6470847040355;5055.191169412877;5061.822836200862;5064.151584671495;5105.744712764421;5052.292679025013;5076.543111120017;5104.983531505109;5114;5123.769430375568;4758.881027974328;5039.21892106724;5054.747262636927;5055.266986286894;5063.215201643751;4931.778069986787;5061.848144555522;5074.847754567369;5076.1878099505375;5170.37955445349;4887.462379138221;4981.975090124526;5060.49395060491;5065.214891691794;5078.781092537838 09:26:58 INFO - PROCESS | 3407 | |5;yui.html;632.3834261594944;641.080050128066;648.1250312078695;734.328089797835;754.7848863074023;12919.870801291985;13333.53332633358;13692.452301907924;13695.383707733152;13714.93142534286;12452.12835101541;12488.875111248884;12495.43770530326;12511.249325040504;13155.539556115538;801.3268854162502;814.1410811593767;815.8735396013598;816.2939057715064;817.1705718695529;804.8108694456798;812.9390295727815;813.3330668851544;813.7477382011566;813.9715109971153;848.5545088828384;849.4436144325446;850.2432834777053;852.0669866496177;852.1265702654766;836.1972506393869;841.3185319890847;841.5960339037266;841.8821365008904;841.9705310314109;616.7255571270787;616.8211218746558;617.0528239152924;617.253123720299;617.8856911471393;13613.183209007491;13700.246486443242;13752.449902003907;13768.449262029506;13783.655408614764;13389.397477113456;13404.262765547892;13600.357799532852;13611.727765444735;13642;10515.947420262926;10612.78774424515;10622.30954987931;10712.143028557697;10910.945445272802;3360;3363.293708321231;3420.504026916083;3425.2293234022395;3492.388831954423;40052;41422.58577414217;46621.76689116532;48468.51531484675;57121.42878571203;10516.263861529773;10970.122390208764;11022.421169386842;11113.83329250062;11401;18829.34097306615;18898.14958326851;18927.053647317854;18972.620547589246;18988.43034708961;7062.823429414203;7126.750563730245;7178.066851309296;7208.675609597581;7282.308180722823;3830.272248272819;3896.3960586109197;3997.1006523531973;4002.659773919191;4044.1911617676583;3006.9398612028076;3104.9379012419627;3106.720395164401;3108.580341653893;3108.891188808381;508.22495694066845;518.271828081546;527.8310940499003;528.120679069353;535.8853584544139;463.1108272117542;499.72015671224233;500.6145268143582;544.2054600283631;589.2310534752189;7998.64006119726;8070.677172913135;8149.674013039531;8177.443354583169;8366.58167091643;472.715250741394;572.6363759012974;577.1746402644175;581.2908251932636;585.3765739487433;3801.1067399161175;3891.474650922146;3924.50943632046;3945.743526670757;3951.585083566242;84351.15648843556;84967;86673.56663216643;86957.56521217353;89647.55176224076;73763.63118184375;75224.62387688136;75236;77595;78051.60974195093;65001.67499162474;66535.66732166405;66536;66833;67791.66104169546;8054.597270136587;8107.959460202661;8139.715109971123;8164.877526836984;8223.917760822314;29428;29595.40809183847;30758.84620576972;37336.626633733315;40077.59922400739;54587.45412545824;55004;56270.71864640651;56588;56774;11002.50488727993;11074.39090850011;11126.55493780272;11251.549938002388;11356;11457.140714446616;11848.348340840992;12433.93783031079;12439.253644781342;12875.291858947849;11180.385078820744;11517.136214783757;11773.646790596296;12565.371731413576;12566.874331256937;11402.258853174517;11581.478833452345;11902.880971190523;11927;12331.075169362155;11492.482838272465;11804.527818887493;11896.048316134862;11973.341466219441;12340.889319961247;9504.667336643184;9674.177694896012;9699.466529340954;9802.558884850056;10063.295569310078;9486;9898.20814334837;9910.30627856072;9984.650537231453;10034.1972642187 09:26:58 INFO - PROCESS | 3407 | __end_tp_report 09:26:58 INFO - PROCESS | 3407 | __start_cc_report 09:26:58 INFO - PROCESS | 3407 | _x_x_mozilla_cycle_collect,940 09:26:58 INFO - PROCESS | 3407 | __end_cc_report 09:26:58 INFO - PROCESS | 3407 | __startTimestamp1464884818417__endTimestamp 09:26:58 INFO - PROCESS | 3407 | 09:26:58 INFO - PROCESS | 3407 | ------- Summary: start ------- 09:26:58 INFO - PROCESS | 3407 | Number of tests: 6 09:26:58 INFO - PROCESS | 3407 | 09:26:58 INFO - PROCESS | 3407 | [#0] dojo.html Cycles:165 Average:4758.35 Median:4861.47 stddev:496.04 (10.2%) stddev-sans-first:470.37 09:26:58 INFO - PROCESS | 3407 | Values: 2693.3 2705.6 2724.9 2746.7 2765.7 4708.1 4758.8 4785.7 4820.8 4859.8 4731.3 4764.1 4808.9 4810.8 4839.6 4422.8 4430.3 4446.0 4449.4 4547.8 4446.6 4513.1 4524.9 4561.2 4565.5 4361.4 4457.8 4498.4 4514.7 4520.1 4392.8 4394.8 4414.0 4415.4 4464.4 4372.0 4433.8 4439.5 4458.8 4478.1 4605.9 4681.3 4717.2 4766.8 4795.7 5090.7 5166.1 5170.0 5233.6 5236.6 5215.7 5229.4 5267.4 5270.4 5271.9 4691.7 4840.9 4861.5 4903.0 4907.8 5182.8 5211.4 5227.6 5288.9 5350.4 5053.5 5058.9 5082.9 5109.3 5110.3 5046.0 5132.3 5150.2 5163.9 5173.8 5030.6 5082.4 5125.9 5142.9 5211.7 5140.4 5146.5 5151.6 5154.3 5154.8 4324.5 4324.6 4325.1 4352.8 4370.5 3726.2 3734.8 3745.2 3776.8 3778.3 4445.1 4489.7 4498.1 4522.7 4524.1 5177.8 5203.6 5206.1 5207.6 5267.0 4326.2 4366.4 4436.7 4487.9 4547.1 4563.6 4617.3 4633.7 4677.9 4684.4 4795.2 4800.3 4806.0 4813.0 4857.8 5109.5 5129.1 5139.3 5141.4 5178.1 4696.9 4739.9 4743.3 4794.4 4797.1 5013.4 5055.1 5057.6 5066.3 5108.3 5136.4 5157.5 5168.3 5170.9 5171.0 4872.9 4929.1 4953.9 4974.6 4984.8 4968.9 4989.8 4995.9 5005.0 5040.4 4901.0 4926.6 4929.5 4940.1 4985.9 5000.0 5032.5 5045.2 5050.4 5067.5 4956.4 4963.0 4972.3 4978.7 5021.0 09:26:58 INFO - PROCESS | 3407 | 09:26:58 INFO - PROCESS | 3407 | [#1] ext.html Cycles:180 Average:45707.71 Median:185531.46 stddev:81751.19 (44.1%) stddev-sans-first:81910.33 09:26:58 INFO - PROCESS | 3407 | Values: 585.8 589.4 589.7 594.0 608.7 28108.6 30601.8 30628.2 43801.3 45840.3 42787.6 43195.4 43263.8 43342.8 43394.6 7634.3 7799.5 7823.9 7829.8 7836.8 7621.3 7686.3 7741.8 7744.9 7747.0 7767.2 7801.6 7803.5 7805.0 7806.0 7751.8 7784.1 7794.3 7795.8 7797.5 7700.7 7783.5 7784.8 7787.1 7788.0 39203.6 39222.8 39604.6 39623.2 39711.8 3039.1 3184.7 3520.3 3667.9 3793.3 29836.9 29923.4 30083.2 30732.0 31113.2 3321.4 3488.2 3497.1 3519.1 3574.2 199312.0 266489.0 267054.0 267500.0 268265.0 32212.0 55759.7 56192.4 56338.2 56488.0 32648.5 34681.8 34710.8 34714.3 34715.7 12299.0 12302.9 12349.3 12353.4 12365.1 11364.8 11421.4 11442.7 11444.9 11454.5 8065.4 8065.4 8098.1 8139.3 8153.6 3138.7 3148.7 3151.1 3158.3 3198.6 900.3 905.8 980.6 987.8 1067.1 27809.6 29084.9 29097.9 29178.3 29678.7 871.2 964.0 1016.5 1021.3 1057.6 14957.7 15131.6 15160.0 15216.5 15401.8 367395.0 367634.0 368698.0 369515.0 369816.0 50956.0 51407.5 51481.7 51564.7 51578.0 1080.2 1193.4 1237.8 1263.6 1264.8 28812.1 29011.3 29348.0 29821.7 30117.2 42949.4 43053.1 43196.0 43211.4 43232.8 295504.1 297092.0 297184.0 297863.0 298306.0 22473.6 24805.5 25522.5 25768.0 25860.4 43430.0 43611.6 43848.6 44647.3 44719.0 36471.5 36931.8 37604.4 37753.8 37780.8 36553.0 36884.2 37233.8 37439.8 37768.4 36275.0 36648.6 36871.8 37472.6 37608.6 31575.4 32890.8 33350.2 33439.7 33651.8 25223.0 25329.0 25450.9 25546.9 25664.5 09:26:58 INFO - PROCESS | 3407 | 09:26:58 INFO - PROCESS | 3407 | [#2] jquery.html Cycles:180 Average:22708.43 Median:5268.53 stddev:56604.97 (1074.4%) stddev-sans-first:56738.92 09:26:58 INFO - PROCESS | 3407 | Values: 371.4 372.0 373.4 379.4 389.3 15612.6 16645.3 16867.5 17043.0 17167.5 15703.9 16186.7 16539.8 16724.6 16765.7 4911.2 5089.4 5095.8 5097.3 5113.3 1496.1 3701.7 3894.6 5618.8 5937.3 5934.4 5937.5 5977.0 5980.9 5983.8 5705.0 5854.3 5873.8 5910.1 5925.9 3394.7 4909.8 5163.2 5262.6 5274.5 20023.6 20654.9 20694.6 20725.4 20778.4 1939.5 2107.8 2490.4 2527.6 2530.9 6316.3 12423.9 13037.6 13273.7 13683.9 1707.5 1762.8 1773.2 1791.4 1829.1 64000.7 64803.4 65077.7 65337.3 67012.0 9523.4 9558.4 9903.8 9987.3 10027.7 13627.4 13718.8 13781.7 13795.5 13810.0 7084.3 7101.0 7333.5 7394.1 7480.8 6641.9 6816.6 6845.3 6934.0 6974.5 6190.5 6242.3 6282.3 6283.1 6306.6 1573.6 1620.4 1635.1 1647.3 1771.5 718.3 880.7 906.5 907.5 933.0 15902.3 16839.4 17502.9 17949.9 18438.9 878.5 892.7 898.6 906.4 919.9 9354.9 9553.7 9707.7 9737.6 9862.5 336331.0 337553.0 339178.0 339657.0 354680.0 76404.6 76856.0 76965.6 77355.0 77488.2 939.6 944.0 954.6 963.3 974.8 15166.8 15406.5 15410.0 15568.2 15833.0 32647.3 32920.2 34497.7 34599.7 34923.8 46098.3 48660.3 48727.3 48834.5 49111.0 7058.2 7145.4 7181.7 7360.0 7470.7 9781.5 11071.4 11164.7 11424.7 11571.6 9366.8 9546.6 9598.4 9674.0 9807.8 9883.6 10065.8 10112.1 10183.1 10402.1 9722.2 9731.4 9784.3 9963.4 10125.4 7335.3 7382.8 7447.5 7463.5 7540.2 9818.2 9828.5 9853.7 9934.4 9993.9 09:26:58 INFO - PROCESS | 3407 | 09:26:58 INFO - PROCESS | 3407 | [#3] mootools.html Cycles:180 Average:4924.81 Median:5058.20 stddev:2693.48 (53.2%) stddev-sans-first:2686.77 09:26:58 INFO - PROCESS | 3407 | Values: 1236.6 1416.3 1433.2 1555.7 1753.8 6496.7 7217.5 7433.0 7448.1 7636.3 7363.0 7484.2 7497.0 7503.7 7508.9 1873.5 1980.0 2059.1 2182.7 2217.0 2262.4 2292.8 2293.2 2295.4 2297.5 2196.2 2215.6 2219.1 2222.0 2224.6 1785.8 2075.3 2080.1 2145.0 2145.5 2033.9 2043.7 2050.0 2051.9 2054.4 7205.3 7235.2 7241.4 7249.7 7261.1 4431.9 4537.6 4541.4 4555.4 4557.3 2735.3 2885.8 2910.1 2910.3 2920.0 942.2 975.6 992.9 1005.5 1018.2 9757.5 9780.7 9802.2 9851.1 9884.3 4062.9 4218.3 4252.5 4253.7 4284.7 8452.2 8492.5 8502.7 8516.1 8519.4 4526.2 4530.5 4530.8 4535.4 4570.6 3602.6 3943.4 4061.0 4071.5 4137.5 3526.8 3557.3 3591.9 3620.5 3640.5 1118.6 1120.2 1120.6 1134.2 1178.2 676.3 838.3 847.4 858.5 863.8 5002.4 5013.1 5043.2 5056.3 5132.9 416.2 417.9 426.4 431.8 440.4 3554.8 3698.8 3787.9 3794.4 3807.4 8971.2 8982.1 9154.8 9163.5 9189.2 9117.3 9117.8 9125.9 9128.9 9132.9 6838.9 6863.2 7018.3 7023.6 7032.8 5060.1 5113.3 5171.5 5248.4 5281.1 8235.5 8334.2 8378.2 8462.9 8499.7 8477.1 8479.8 8556.5 8613.7 8628.2 5725.9 6208.5 6402.1 6411.7 6547.5 7174.2 7193.4 7223.7 7263.9 7265.9 6403.7 6446.6 6491.4 6708.6 6787.8 6254.4 6322.3 6465.7 6529.3 6542.8 6076.6 6149.2 6255.6 6262.3 6268.4 4298.6 4343.1 4443.5 4527.1 4535.6 4565.9 4628.2 4631.1 4711.6 4749.7 09:26:58 INFO - PROCESS | 3407 | 09:26:58 INFO - PROCESS | 3407 | [#4] prototype.html Cycles:180 Average:4243.51 Median:4882.60 stddev:1231.56 (25.2%) stddev-sans-first:1198.88 09:26:58 INFO - PROCESS | 3407 | Values: 298.0 302.4 303.1 303.4 305.8 4921.3 4927.9 4935.1 4939.2 4939.2 4849.7 4863.4 4867.9 4890.5 4893.1 3588.1 3698.4 3788.1 3828.4 3851.9 3780.6 3819.9 3820.9 3830.7 3835.8 3789.5 3802.4 3804.5 3812.6 3822.2 3555.5 3666.4 3821.2 3837.8 3838.3 3363.7 3386.1 3386.3 3396.2 3410.7 4658.4 4669.8 4673.5 4683.3 4691.2 4247.9 4352.0 4356.7 4368.7 4387.7 5036.1 5049.1 5051.5 5092.9 5113.0 3678.7 3681.2 3699.5 3712.3 3720.5 5105.9 5307.5 5345.4 5367.1 5376.1 3761.8 3770.8 3772.0 3778.9 3790.8 3832.6 3840.8 3852.1 3854.4 3861.1 4350.1 4368.5 4388.3 4389.3 4393.2 4878.4 5137.2 5167.5 5168.5 5188.7 1279.9 1282.2 1288.1 1300.1 1301.2 787.9 811.7 816.8 817.2 818.2 4431.8 4488.9 4495.0 4497.5 4511.9 5237.3 5245.5 5252.0 5275.1 5317.1 4452.0 4523.3 4531.9 4537.9 4539.3 2655.9 2795.0 2801.9 2803.6 2816.2 4866.0 4886.8 4899.6 4908.9 4942.5 5284.9 5389.3 5400.8 5442.7 5444.5 4899.6 4916.0 4937.5 4943.2 4948.7 5257.7 5279.4 5287.1 5291.9 5303.2 5056.6 5119.6 5152.6 5173.7 5210.2 4915.2 4938.3 4950.2 4951.6 4951.9 3768.2 3799.4 3802.8 3805.3 3824.9 5013.7 5205.3 5232.8 5244.3 5265.8 5041.6 5055.2 5061.8 5064.2 5105.7 5052.3 5076.5 5105.0 5114.0 5123.8 4758.9 5039.2 5054.7 5055.3 5063.2 4931.8 5061.8 5074.8 5076.2 5170.4 4887.5 4982.0 5060.5 5065.2 5078.8 09:26:58 INFO - PROCESS | 3407 | 09:26:58 INFO - PROCESS | 3407 | [#5] yui.html Cycles:180 Average:16157.58 Median:23547.24 stddev:21924.53 (93.1%) stddev-sans-first:21955.04 09:26:58 INFO - PROCESS | 3407 | Values: 632.4 641.1 648.1 734.3 754.8 12919.9 13333.5 13692.5 13695.4 13714.9 12452.1 12488.9 12495.4 12511.2 13155.5 801.3 814.1 815.9 816.3 817.2 804.8 812.9 813.3 813.7 814.0 848.6 849.4 850.2 852.1 852.1 836.2 841.3 841.6 841.9 842.0 616.7 616.8 617.1 617.3 617.9 13613.2 13700.2 13752.4 13768.4 13783.7 13389.4 13404.3 13600.4 13611.7 13642.0 10515.9 10612.8 10622.3 10712.1 10910.9 3360.0 3363.3 3420.5 3425.2 3492.4 40052.0 41422.6 46621.8 48468.5 57121.4 10516.3 10970.1 11022.4 11113.8 11401.0 18829.3 18898.1 18927.1 18972.6 18988.4 7062.8 7126.8 7178.1 7208.7 7282.3 3830.3 3896.4 3997.1 4002.7 4044.2 3006.9 3104.9 3106.7 3108.6 3108.9 508.2 518.3 527.8 528.1 535.9 463.1 499.7 500.6 544.2 589.2 7998.6 8070.7 8149.7 8177.4 8366.6 472.7 572.6 577.2 581.3 585.4 3801.1 3891.5 3924.5 3945.7 3951.6 84351.2 84967.0 86673.6 86957.6 89647.6 73763.6 75224.6 75236.0 77595.0 78051.6 65001.7 66535.7 66536.0 66833.0 67791.7 8054.6 8108.0 8139.7 8164.9 8223.9 29428.0 29595.4 30758.8 37336.6 40077.6 54587.5 55004.0 56270.7 56588.0 56774.0 11002.5 11074.4 11126.6 11251.5 11356.0 11457.1 11848.3 12433.9 12439.3 12875.3 11180.4 11517.1 11773.6 12565.4 12566.9 11402.3 11581.5 11902.9 11927.0 12331.1 11492.5 11804.5 11896.0 11973.3 12340.9 9504.7 9674.2 9699.5 9802.6 10063.3 9486.0 9898.2 9910.3 9984.7 10034.2 09:26:58 INFO - PROCESS | 3407 | -------- Summary: end -------- 09:26:58 INFO - PROCESS | 3407 | 09:26:59 INFO - TEST-INFO | 3407: exit 0 09:26:59 INFO - TEST-OK | dromaeo_css | took 1121469ms 09:26:59 INFO - TEST-START | kraken 09:26:59 INFO - operating with platform_type : linux_ 09:26:59 INFO - Initialising browser for kraken test... 09:26:59 INFO - TEST-INFO | started process 3585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGhnJ5s/profile http://localhost:39159/getInfo.html) 09:27:03 INFO - PROCESS | 3585 | __metrics Screen width/height:1600/1200 09:27:03 INFO - PROCESS | 3585 | colorDepth:24 09:27:03 INFO - PROCESS | 3585 | Browser inner width/height: 1024/697 09:27:03 INFO - PROCESS | 3585 | __metrics 09:27:04 ERROR - PROCESS | 3585 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:27:05 INFO - TEST-INFO | 3585: exit 0 09:27:05 INFO - Browser initialized. 09:27:05 INFO - Running cycle 1/1 for kraken test... 09:27:05 INFO - TEST-INFO | started process 3669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGhnJ5s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:27:17 INFO - PROCESS | 3669 | RSS: Main: 157859840 09:27:17 INFO - PROCESS | 3669 | 09:27:19 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:39159/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39159/tests/kraken/driver.html?testName=audio-beat-detection) 09:27:20 INFO - PROCESS | 3669 | RSS: Main: 214777856 09:27:20 INFO - PROCESS | 3669 | 09:27:23 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:39159/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39159/tests/kraken/driver.html?testName=audio-dft) 09:27:24 INFO - PROCESS | 3669 | RSS: Main: 203812864 09:27:24 INFO - PROCESS | 3669 | 09:27:27 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:39159/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39159/tests/kraken/driver.html?testName=audio-fft) 09:27:28 INFO - PROCESS | 3669 | RSS: Main: 269377536 09:27:28 INFO - PROCESS | 3669 | 09:27:30 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:39159/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39159/tests/kraken/driver.html?testName=audio-oscillator) 09:27:30 INFO - PROCESS | 3669 | RSS: Main: 180072448 09:27:30 INFO - PROCESS | 3669 | 09:27:33 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:39159/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39159/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:27:33 INFO - PROCESS | 3669 | RSS: Main: 184279040 09:27:33 INFO - PROCESS | 3669 | 09:27:36 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:39159/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39159/tests/kraken/driver.html?testName=imaging-darkroom) 09:27:37 INFO - PROCESS | 3669 | RSS: Main: 220020736 09:27:37 INFO - PROCESS | 3669 | 09:27:41 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:39159/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39159/tests/kraken/driver.html?testName=imaging-desaturate) 09:27:41 INFO - PROCESS | 3669 | RSS: Main: 216461312 09:27:41 INFO - PROCESS | 3669 | 09:27:44 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:39159/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39159/tests/kraken/driver.html?testName=json-parse-financial) 09:27:45 INFO - PROCESS | 3669 | RSS: Main: 219213824 09:27:45 INFO - PROCESS | 3669 | 09:27:46 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:39159/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39159/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:27:47 INFO - PROCESS | 3669 | RSS: Main: 208162816 09:27:47 INFO - PROCESS | 3669 | 09:27:49 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:39159/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39159/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:27:49 INFO - PROCESS | 3669 | RSS: Main: 211587072 09:27:49 INFO - PROCESS | 3669 | 09:27:52 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:39159/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39159/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:27:52 INFO - PROCESS | 3669 | RSS: Main: 216698880 09:27:52 INFO - PROCESS | 3669 | 09:27:55 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:39159/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39159/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:27:56 INFO - PROCESS | 3669 | RSS: Main: 224157696 09:27:56 INFO - PROCESS | 3669 | 09:27:59 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:39159/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39159/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:27:59 INFO - PROCESS | 3669 | RSS: Main: 225595392 09:27:59 INFO - PROCESS | 3669 | 09:28:01 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:39159/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39159/tests/kraken/driver.html?testName=ai-astar) 09:28:01 INFO - PROCESS | 3669 | RSS: Main: 267431936 09:28:01 INFO - PROCESS | 3669 | 09:28:01 INFO - PROCESS | 3669 | __start_tp_report 09:28:01 INFO - PROCESS | 3669 | _x_x_mozilla_page_load 09:28:01 INFO - PROCESS | 3669 | _x_x_mozilla_page_load_details 09:28:01 INFO - PROCESS | 3669 | |i|pagename|runs| 09:28:01 INFO - PROCESS | 3669 | |0;ai-astar;115;111;115;116;114;114;116;114;113;114 09:28:01 INFO - PROCESS | 3669 | |1;audio-beat-detection;172;129;137;182;130;162;162;132;196;129 09:28:01 INFO - PROCESS | 3669 | |2;audio-dft;163;163;159;162;161;160;161;162;161;161 09:28:01 INFO - PROCESS | 3669 | |3;audio-fft;77;76;75;119;75;76;76;76;97;74 09:28:01 INFO - PROCESS | 3669 | |4;audio-oscillator;86;85;116;84;86;84;116;84;86;124 09:28:01 INFO - PROCESS | 3669 | |5;imaging-gaussian-blur;117;116;117;117;118;117;116;117;118;116 09:28:01 INFO - PROCESS | 3669 | |6;imaging-darkroom;146;146;147;146;145;146;147;146;145;145 09:28:01 INFO - PROCESS | 3669 | |7;imaging-desaturate;94;95;95;95;95;96;94;95;94;94 09:28:01 INFO - PROCESS | 3669 | |8;json-parse-financial;63;64;66;64;64;65;63;64;64;65 09:28:01 INFO - PROCESS | 3669 | |9;json-stringify-tinderbox;64;65;64;64;64;65;64;64;64;64 09:28:01 INFO - PROCESS | 3669 | |10;stanford-crypto-aes;83;87;86;89;90;85;84;87;115;86 09:28:01 INFO - PROCESS | 3669 | |11;stanford-crypto-ccm;134;143;141;140;133;147;135;134;156;135 09:28:01 INFO - PROCESS | 3669 | |12;stanford-crypto-pbkdf2;169;170;171;172;172;170;172;181;174;169 09:28:01 INFO - PROCESS | 3669 | |13;stanford-crypto-sha256-iterative;67;66;69;69;66;66;67;67;71;72 09:28:01 INFO - PROCESS | 3669 | __end_tp_report 09:28:01 INFO - PROCESS | 3669 | __start_cc_report 09:28:01 INFO - PROCESS | 3669 | _x_x_mozilla_cycle_collect,1867 09:28:01 INFO - PROCESS | 3669 | __end_cc_report 09:28:01 INFO - PROCESS | 3669 | __startTimestamp1464884881897__endTimestamp 09:28:01 INFO - PROCESS | 3669 | 09:28:01 INFO - PROCESS | 3669 | ------- Summary: start ------- 09:28:01 INFO - PROCESS | 3669 | Number of tests: 14 09:28:01 INFO - PROCESS | 3669 | 09:28:01 INFO - PROCESS | 3669 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.50 stddev:1.48 (1.3%) stddev-sans-first:1.54 09:28:01 INFO - PROCESS | 3669 | Values: 115.0 111.0 115.0 116.0 114.0 114.0 116.0 114.0 113.0 114.0 09:28:01 INFO - PROCESS | 3669 | 09:28:01 INFO - PROCESS | 3669 | [#1] audio-beat-detection Cycles:10 Average:153.10 Median:162.00 stddev:24.92 (15.4%) stddev-sans-first:25.48 09:28:01 INFO - PROCESS | 3669 | Values: 172.0 129.0 137.0 182.0 130.0 162.0 162.0 132.0 196.0 129.0 09:28:01 INFO - PROCESS | 3669 | 09:28:01 INFO - PROCESS | 3669 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.17 09:28:01 INFO - PROCESS | 3669 | Values: 163.0 163.0 159.0 162.0 161.0 160.0 161.0 162.0 161.0 161.0 09:28:01 INFO - PROCESS | 3669 | 09:28:01 INFO - PROCESS | 3669 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:14.62 (19.2%) stddev-sans-first:15.39 09:28:01 INFO - PROCESS | 3669 | Values: 77.0 76.0 75.0 119.0 75.0 76.0 76.0 76.0 97.0 74.0 09:28:01 INFO - PROCESS | 3669 | 09:28:01 INFO - PROCESS | 3669 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:84.50 stddev:16.43 (19.4%) stddev-sans-first:17.09 09:28:01 INFO - PROCESS | 3669 | Values: 86.0 85.0 116.0 84.0 86.0 84.0 116.0 84.0 86.0 124.0 09:28:01 INFO - PROCESS | 3669 | 09:28:01 INFO - PROCESS | 3669 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 09:28:01 INFO - PROCESS | 3669 | Values: 117.0 116.0 117.0 117.0 118.0 117.0 116.0 117.0 118.0 116.0 09:28:01 INFO - PROCESS | 3669 | 09:28:01 INFO - PROCESS | 3669 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 09:28:01 INFO - PROCESS | 3669 | Values: 146.0 146.0 147.0 146.0 145.0 146.0 147.0 146.0 145.0 145.0 09:28:01 INFO - PROCESS | 3669 | 09:28:01 INFO - PROCESS | 3669 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 09:28:01 INFO - PROCESS | 3669 | Values: 94.0 95.0 95.0 95.0 95.0 96.0 94.0 95.0 94.0 94.0 09:28:01 INFO - PROCESS | 3669 | 09:28:01 INFO - PROCESS | 3669 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 09:28:01 INFO - PROCESS | 3669 | Values: 63.0 64.0 66.0 64.0 64.0 65.0 63.0 64.0 64.0 65.0 09:28:01 INFO - PROCESS | 3669 | 09:28:01 INFO - PROCESS | 3669 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 09:28:01 INFO - PROCESS | 3669 | Values: 64.0 65.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 09:28:01 INFO - PROCESS | 3669 | 09:28:01 INFO - PROCESS | 3669 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:86.50 stddev:9.31 (10.8%) stddev-sans-first:9.60 09:28:01 INFO - PROCESS | 3669 | Values: 83.0 87.0 86.0 89.0 90.0 85.0 84.0 87.0 115.0 86.0 09:28:01 INFO - PROCESS | 3669 | 09:28:01 INFO - PROCESS | 3669 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:140.50 stddev:7.35 (5.2%) stddev-sans-first:7.49 09:28:01 INFO - PROCESS | 3669 | Values: 134.0 143.0 141.0 140.0 133.0 147.0 135.0 134.0 156.0 135.0 09:28:01 INFO - PROCESS | 3669 | 09:28:01 INFO - PROCESS | 3669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:172.00 stddev:3.53 (2.1%) stddev-sans-first:3.57 09:28:01 INFO - PROCESS | 3669 | Values: 169.0 170.0 171.0 172.0 172.0 170.0 172.0 181.0 174.0 169.0 09:28:01 INFO - PROCESS | 3669 | 09:28:01 INFO - PROCESS | 3669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:2.16 (3.2%) stddev-sans-first:2.26 09:28:01 INFO - PROCESS | 3669 | Values: 67.0 66.0 69.0 69.0 66.0 66.0 67.0 67.0 71.0 72.0 09:28:01 INFO - PROCESS | 3669 | -------- Summary: end -------- 09:28:01 INFO - PROCESS | 3669 | 09:28:02 INFO - TEST-INFO | 3669: exit 0 09:28:02 INFO - TEST-OK | kraken | took 63811ms 09:28:02 INFO - SUITE-END | took 1185s 09:28:03 INFO - Completed test suite (00:19:45) 09:28:03 INFO - javascript benchmark 09:28:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2693.3132051326907, 2705.567109262518, 2724.8773805178766, 2746.711595282495, 2765.7234276572344, 4708.0819240248165, 4758.785854636541, 4785.712857228568, 4820.8071677132875, 4859.805607775689, 4731.266653668678, 4764.118638051954, 4808.855734327967, 4810.759462026894, 4839.588634966032, 4422.778861056959, 4430.26900561407, 4445.977770111145, 4449.377087207794, 4547.818087276505, 4446.599806017458, 4513.052259025609, 4524.886877828048, 4561.201789686808, 4565.452145742499, 4361.43301370823, 4457.754823484707, 4498.392716983198, 4514.706544074641, 4520.11857687751, 4392.758398288093, 4394.846180383671, 4413.955860441387, 4415.381846541487, 4464.352668863029, 4372.0, 4433.756143412111, 4439.533848945846, 4458.821647134111, 4478.149151661174, 4605.884852878671, 4681.297805329194, 4717.150912835688, 4766.76166191689, 4795.664303498756, 5090.720010399426, 5166.121759300928, 5170.043541944715, 5233.633645644806, 5236.633435659505, 5215.739213039333, 5229.37247530295, 5267.3942496613, 5270.39390470097, 5271.920921186185, 4691.7184968901975, 4840.854774356775, 4861.465238823726, 4903.0, 4907.7546122694075, 5182.818601348935, 5211.42674305826, 5227.60792940531, 5288.894222115536, 5350.384705758887, 5053.519915608012, 5058.873528161826, 5082.872928176826, 5109.284700141983, 5110.28456016158, 5046.0, 5132.255822905732, 5150.175971844487, 5163.948360516347, 5173.767180476812, 5030.622703297267, 5082.364704411949, 5125.923111153335, 5142.922856157161, 5211.713355765393, 5140.434552199255, 5146.485351464824, 5151.5878729701535, 5154.329937108152, 5154.7938082476285, 4324.545922678073, 4324.589164029412, 4325.134973005412, 4352.825886964486, 4370.497392799869, 3726.16161363691, 3734.7945862977253, 3745.232227393378, 3776.811159442017, 3778.3387907116144, 4445.066536027406, 4489.685721999429, 4498.1003799239625, 4522.683412161117, 4524.117797029613, 5177.792888284502, 5203.635745497854, 5206.140986737221, 5207.557357624644, 5266.97366513165, 4326.15639950213, 4366.388705581221, 4436.733795972252, 4487.910241795146, 4547.113312903952, 4563.634909207255, 4617.2612382018715, 4633.72197668141, 4677.883052923704, 4684.367610372624, 4795.160846851717, 4800.279958006257, 4805.951940480621, 4813.0, 4857.757112144449, 5109.514596113363, 5129.076766182123, 5139.331886854685, 5141.408737995029, 5178.119719647593, 4696.8590942271785, 4739.905201896012, 4743.264793956942, 4794.376731025084, 4797.064572408486, 5013.423456302572, 5055.1153548128195, 5057.6459647824295, 5066.290719299374, 5108.335916330853, 5136.434992150935, 5157.510036546522, 5168.328117344721, 5170.896582068262, 5171.0, 4872.853814385574, 4929.06347793918, 4953.900921981613, 4974.626902982219, 4984.775685094107, 4968.850934471971, 4989.800407983786, 4995.925061124013, 5005.049040682259, 5040.36995375578, 4901.044296362175, 4926.605871530341, 4929.507049295042, 4940.110780059624, 4985.900281994267, 4999.975000125121, 5032.496750324938, 5045.2432135180015, 5050.368703912011, 5067.46791586878, 4956.430010548833, 4962.950370496249, 4972.328735620789, 4978.676386035041, 5021.020900924284], "value": 4727.039904142055, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.7920438244423, 589.4488653109343, 589.6845187824515, 593.9613925094868, 608.6743592178185, 28108.578371324445, 30601.846990765072, 30628.234294142658, 43801.342979855246, 45840.3123953141, 42787.57212427875, 43195.35206971898, 43263.78368108155, 43342.783286083526, 43394.56605433945, 7634.274743899321, 7799.454038217327, 7823.921760782377, 7829.765107046797, 7836.843263134734, 7621.314081732643, 7686.346660533862, 7741.806454838617, 7744.883826742604, 7746.992890924172, 7767.184445633212, 7801.648925798324, 7803.531788092732, 7804.960975195116, 7805.960970195141, 7751.7674469766, 7784.065912090528, 7794.259545343183, 7795.844083118306, 7797.454178207528, 7700.730474433424, 7783.494072885244, 7784.805379865492, 7787.143414224431, 7787.96106019472, 39203.60796392056, 39222.803885980386, 39604.60395396038, 39623.20753584912, 39711.80144099261, 3039.133846853636, 3184.68153184682, 3520.3311370839715, 3667.9266414671824, 3793.279276937373, 29836.850815746, 29923.401531969455, 30083.247918801986, 30732.0, 31113.22216944572, 3321.368939901411, 3488.180277634779, 3497.090756403353, 3519.0850378901414, 3574.1779390740016, 199312.0, 266489.0, 267054.0, 267500.0, 268265.0, 32212.0, 55759.72120139373, 56192.43807561954, 56338.1549276753, 56488.0, 32648.510272345935, 34681.826590867386, 34710.826445867606, 34714.30571388558, 34715.65284347175, 12299.0, 12302.876971230353, 12349.32078735678, 12353.444095015746, 12365.07261955357, 11364.772704546029, 11421.42892855354, 11442.656720298404, 11444.885551144549, 11454.48454819535, 8065.39509536787, 8065.435419520577, 8098.109207987117, 8139.267465927976, 8153.633086511121, 3138.6704396038544, 3148.669389714047, 3151.07043422191, 3158.289384888428, 3198.6321573018936, 900.2707806676613, 905.8143080668447, 980.6273616026007, 987.7530617345664, 1067.1089640150406, 27809.582856257173, 29084.854575727408, 29097.85451072731, 29178.270543236587, 29678.703212968026, 871.2420194430886, 963.9685536476044, 1016.4561959351711, 1021.3055122516612, 1057.6351158850184, 14957.70084598302, 15131.621709457351, 15160.0, 15216.467423640119, 15401.768973465407, 367395.0, 367634.0, 368698.0, 369515.0, 369816.0, 50956.0, 51407.485925141016, 51481.742591287555, 51564.74217628888, 51578.0, 1080.2168427889874, 1193.4032983508246, 1237.7957636989795, 1263.5640703957304, 1264.8482182138018, 28812.135635930954, 29011.274718132216, 29348.0, 29821.701782981894, 30117.247068822577, 42949.35575966426, 43053.13893722171, 43196.0, 43211.35182972195, 43232.78383608062, 295504.13487595407, 297092.0, 297184.0, 297863.0, 298306.0, 22473.550528989657, 24805.50388992246, 25522.489550209262, 25768.0, 25860.35349116287, 43430.0, 43611.56388436075, 43848.56151438445, 44647.330290046324, 44719.0, 36471.45292820663, 36931.81534092312, 37604.435933460474, 37753.81123094367, 37780.811095944344, 36553.0, 36884.175694935264, 37233.813830930674, 37439.81280093582, 37768.433473498466, 36275.0, 36648.63351366559, 36871.815640921624, 37472.625273748, 37608.623913760515, 31575.36849262956, 32890.848820291176, 33350.16624584405, 33439.66560334365, 33651.83174084114, 25223.0, 25329.0, 25450.872745636152, 25546.872265638554, 25664.486710265315], "value": 16695.52468355773, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.407604870232, 371.9869804556839, 373.3652790256564, 379.3740328458042, 389.2856608124092, 15612.609684757886, 16645.33418663252, 16867.493975180732, 17043.0, 17167.484975450727, 15703.92148039261, 16186.676266474664, 16539.83460165398, 16724.58188545287, 16765.748513772272, 4911.189653707143, 5089.3638295213095, 5095.79616815327, 5097.311862898517, 5113.335266415361, 1496.1023385968385, 3701.68535674468, 3894.6494815466604, 5618.775248990036, 5937.346891841894, 5934.406559344075, 5937.4656280934705, 5977.043673012319, 5980.940190598082, 5983.820485385424, 5704.973104841127, 5854.29748430189, 5873.823785286449, 5910.1430292607765, 5925.851853703649, 3394.728421726256, 4909.803607855682, 5163.225516172567, 5262.578993680497, 5274.472552744734, 20023.599528009505, 20654.896725516428, 20694.5861082779, 20725.378238652866, 20778.376648700563, 1939.5054261163314, 2107.7786832382685, 2490.414752533153, 2527.5576774064466, 2530.936726581832, 6316.336784637593, 12423.875761242452, 13037.608871733863, 13273.672632736649, 13683.931580342034, 1707.4621494229277, 1762.7796525434321, 1773.184335205807, 1791.3730194431976, 1829.067175740382, 64000.679996600185, 64803.35196648067, 65077.67461162664, 65337.346626534076, 67012.0, 9523.380980236401, 9558.378705384128, 9903.752406189758, 9987.253505285958, 10027.749306267402, 13627.386767595284, 13718.794218086736, 13781.655458613413, 13795.517156899461, 13810.0, 7084.326988936043, 7100.964495177491, 7333.523320984119, 7394.149672787591, 7480.812979675552, 6641.933580664228, 6816.556923799937, 6845.349691779273, 6933.965330173418, 6974.511784175161, 6190.473809726133, 6242.344553821874, 6282.340354262737, 6283.08895210192, 6306.558540902093, 1573.5908663747507, 1620.4328485030146, 1635.1497221444781, 1647.283431707211, 1771.4588308171715, 718.306833905284, 880.6521424037469, 906.4697152165925, 907.4736652741394, 932.9673461428818, 15902.284397202153, 16839.41062062822, 17502.949823010662, 17949.910250448665, 18438.907805460887, 878.547548012774, 892.7366426904078, 898.5507246376811, 906.4380084347747, 919.94940278284, 9354.859677104849, 9553.713388598353, 9707.70876873695, 9737.56180971858, 9862.457564834003, 336331.0, 337553.0, 339178.0, 339657.0, 354680.0, 76404.61797690977, 76856.0, 76965.6151719249, 77355.0, 77488.22511774923, 939.5631031570352, 943.9858402123974, 954.556131398889, 963.2534785541121, 974.848898420746, 15166.848331516543, 15406.537803865902, 15410.0, 15568.221588920282, 15833.0, 32647.34705305833, 32920.176995575304, 34497.65502344944, 34599.65400346065, 34923.78336027619, 46098.30852537282, 48660.270095949294, 48727.26909096437, 48834.511654884416, 49111.0, 7058.153021637437, 7145.428365730833, 7181.676824542804, 7359.963200183965, 7470.663820127998, 9781.462019588991, 11071.391073491035, 11164.665060048212, 11424.657260282205, 11571.594994175164, 9366.765830854283, 9546.570404331684, 9598.376105553116, 9674.0, 9807.754806129618, 9883.555240014073, 10065.798684026426, 10112.089911907964, 10183.13443357323, 10402.063814256753, 9722.173615242784, 9731.41611503312, 9784.266180036384, 9963.352382095141, 10125.392476451436, 7335.266473352622, 7382.815429614303, 7447.515911465737, 7463.477556570988, 7540.17058123595, 9818.165455936325, 9828.459434731158, 9853.704388868346, 9934.403935763878, 9993.900060999587], "value": 8191.866773772119, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1236.5733821831477, 1416.2918540729638, 1433.2260579287183, 1555.6810853774978, 1753.7807774028254, 6496.7401303947845, 7217.530860494065, 7432.999999999994, 7448.106227252737, 7636.312731854132, 7362.9631851840795, 7484.176740558534, 7497.0, 7503.737369192079, 7508.887366689504, 1873.4566975577065, 1979.9505012374661, 2059.073416962373, 2182.683510890924, 2217.024509215948, 2262.4117729390314, 2292.805111565519, 2293.1515339324474, 2295.391721193885, 2297.5060362022164, 2196.242296407737, 2215.556888622274, 2219.0679914435896, 2221.9666704999436, 2224.63293556563, 1785.7589225454528, 2075.2529089527757, 2080.053575623088, 2145.0454547726267, 2145.4850835799452, 2033.9288124915704, 2043.6730123180369, 2050.026237537158, 2051.917923283067, 2054.4042227753935, 7205.315495027964, 7235.204127545966, 7241.384482319009, 7249.71001159953, 7261.092363454568, 4431.889202769924, 4537.614302784267, 4541.364209010741, 4555.40779698637, 4557.316402539613, 2735.288824905519, 2885.75471084958, 2910.1124157132067, 2910.3451723362073, 2920.0, 942.2273735536862, 975.6292608808678, 992.8609994600762, 1005.527402121002, 1018.1549314069379, 9757.463339516324, 9780.657676981342, 9802.166815820592, 9851.064148905842, 9884.258680598983, 4062.857799977046, 4218.303979843353, 4252.48970123581, 4253.723507972034, 4284.700070995063, 8452.154784521621, 8492.532910689848, 8502.702405415781, 8516.1058088901, 8519.403641745143, 4526.162659907927, 4530.546945305443, 4530.773461326987, 4535.433070866142, 4570.634349252052, 3602.5857026442295, 3943.38877473992, 4060.959390406117, 4071.491063617048, 4137.54487006429, 3526.8060256685617, 3557.288542291552, 3591.9461208081375, 3620.4931309616672, 3640.508531348287, 1118.5637601335486, 1120.1598800899326, 1120.551779288275, 1134.2230572058168, 1178.2105988987228, 676.2763842688277, 838.3125836813877, 847.3560094328354, 858.5020688000944, 863.7840539865034, 5002.399712034507, 5013.097642424325, 5043.167877300278, 5056.26684130799, 5132.871678208075, 416.19466332646425, 417.9393987871742, 426.40942294921757, 431.75008350824186, 440.3856620015125, 3554.8222588870453, 3698.8335524901445, 3787.886363409102, 3794.392897136445, 3807.4479200516325, 8971.237444817132, 8982.056884027083, 9154.81690366189, 9163.450192988443, 9189.1729744322, 9117.270618350516, 9117.77205569866, 9125.863112053325, 9128.863067053999, 9132.863007054899, 6838.93161068383, 6863.210730765826, 7018.298170183043, 7023.578585284899, 7032.824179395556, 5060.139776237975, 5113.3097031900215, 5171.50870667286, 5248.422673505835, 5281.075811733008, 8235.50586964784, 8334.20825021622, 8378.204070613281, 8462.915370846213, 8499.660013599387, 8477.067522572635, 8479.830403392021, 8556.529390883561, 8613.741587752378, 8628.180322869317, 5725.885482290248, 6208.50331973432, 6402.071699603438, 6411.743530258924, 6547.541672082908, 7174.210836808052, 7193.388561972291, 7223.747168849275, 7263.891041634485, 7265.854682906206, 6403.711832967434, 6446.613203207822, 6491.415772580302, 6708.563943343667, 6787.762428314985, 6254.405831446005, 6322.33615470369, 6465.741370345321, 6529.281779004401, 6542.803715888531, 6076.635401875901, 6149.2313460817395, 6255.624662520263, 6262.34245404226, 6268.435840774352, 4298.63461605767, 4343.066240758252, 4443.488998765183, 4527.139843429738, 4535.637149028136, 4565.863024109282, 4628.213203755302, 4631.050634619827, 4711.552402521755, 4749.738764367855], "value": 3945.4971669829197, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.9657339405968, 302.42991960155115, 303.14210783482747, 303.4431817614678, 305.8134537931861, 4921.261810728392, 4927.876803079925, 4935.062338155748, 4939.160342741738, 4939.234418665113, 4849.684770489925, 4863.392075990501, 4867.9026419471675, 4890.486498917616, 4893.1436998525205, 3588.1388466767985, 3698.3712768829228, 3788.1287303920117, 3828.4158193219605, 3851.9422208666892, 3780.621937806225, 3819.9045023874487, 3820.8853734387876, 3830.731848770587, 3835.7698538087666, 3789.5073640426845, 3802.448644946481, 3804.4673745675627, 3812.5615554211345, 3822.159124992511, 3555.471147406614, 3666.431703086026, 3821.2357528494135, 3837.750546214515, 3838.2899163654815, 3363.697267245935, 3386.136535183537, 3386.339663765567, 3396.2188696599674, 3410.6759857813468, 4658.417697787777, 4669.766511674403, 4673.509281525459, 4683.250679891235, 4691.1555919934735, 4247.936280955788, 4351.97824010878, 4356.695031347807, 4368.737875727435, 4387.670924680661, 5036.143855544567, 5049.12200045974, 5051.4845546335955, 5092.949070509285, 5113.002964421939, 3678.70570354371, 3681.226942342111, 3699.4635777812337, 3712.3317802795486, 3720.479132921393, 5105.923411148836, 5307.522322990911, 5345.412004679482, 5367.141257398797, 5376.086065368858, 3761.8495260189834, 3770.7933461292673, 3771.981140094282, 3778.9433158502643, 3790.77255364679, 3832.616738326201, 3840.8271627776817, 3852.114013776847, 3854.4411060396087, 3861.1119442528375, 4350.129974005148, 4368.453943257093, 4388.253996820548, 4389.297712366006, 4393.1872603568445, 4878.414590249193, 5137.152369859006, 5167.457416971239, 5168.53483186515, 5188.688678679291, 1279.929603871796, 1282.2114399644151, 1288.1240756285629, 1300.0704496285202, 1301.1997621462922, 787.8778789287669, 811.7321283976273, 816.7590560784582, 817.2154731457867, 818.2349503214514, 4431.800568974404, 4488.887777805516, 4494.977525112419, 4497.460304763384, 4511.932321015187, 5237.319148510745, 5245.501677340647, 5251.973740131351, 5275.103232450492, 5317.122674758699, 4452.0, 4523.253663145544, 4531.909361812745, 4537.863864084083, 4539.319102134707, 2655.933601659974, 2794.972050279471, 2801.9159425217276, 2803.607494950668, 2816.2396153038976, 4865.9756701216265, 4886.780094895738, 4899.5590396863745, 4908.9263661045115, 4942.5304596063315, 5284.867878303073, 5389.27244821944, 5400.756965936543, 5442.673439593637, 5444.455554444524, 4899.608031357483, 4915.95084049155, 4937.481564435682, 4943.184374578154, 4948.678335908155, 5257.710825904612, 5279.419263881046, 5287.123071309629, 5291.894162116813, 5303.204519322133, 5056.62075344358, 5119.622722572147, 5152.613553983541, 5173.663711858717, 5210.192420174879, 4915.18899381598, 4938.30863679078, 4950.183219768842, 4951.603871690184, 4951.876203094951, 3768.2086761780333, 3799.3731034379016, 3802.752821066622, 3805.2579746949077, 3824.9235015300096, 5013.674111182761, 5205.323307969939, 5232.816851410183, 5244.269391101004, 5265.842024739264, 5041.6470847040355, 5055.191169412877, 5061.822836200862, 5064.151584671495, 5105.744712764421, 5052.292679025013, 5076.543111120017, 5104.983531505109, 5114.0, 5123.769430375568, 4758.881027974328, 5039.21892106724, 5054.747262636927, 5055.266986286894, 5063.215201643751, 4931.778069986787, 5061.848144555522, 5074.847754567369, 5076.1878099505375, 5170.37955445349, 4887.462379138221, 4981.975090124526, 5060.49395060491, 5065.214891691794, 5078.781092537838], "value": 3846.594658668973, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.3834261594944, 641.080050128066, 648.1250312078695, 734.328089797835, 754.7848863074023, 12919.870801291985, 13333.53332633358, 13692.452301907924, 13695.383707733152, 13714.93142534286, 12452.12835101541, 12488.875111248884, 12495.43770530326, 12511.249325040504, 13155.539556115538, 801.3268854162502, 814.1410811593767, 815.8735396013598, 816.2939057715064, 817.1705718695529, 804.8108694456798, 812.9390295727815, 813.3330668851544, 813.7477382011566, 813.9715109971153, 848.5545088828384, 849.4436144325446, 850.2432834777053, 852.0669866496177, 852.1265702654766, 836.1972506393869, 841.3185319890847, 841.5960339037266, 841.8821365008904, 841.9705310314109, 616.7255571270787, 616.8211218746558, 617.0528239152924, 617.253123720299, 617.8856911471393, 13613.183209007491, 13700.246486443242, 13752.449902003907, 13768.449262029506, 13783.655408614764, 13389.397477113456, 13404.262765547892, 13600.357799532852, 13611.727765444735, 13642.0, 10515.947420262926, 10612.78774424515, 10622.30954987931, 10712.143028557697, 10910.945445272802, 3360.0, 3363.293708321231, 3420.504026916083, 3425.2293234022395, 3492.388831954423, 40052.0, 41422.58577414217, 46621.76689116532, 48468.51531484675, 57121.42878571203, 10516.263861529773, 10970.122390208764, 11022.421169386842, 11113.83329250062, 11401.0, 18829.34097306615, 18898.14958326851, 18927.053647317854, 18972.620547589246, 18988.43034708961, 7062.823429414203, 7126.750563730245, 7178.066851309296, 7208.675609597581, 7282.308180722823, 3830.272248272819, 3896.3960586109197, 3997.1006523531973, 4002.659773919191, 4044.1911617676583, 3006.9398612028076, 3104.9379012419627, 3106.720395164401, 3108.580341653893, 3108.891188808381, 508.22495694066845, 518.271828081546, 527.8310940499003, 528.120679069353, 535.8853584544139, 463.1108272117542, 499.72015671224233, 500.6145268143582, 544.2054600283631, 589.2310534752189, 7998.64006119726, 8070.677172913135, 8149.674013039531, 8177.443354583169, 8366.58167091643, 472.715250741394, 572.6363759012974, 577.1746402644175, 581.2908251932636, 585.3765739487433, 3801.1067399161175, 3891.474650922146, 3924.50943632046, 3945.743526670757, 3951.585083566242, 84351.15648843556, 84967.0, 86673.56663216643, 86957.56521217353, 89647.55176224076, 73763.63118184375, 75224.62387688136, 75236.0, 77595.0, 78051.60974195093, 65001.67499162474, 66535.66732166405, 66536.0, 66833.0, 67791.66104169546, 8054.597270136587, 8107.959460202661, 8139.715109971123, 8164.877526836984, 8223.917760822314, 29428.0, 29595.40809183847, 30758.84620576972, 37336.626633733315, 40077.59922400739, 54587.45412545824, 55004.0, 56270.71864640651, 56588.0, 56774.0, 11002.50488727993, 11074.39090850011, 11126.55493780272, 11251.549938002388, 11356.0, 11457.140714446616, 11848.348340840992, 12433.93783031079, 12439.253644781342, 12875.291858947849, 11180.385078820744, 11517.136214783757, 11773.646790596296, 12565.371731413576, 12566.874331256937, 11402.258853174517, 11581.478833452345, 11902.880971190523, 11927.0, 12331.075169362155, 11492.482838272465, 11804.527818887493, 11896.048316134862, 11973.341466219441, 12340.889319961247, 9504.667336643184, 9674.177694896012, 9699.466529340954, 9802.558884850056, 10063.295569310078, 9486.0, 9898.20814334837, 9910.30627856072, 9984.650537231453, 10034.1972642187], "value": 6449.295740434365, "unit": "score"}], "name": "dromaeo_css", "value": 6312.7489252196265, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 115.0, 116.0, 114.0, 114.0, 116.0, 114.0, 113.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 129.0, 137.0, 182.0, 130.0, 162.0, 162.0, 132.0, 196.0, 129.0], "value": 153.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 159.0, 162.0, 161.0, 160.0, 161.0, 162.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 119.0, 75.0, 76.0, 76.0, 76.0, 97.0, 74.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 116.0, 84.0, 86.0, 84.0, 116.0, 84.0, 86.0, 124.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 118.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 147.0, 146.0, 145.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 66.0, 64.0, 64.0, 65.0, 63.0, 64.0, 64.0, 65.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 86.0, 89.0, 90.0, 85.0, 84.0, 87.0, 115.0, 86.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 143.0, 141.0, 140.0, 133.0, 147.0, 135.0, 134.0, 156.0, 135.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 171.0, 172.0, 172.0, 170.0, 172.0, 181.0, 174.0, 169.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 69.0, 69.0, 66.0, 66.0, 67.0, 67.0, 71.0, 72.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1560.7, "alertThreshold": 2.0}]} 09:28:03 INFO - Return code: 0 09:28:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:28:03 ERROR - # TBPL SUCCESS # 09:28:03 INFO - Running post-action listener: _resource_record_post_action 09:28:03 INFO - ##### 09:28:03 INFO - ##### Finished run-tests step (success) 09:28:03 INFO - ##### 09:28:03 INFO - Running post-run listener: _resource_record_post_run 09:28:03 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 7860224; Write bytes: 432398336; Read time: 1144; Write time: 436344 09:28:03 INFO - TinderboxPrint: CPU usage
13.1% 09:28:03 INFO - TinderboxPrint: I/O read bytes / time
7,860,224 / 1,144 09:28:03 INFO - TinderboxPrint: I/O write bytes / time
432,398,336 / 436,344 09:28:03 INFO - TinderboxPrint: CPU idle
8,336.3 (86.9%) 09:28:03 INFO - TinderboxPrint: CPU user
1,213.5 (12.6%) 09:28:03 INFO - TinderboxPrint: Swap in / out
0 / 0 09:28:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 111869952; Read time: 0; Write time: 108944 09:28:03 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 5967872; Write bytes: 320528384; Read time: 988; Write time: 327400 09:28:03 INFO - Running post-run listener: _upload_blobber_files 09:28:03 INFO - Blob upload gear active. 09:28:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:28:03 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 09:28:03 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'] 09:28:03 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 09:28:04 INFO - (blobuploader) - INFO - Open directory for files ... 09:28:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:28:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:28:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:28:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:28:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:28:08 INFO - (blobuploader) - INFO - Done attempting. 09:28:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:28:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:28:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:28:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:28:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:28:09 INFO - (blobuploader) - INFO - Done attempting. 09:28:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:28:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:28:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:28:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:28:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:28:10 INFO - (blobuploader) - INFO - Done attempting. 09:28:10 INFO - (blobuploader) - INFO - Iteration through files over. 09:28:10 INFO - Return code: 0 09:28:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:28:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:28:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d3ed6b3a49cc6c3b7c82fbf82ecc6b23661a103f6523850a9d0edae2dd9ea0d0680800bdc8fcdabd930d4ad1ce6f56069e97b0e1d1238dc7be4e6c81d2c5b6e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a62c717a73fe7a6427e46d66b4b1c27eb92c137e40f2d07b0125cec7e1ca9c0a8992891b7415ccd6eb7b9facc8955ab94f6e08d16b50bb419b65bec66b04ba64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/64e1e745582effc5297ceac9d60e48eafb3b0c9dee45f82e084e565872354f87df86b5e46253fab6814955c77ff80ebe24be56d02c984db8c962a73ab99b3918"} 09:28:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:28:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:28:10 INFO - Contents: 09:28:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d3ed6b3a49cc6c3b7c82fbf82ecc6b23661a103f6523850a9d0edae2dd9ea0d0680800bdc8fcdabd930d4ad1ce6f56069e97b0e1d1238dc7be4e6c81d2c5b6e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a62c717a73fe7a6427e46d66b4b1c27eb92c137e40f2d07b0125cec7e1ca9c0a8992891b7415ccd6eb7b9facc8955ab94f6e08d16b50bb419b65bec66b04ba64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/64e1e745582effc5297ceac9d60e48eafb3b0c9dee45f82e084e565872354f87df86b5e46253fab6814955c77ff80ebe24be56d02c984db8c962a73ab99b3918"} 09:28:10 INFO - Running post-run listener: copy_logs_to_upload_dir 09:28:10 INFO - Copying logs to upload dir... 09:28:10 INFO - mkdir: /builds/slave/test/build/upload/logs 09:28:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.534836 ========= master_lag: 3.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-02 09:28:13.685613) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 09:28:13.690115) ========= 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=20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d3ed6b3a49cc6c3b7c82fbf82ecc6b23661a103f6523850a9d0edae2dd9ea0d0680800bdc8fcdabd930d4ad1ce6f56069e97b0e1d1238dc7be4e6c81d2c5b6e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a62c717a73fe7a6427e46d66b4b1c27eb92c137e40f2d07b0125cec7e1ca9c0a8992891b7415ccd6eb7b9facc8955ab94f6e08d16b50bb419b65bec66b04ba64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/64e1e745582effc5297ceac9d60e48eafb3b0c9dee45f82e084e565872354f87df86b5e46253fab6814955c77ff80ebe24be56d02c984db8c962a73ab99b3918"} build_url:https://queue.taskcluster.net/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011178 build_url: 'https://queue.taskcluster.net/v1/task/bIB-ojWZR_2EpnBzwYbbWw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d3ed6b3a49cc6c3b7c82fbf82ecc6b23661a103f6523850a9d0edae2dd9ea0d0680800bdc8fcdabd930d4ad1ce6f56069e97b0e1d1238dc7be4e6c81d2c5b6e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a62c717a73fe7a6427e46d66b4b1c27eb92c137e40f2d07b0125cec7e1ca9c0a8992891b7415ccd6eb7b9facc8955ab94f6e08d16b50bb419b65bec66b04ba64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/64e1e745582effc5297ceac9d60e48eafb3b0c9dee45f82e084e565872354f87df86b5e46253fab6814955c77ff80ebe24be56d02c984db8c962a73ab99b3918"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 09:28:13.721891) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 09:28:13.722252) ========= 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=20e666a3d4cfbb71505a330e000001b4-1464883631.184081-1824444353 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.35 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 09:28:14.076474) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 09:28:14.076795) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 09:28:14.077074) ========= ========= Total master_lag: 3.51 =========