builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1463403857.7 results: success (0) buildid: 20160516051534 builduid: 6a6989e64c0b4bdda048783f9404c728 revision: 26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 06:04:17.698721) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 06:04:17.699262) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 06:04:17.699573) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 06:04:17.726930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 06:04:17.727190) ========= 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=0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-16 06:04:17-- 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% 51.8K=0.2s 2016-05-16 06:04:18 (51.8 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.422597 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 06:04:18.163433) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 06:04:18.163773) ========= 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=0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021611 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 06:04:18.213430) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 06:04:18.213794) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89 --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 26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89 --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=0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-16 06:04:18,451 truncating revision to first 12 chars 2016-05-16 06:04:18,451 Setting DEBUG logging. 2016-05-16 06:04:18,451 attempt 1/10 2016-05-16 06:04:18,451 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/26656bbb6d39?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 06:04:19,592 unpacking tar archive at: fx-team-26656bbb6d39/testing/mozharness/ program finished with exit code 0 elapsedTime=1.433173 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 06:04:19.658174) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 06:04:19.658477) ========= script_repo_revision: 26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 06:04:19.658882) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 06:04:19.659144) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 06:04:19.668610) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-16 06:04:19.668950) ========= /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=0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:04:19 INFO - MultiFileLogger online at 20160516 06:04:19 in /builds/slave/test 06:04:19 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 06:04:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:04:19 INFO - {'append_to_log': False, 06:04:19 INFO - 'base_work_dir': '/builds/slave/test', 06:04:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:04:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:04:19 INFO - 'branch': 'Fx-Team-Non-PGO', 06:04:19 INFO - 'buildbot_json_path': 'buildprops.json', 06:04:19 INFO - 'config_files': ('talos/linux_config.py',), 06:04:19 INFO - 'default_actions': ('clobber', 06:04:19 INFO - 'read-buildbot-config', 06:04:19 INFO - 'download-and-extract', 06:04:19 INFO - 'populate-webroot', 06:04:19 INFO - 'create-virtualenv', 06:04:19 INFO - 'install', 06:04:19 INFO - 'run-tests'), 06:04:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:04:19 INFO - 'download_minidump_stackwalk': True, 06:04:19 INFO - 'download_symbols': 'ondemand', 06:04:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:04:19 INFO - 'tooltool.py': '/tools/tooltool.py', 06:04:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:04:19 INFO - '/tools/misc-python/virtualenv.py')}, 06:04:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:04:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:04:19 INFO - 'installer_path': 'installer.exe', 06:04:19 INFO - 'log_level': 'info', 06:04:19 INFO - 'log_name': 'talos', 06:04:19 INFO - 'log_to_console': True, 06:04:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:04:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:04:20 INFO - 'opt_config_files': (), 06:04:20 INFO - 'pip_index': False, 06:04:20 INFO - 'sps_profile': False, 06:04:20 INFO - 'sps_profile_interval': 0, 06:04:20 INFO - 'suite': 'dromaeojs', 06:04:20 INFO - 'system_bits': '32', 06:04:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:04:20 INFO - 'title': 'talos-linux64-ix-017', 06:04:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:04:20 INFO - 'use_talos_json': True, 06:04:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:04:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:04:20 INFO - 'work_dir': 'build'} 06:04:20 INFO - ##### 06:04:20 INFO - ##### Running clobber step. 06:04:20 INFO - ##### 06:04:20 INFO - Running pre-action listener: _resource_record_pre_action 06:04:20 INFO - Running main action method: clobber 06:04:20 INFO - rmtree: /builds/slave/test/build 06:04:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:04:20 INFO - Running post-action listener: _resource_record_post_action 06:04:20 INFO - ##### 06:04:20 INFO - ##### Finished clobber step (success) 06:04:20 INFO - ##### 06:04:20 INFO - ##### 06:04:20 INFO - ##### Running read-buildbot-config step. 06:04:20 INFO - ##### 06:04:20 INFO - Running pre-action listener: _resource_record_pre_action 06:04:20 INFO - Running main action method: read_buildbot_config 06:04:20 INFO - Using buildbot properties: 06:04:20 INFO - { 06:04:20 INFO - "project": "", 06:04:20 INFO - "product": "firefox", 06:04:20 INFO - "script_repo_revision": "production", 06:04:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:04:20 INFO - "repository": "", 06:04:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:04:20 INFO - "buildid": "20160516051534", 06:04:20 INFO - "pgo_build": "False", 06:04:20 INFO - "basedir": "/builds/slave/test", 06:04:20 INFO - "buildnumber": 1747, 06:04:20 INFO - "slavename": "talos-linux64-ix-017", 06:04:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:04:20 INFO - "platform": "ubuntu64_hw", 06:04:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:04:20 INFO - "branch": "fx-team", 06:04:20 INFO - "repo_path": "integration/fx-team", 06:04:20 INFO - "revision": "26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89", 06:04:20 INFO - "stage_platform": "linux64", 06:04:20 INFO - "builduid": "6a6989e64c0b4bdda048783f9404c728", 06:04:20 INFO - "slavebuilddir": "test" 06:04:20 INFO - } 06:04:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:04:20 INFO - Running post-action listener: _resource_record_post_action 06:04:20 INFO - ##### 06:04:20 INFO - ##### Finished read-buildbot-config step (success) 06:04:20 INFO - ##### 06:04:20 INFO - ##### 06:04:20 INFO - ##### Running download-and-extract step. 06:04:20 INFO - ##### 06:04:20 INFO - Running pre-action listener: _resource_record_pre_action 06:04:20 INFO - Running main action method: download_and_extract 06:04:20 INFO - mkdir: /builds/slave/test/build/tests 06:04:20 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')]} 06:04:20 INFO - https://queue.taskcluster.net/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:04:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:04:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:04:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/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 06:04:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/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 06:04:26 INFO - Downloaded 1361 bytes. 06:04:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:04:26 INFO - Using the following test package requirements: 06:04:26 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:04:26 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:04:26 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:04:26 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:26 INFO - u'jsshell-linux-x86_64.zip'], 06:04:26 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:04:26 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:04:26 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:04:26 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:04:26 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:04:26 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:04:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:04:26 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')]} 06:04:26 INFO - https://queue.taskcluster.net/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:04:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:04:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:04:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/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 06:04:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/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 06:04:31 INFO - Downloaded 22448136 bytes. 06:04:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:04:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:04:32 INFO - Return code: 0 06:04:32 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 06:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:32 INFO - https://queue.taskcluster.net/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:04:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:04:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:04:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/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 06:04:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/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 06:04:34 INFO - Downloaded 22448136 bytes. 06:04:34 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'] 06:04:34 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 06:04:35 INFO - Return code: 0 06:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:35 INFO - https://queue.taskcluster.net/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:04:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:04:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:04:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/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 06:04:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/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 06:04:36 INFO - Downloaded 10840194 bytes. 06:04:36 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'] 06:04:36 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 06:04:37 INFO - Return code: 0 06:04:37 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')]} 06:04:37 INFO - https://queue.taskcluster.net/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:04:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:04:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:04:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/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 06:04:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/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 06:04:38 INFO - Downloaded 54745217 bytes. 06:04:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:04:38 INFO - mkdir: /builds/slave/test/properties 06:04:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:04:38 INFO - Writing to file /builds/slave/test/properties/build_url 06:04:38 INFO - Contents: 06:04:38 INFO - build_url:https://queue.taskcluster.net/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:04:39 INFO - Running post-action listener: _resource_record_post_action 06:04:39 INFO - Running post-action listener: set_extra_try_arguments 06:04:39 INFO - ##### 06:04:39 INFO - ##### Finished download-and-extract step (success) 06:04:39 INFO - ##### 06:04:39 INFO - ##### 06:04:39 INFO - ##### Running populate-webroot step. 06:04:39 INFO - ##### 06:04:39 INFO - Running pre-action listener: _resource_record_pre_action 06:04:39 INFO - Running main action method: populate_webroot 06:04:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:04:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:04:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:04:39 INFO - '--tppagecycles', 06:04:39 INFO - '7'], 06:04:39 INFO - 'tests': ['tsvgm']}}, 06:04:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:04:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:04:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:04:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:04:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:04:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:04:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:39 INFO - 'talos_options': ['--disable-e10s'], 06:04:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:04:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:04:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:39 INFO - 'talos_options': ['--disable-e10s'], 06:04:39 INFO - 'tests': ['damp', 'tps']}, 06:04:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:39 INFO - 'tests': ['damp', 'tps']}, 06:04:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:04:39 INFO - 'tests': ['dromaeo_dom']}, 06:04:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:04:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:04:39 INFO - 'tests': ['a11yr', 06:04:39 INFO - 'ts_paint', 06:04:39 INFO - 'tpaint', 06:04:39 INFO - 'sessionrestore', 06:04:39 INFO - 'sessionrestore_no_auto_restore', 06:04:39 INFO - 'tabpaint']}, 06:04:39 INFO - 'other-e10s': {'tests': ['a11yr', 06:04:39 INFO - 'ts_paint', 06:04:39 INFO - 'tpaint', 06:04:39 INFO - 'sessionrestore', 06:04:39 INFO - 'sessionrestore_no_auto_restore', 06:04:39 INFO - 'tabpaint']}, 06:04:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:04:39 INFO - 'ts_paint', 06:04:39 INFO - 'tpaint', 06:04:39 INFO - 'sessionrestore', 06:04:39 INFO - 'sessionrestore_no_auto_restore', 06:04:39 INFO - 'tabpaint']}, 06:04:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:04:39 INFO - 'ts_paint', 06:04:39 INFO - 'tpaint', 06:04:39 INFO - 'sessionrestore', 06:04:39 INFO - 'sessionrestore_no_auto_restore', 06:04:39 INFO - 'tabpaint']}, 06:04:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:04:39 INFO - 'tests': ['a11yr', 06:04:39 INFO - 'ts_paint', 06:04:39 INFO - 'tpaint', 06:04:39 INFO - 'sessionrestore', 06:04:39 INFO - 'sessionrestore_no_auto_restore', 06:04:39 INFO - 'tabpaint']}, 06:04:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:04:39 INFO - 'tests': ['a11yr', 06:04:39 INFO - 'ts_paint', 06:04:39 INFO - 'tpaint', 06:04:39 INFO - 'sessionrestore', 06:04:39 INFO - 'sessionrestore_no_auto_restore', 06:04:39 INFO - 'tabpaint']}, 06:04:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:04:39 INFO - 'tests': ['tsvgx', 06:04:39 INFO - 'tsvgr_opacity', 06:04:39 INFO - 'tart', 06:04:39 INFO - 'tscrollx', 06:04:39 INFO - 'cart']}, 06:04:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:04:39 INFO - 'tsvgr_opacity', 06:04:39 INFO - 'tart', 06:04:39 INFO - 'tscrollx', 06:04:39 INFO - 'cart']}, 06:04:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:39 INFO - 'talos_options': ['--disable-e10s'], 06:04:39 INFO - 'tests': ['tp5o']}, 06:04:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:39 INFO - 'tests': ['tp5o']}, 06:04:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:39 INFO - 'talos_options': ['--disable-e10s', 06:04:39 INFO - '--xperf_path', 06:04:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:04:39 INFO - 'tests': ['tp5n']}, 06:04:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:39 INFO - 'talos_options': ['--xperf_path', 06:04:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:04:39 INFO - 'tests': ['tp5n']}}, 06:04:39 INFO - 'talos.zip': {'path': '', 06:04:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:04:39 INFO - Running post-action listener: _resource_record_post_action 06:04:39 INFO - ##### 06:04:39 INFO - ##### Finished populate-webroot step (success) 06:04:39 INFO - ##### 06:04:39 INFO - ##### 06:04:39 INFO - ##### Running create-virtualenv step. 06:04:39 INFO - ##### 06:04:39 INFO - Running pre-action listener: _resource_record_pre_action 06:04:39 INFO - Running main action method: create_virtualenv 06:04:39 INFO - Creating virtualenv /builds/slave/test/build/venv 06:04:39 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 06:04:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:04:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:04:39 INFO - Using real prefix '/usr' 06:04:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:04:39 INFO - Installing distribute.............................................................................................................................................................................................done. 06:04:41 INFO - Installing pip.................done. 06:04:41 INFO - Return code: 0 06:04:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:04: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')]} 06:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04: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')]} 06:04:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd16f79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fd9c0>, '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 0x17fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17fed50>, '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': '0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462', '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 06:04: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', 'pip>=1.5'] in /builds/slave/test/build 06:04: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 pip>=1.5 06:04:41 INFO - Using env: {'DISPLAY': ':0', 06:04:41 INFO - 'HOME': '/home/cltbld', 06:04:41 INFO - 'LANG': 'en_US.UTF-8', 06:04:41 INFO - 'LANGUAGE': 'en_US:en', 06:04:41 INFO - 'LOGNAME': 'cltbld', 06:04:41 INFO - 'MAIL': '/var/mail/cltbld', 06:04:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:41 INFO - 'MOZ_NO_REMOTE': '1', 06:04:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:41 INFO - 'NO_EM_RESTART': '1', 06:04:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:41 INFO - 'PWD': '/builds/slave/test', 06:04:41 INFO - 'SHELL': '/bin/bash', 06:04:41 INFO - 'SHLVL': '1', 06:04:41 INFO - 'TERM': 'linux', 06:04:41 INFO - 'TMOUT': '86400', 06:04:41 INFO - 'USER': 'cltbld', 06:04:41 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462', 06:04:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:41 INFO - '_': '/tools/buildbot/bin/python'} 06:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:41 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 06:04:41 INFO - Cleaning up... 06:04:41 INFO - Return code: 0 06:04:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:04: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')]} 06:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04: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')]} 06:04:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04: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', '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 0x7ffd16f79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fd9c0>, '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 0x17fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17fed50>, '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': '0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462', '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 06:04: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', 'psutil>=3.1.1'] in /builds/slave/test/build 06:04: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 psutil>=3.1.1 06:04:41 INFO - Using env: {'DISPLAY': ':0', 06:04:41 INFO - 'HOME': '/home/cltbld', 06:04:41 INFO - 'LANG': 'en_US.UTF-8', 06:04:41 INFO - 'LANGUAGE': 'en_US:en', 06:04:41 INFO - 'LOGNAME': 'cltbld', 06:04:41 INFO - 'MAIL': '/var/mail/cltbld', 06:04:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:41 INFO - 'MOZ_NO_REMOTE': '1', 06:04:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:41 INFO - 'NO_EM_RESTART': '1', 06:04:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:41 INFO - 'PWD': '/builds/slave/test', 06:04:41 INFO - 'SHELL': '/bin/bash', 06:04:41 INFO - 'SHLVL': '1', 06:04:41 INFO - 'TERM': 'linux', 06:04:41 INFO - 'TMOUT': '86400', 06:04:41 INFO - 'USER': 'cltbld', 06:04:41 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462', 06:04:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:41 INFO - '_': '/tools/buildbot/bin/python'} 06:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:42 INFO - Downloading/unpacking psutil>=3.1.1 06:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:04:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:04:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:04:44 INFO - Installing collected packages: psutil 06:04:44 INFO - Running setup.py install for psutil 06:04:44 INFO - building 'psutil._psutil_linux' extension 06:04:44 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 06:04:44 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 06:04:44 INFO - building 'psutil._psutil_posix' extension 06:04:44 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 06:04:44 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 06:04:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:04:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:04:44 INFO - Successfully installed psutil 06:04:44 INFO - Cleaning up... 06:04:44 INFO - Return code: 0 06:04:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd16f79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fd9c0>, '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 0x17fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17fed50>, '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': '0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462', '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 06:04:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:04:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:04:44 INFO - Using env: {'DISPLAY': ':0', 06:04:44 INFO - 'HOME': '/home/cltbld', 06:04:44 INFO - 'LANG': 'en_US.UTF-8', 06:04:44 INFO - 'LANGUAGE': 'en_US:en', 06:04:44 INFO - 'LOGNAME': 'cltbld', 06:04:44 INFO - 'MAIL': '/var/mail/cltbld', 06:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:44 INFO - 'MOZ_NO_REMOTE': '1', 06:04:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:44 INFO - 'NO_EM_RESTART': '1', 06:04:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:44 INFO - 'PWD': '/builds/slave/test', 06:04:44 INFO - 'SHELL': '/bin/bash', 06:04:44 INFO - 'SHLVL': '1', 06:04:44 INFO - 'TERM': 'linux', 06:04:44 INFO - 'TMOUT': '86400', 06:04:44 INFO - 'USER': 'cltbld', 06:04:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462', 06:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:44 INFO - '_': '/tools/buildbot/bin/python'} 06:04:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:04:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:04:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:04:46 INFO - Installing collected packages: mozsystemmonitor 06:04:46 INFO - Running setup.py install for mozsystemmonitor 06:04:46 INFO - Successfully installed mozsystemmonitor 06:04:46 INFO - Cleaning up... 06:04:46 INFO - Return code: 0 06:04:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:04:46 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')]} 06:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:46 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')]} 06:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:46 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 0x7ffd16f79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fd9c0>, '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 0x17fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17fed50>, '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': '0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462', '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 06:04:46 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 06:04:46 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 06:04:46 INFO - Using env: {'DISPLAY': ':0', 06:04:46 INFO - 'HOME': '/home/cltbld', 06:04:46 INFO - 'LANG': 'en_US.UTF-8', 06:04:46 INFO - 'LANGUAGE': 'en_US:en', 06:04:46 INFO - 'LOGNAME': 'cltbld', 06:04:46 INFO - 'MAIL': '/var/mail/cltbld', 06:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:46 INFO - 'MOZ_NO_REMOTE': '1', 06:04:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:46 INFO - 'NO_EM_RESTART': '1', 06:04:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:46 INFO - 'PWD': '/builds/slave/test', 06:04:46 INFO - 'SHELL': '/bin/bash', 06:04:46 INFO - 'SHLVL': '1', 06:04:46 INFO - 'TERM': 'linux', 06:04:46 INFO - 'TMOUT': '86400', 06:04:46 INFO - 'USER': 'cltbld', 06:04:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462', 06:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:46 INFO - '_': '/tools/buildbot/bin/python'} 06:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:47 INFO - Downloading/unpacking blobuploader==1.2.4 06:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:48 INFO - Downloading blobuploader-1.2.4.tar.gz 06:04:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:04:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:04:49 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 06:04:49 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 06:04:49 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 06:04:49 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 06:04:49 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 06:04:49 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 06:04:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:04:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:04:49 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 06:04:49 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 06:04:49 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 06:04:49 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 06:04:49 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 06:04:49 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 06:04:49 INFO - Downloading docopt-0.6.1.tar.gz 06:04:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:04:49 INFO - Installing collected packages: blobuploader, requests, docopt 06:04:49 INFO - Running setup.py install for blobuploader 06:04:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:04:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:04:49 INFO - Running setup.py install for requests 06:04:50 INFO - Running setup.py install for docopt 06:04:50 INFO - Successfully installed blobuploader requests docopt 06:04:50 INFO - Cleaning up... 06:04:50 INFO - Return code: 0 06:04:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:04: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')]} 06:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04: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')]} 06:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:50 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 0x7ffd16f79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fd9c0>, '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 0x17fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17fed50>, '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': '0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462', '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 06:04:50 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 06:04:50 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 06:04:50 INFO - Using env: {'DISPLAY': ':0', 06:04:50 INFO - 'HOME': '/home/cltbld', 06:04:50 INFO - 'LANG': 'en_US.UTF-8', 06:04:50 INFO - 'LANGUAGE': 'en_US:en', 06:04:50 INFO - 'LOGNAME': 'cltbld', 06:04:50 INFO - 'MAIL': '/var/mail/cltbld', 06:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:50 INFO - 'MOZ_NO_REMOTE': '1', 06:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:50 INFO - 'NO_EM_RESTART': '1', 06:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:50 INFO - 'PWD': '/builds/slave/test', 06:04:50 INFO - 'SHELL': '/bin/bash', 06:04:50 INFO - 'SHLVL': '1', 06:04:50 INFO - 'TERM': 'linux', 06:04:50 INFO - 'TMOUT': '86400', 06:04:50 INFO - 'USER': 'cltbld', 06:04:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462', 06:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:50 INFO - '_': '/tools/buildbot/bin/python'} 06:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:04:50 INFO - Running setup.py (path:/tmp/pip-o1uF4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:04:50 INFO - Running setup.py (path:/tmp/pip-4XjMWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:04:50 INFO - Running setup.py (path:/tmp/pip-FRVZlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:04:50 INFO - Running setup.py (path:/tmp/pip-25Cjty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:04:50 INFO - Running setup.py (path:/tmp/pip-2kK05h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:04:51 INFO - Running setup.py (path:/tmp/pip-JaqjK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:04:51 INFO - Running setup.py (path:/tmp/pip-thvNxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:04:51 INFO - Running setup.py (path:/tmp/pip-jngPAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:04:51 INFO - Running setup.py (path:/tmp/pip-gkq9R0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:04:51 INFO - Running setup.py (path:/tmp/pip-ryQKhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:04:51 INFO - Running setup.py (path:/tmp/pip-kW8SCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:04:51 INFO - Running setup.py (path:/tmp/pip-F3EQof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:04:51 INFO - Running setup.py (path:/tmp/pip-86SIpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:04:51 INFO - Running setup.py (path:/tmp/pip-e_QZLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:04:51 INFO - Running setup.py (path:/tmp/pip-Fhp6wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:04:51 INFO - Running setup.py (path:/tmp/pip-1UgH5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:04:51 INFO - Running setup.py (path:/tmp/pip-rE7Gl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:04:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:04:51 INFO - Running setup.py install for manifestparser 06:04:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:04:52 INFO - Running setup.py install for mozcrash 06:04:52 INFO - Running setup.py install for mozdebug 06:04:52 INFO - Running setup.py install for mozdevice 06:04:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:04:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:04:52 INFO - Running setup.py install for mozfile 06:04:52 INFO - Running setup.py install for mozhttpd 06:04:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:04:52 INFO - Running setup.py install for mozinfo 06:04:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:04:52 INFO - Running setup.py install for mozInstall 06:04:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:04:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:04:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:04:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:04:52 INFO - Running setup.py install for mozleak 06:04:52 INFO - Running setup.py install for mozlog 06:04:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:04:52 INFO - Running setup.py install for moznetwork 06:04:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:04:53 INFO - Running setup.py install for mozprocess 06:04:53 INFO - Running setup.py install for mozprofile 06:04:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:04:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:04:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:04:53 INFO - Running setup.py install for mozrunner 06:04:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:04:53 INFO - Running setup.py install for mozscreenshot 06:04:53 INFO - Running setup.py install for moztest 06:04:53 INFO - Running setup.py install for mozversion 06:04:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:04:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:04:53 INFO - Cleaning up... 06:04:53 INFO - Return code: 0 06:04:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:04:53 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')]} 06:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:53 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')]} 06:04:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:53 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 0x7ffd16f79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fd9c0>, '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 0x17fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17fed50>, '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': '0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462', '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 06:04:53 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 06:04:53 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 06:04:53 INFO - Using env: {'DISPLAY': ':0', 06:04:53 INFO - 'HOME': '/home/cltbld', 06:04:53 INFO - 'LANG': 'en_US.UTF-8', 06:04:53 INFO - 'LANGUAGE': 'en_US:en', 06:04:53 INFO - 'LOGNAME': 'cltbld', 06:04:53 INFO - 'MAIL': '/var/mail/cltbld', 06:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:53 INFO - 'MOZ_NO_REMOTE': '1', 06:04:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:53 INFO - 'NO_EM_RESTART': '1', 06:04:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:53 INFO - 'PWD': '/builds/slave/test', 06:04:53 INFO - 'SHELL': '/bin/bash', 06:04:53 INFO - 'SHLVL': '1', 06:04:53 INFO - 'TERM': 'linux', 06:04:53 INFO - 'TMOUT': '86400', 06:04:53 INFO - 'USER': 'cltbld', 06:04:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462', 06:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:53 INFO - '_': '/tools/buildbot/bin/python'} 06:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:04:53 INFO - Running setup.py (path:/tmp/pip-5iUEaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:04:53 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)) 06:04:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:04:53 INFO - Running setup.py (path:/tmp/pip-yV8Fi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:04:54 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)) 06:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:04:54 INFO - Running setup.py (path:/tmp/pip-Y0boUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:04:54 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)) 06:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:04:54 INFO - Running setup.py (path:/tmp/pip-_r_ZxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:04:54 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)) 06:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:04:54 INFO - Running setup.py (path:/tmp/pip-pa91Gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:04:54 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)) 06:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:04:54 INFO - Running setup.py (path:/tmp/pip-c4FhQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:04:54 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)) 06:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:04:54 INFO - Running setup.py (path:/tmp/pip-LwKuvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:04:54 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)) 06:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:04:54 INFO - Running setup.py (path:/tmp/pip-NuKesa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:04:54 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)) 06:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:04:54 INFO - Running setup.py (path:/tmp/pip-Sblkve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:04:54 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)) 06:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:04:54 INFO - Running setup.py (path:/tmp/pip-cCH5KL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:04:54 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)) 06:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:04:54 INFO - Running setup.py (path:/tmp/pip-mTOIXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:04:54 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)) 06:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:04:54 INFO - Running setup.py (path:/tmp/pip-ehvjUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:04:54 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)) 06:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:04:54 INFO - Running setup.py (path:/tmp/pip-S7K3K9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:04:54 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)) 06:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:04:54 INFO - Running setup.py (path:/tmp/pip-7nDrWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:04:54 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)) 06:04:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:04:54 INFO - Running setup.py (path:/tmp/pip-mNx5_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:04:55 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)) 06:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:04:55 INFO - Running setup.py (path:/tmp/pip-tE132k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:04:55 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)) 06:04:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:04:55 INFO - Running setup.py (path:/tmp/pip-X1_0eI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:04:55 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)) 06:04:55 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)) 06:04:55 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)) 06:04:55 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)) 06:04:55 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)) 06:04:55 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)) 06:04:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:57 INFO - Downloading blessings-1.6.tar.gz 06:04:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:04:57 INFO - Installing collected packages: blessings 06:04:57 INFO - Running setup.py install for blessings 06:04:57 INFO - Successfully installed blessings 06:04:57 INFO - Cleaning up... 06:04:57 INFO - Return code: 0 06:04:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:04:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:04:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:04:57 INFO - Reading from file tmpfile_stdout 06:04:57 INFO - Current package versions: 06:04:57 INFO - argparse == 1.2.1 06:04:57 INFO - blessings == 1.6 06:04:57 INFO - blobuploader == 1.2.4 06:04:57 INFO - docopt == 0.6.1 06:04:57 INFO - manifestparser == 1.1 06:04:57 INFO - mozInstall == 1.12 06:04:57 INFO - mozcrash == 0.17 06:04:57 INFO - mozdebug == 0.1 06:04:57 INFO - mozdevice == 0.48 06:04:57 INFO - mozfile == 1.2 06:04:57 INFO - mozhttpd == 0.7 06:04:57 INFO - mozinfo == 0.9 06:04:57 INFO - mozleak == 0.1 06:04:57 INFO - mozlog == 3.2 06:04:57 INFO - moznetwork == 0.27 06:04:57 INFO - mozprocess == 0.22 06:04:57 INFO - mozprofile == 0.28 06:04:57 INFO - mozrunner == 6.11 06:04:57 INFO - mozscreenshot == 0.1 06:04:57 INFO - mozsystemmonitor == 0.3 06:04:57 INFO - moztest == 0.7 06:04:57 INFO - mozversion == 1.4 06:04:57 INFO - psutil == 3.1.1 06:04:57 INFO - requests == 1.2.3 06:04:57 INFO - wsgiref == 0.1.2 06:04:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:04: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')]} 06:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04: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')]} 06:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:57 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 0x7ffd16f79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fd9c0>, '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 0x17fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17fed50>, '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': '0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462', '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 06:04:57 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 06:04:57 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 06:04:57 INFO - Using env: {'DISPLAY': ':0', 06:04:57 INFO - 'HOME': '/home/cltbld', 06:04:57 INFO - 'LANG': 'en_US.UTF-8', 06:04:57 INFO - 'LANGUAGE': 'en_US:en', 06:04:57 INFO - 'LOGNAME': 'cltbld', 06:04:57 INFO - 'MAIL': '/var/mail/cltbld', 06:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:57 INFO - 'MOZ_NO_REMOTE': '1', 06:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:57 INFO - 'NO_EM_RESTART': '1', 06:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:57 INFO - 'PWD': '/builds/slave/test', 06:04:57 INFO - 'SHELL': '/bin/bash', 06:04:57 INFO - 'SHLVL': '1', 06:04:57 INFO - 'TERM': 'linux', 06:04:57 INFO - 'TMOUT': '86400', 06:04:57 INFO - 'USER': 'cltbld', 06:04:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462', 06:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:57 INFO - '_': '/tools/buildbot/bin/python'} 06:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:57 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)) 06:04:57 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)) 06:04:57 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)) 06:04:57 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)) 06:04:57 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)) 06:04:57 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)) 06:04:57 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)) 06:04:57 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)) 06:04:57 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)) 06:04:57 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)) 06:04:57 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)) 06:04:57 INFO - Cleaning up... 06:04:57 INFO - Return code: 0 06:04:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:04: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')]} 06:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04: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')]} 06:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd16f79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fd9c0>, '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 0x17fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17fed50>, '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': '0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462', '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 06:04: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', 'jsonschema'] in /builds/slave/test/build 06:04: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 jsonschema 06:04:57 INFO - Using env: {'DISPLAY': ':0', 06:04:57 INFO - 'HOME': '/home/cltbld', 06:04:57 INFO - 'LANG': 'en_US.UTF-8', 06:04:57 INFO - 'LANGUAGE': 'en_US:en', 06:04:57 INFO - 'LOGNAME': 'cltbld', 06:04:57 INFO - 'MAIL': '/var/mail/cltbld', 06:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:57 INFO - 'MOZ_NO_REMOTE': '1', 06:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:04:57 INFO - 'NO_EM_RESTART': '1', 06:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:57 INFO - 'PWD': '/builds/slave/test', 06:04:57 INFO - 'SHELL': '/bin/bash', 06:04:57 INFO - 'SHLVL': '1', 06:04:57 INFO - 'TERM': 'linux', 06:04:57 INFO - 'TMOUT': '86400', 06:04:57 INFO - 'USER': 'cltbld', 06:04:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462', 06:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:57 INFO - '_': '/tools/buildbot/bin/python'} 06:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:57 INFO - Downloading/unpacking jsonschema 06:04: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 06:04: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 06:04: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 06:04: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 06:04: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 06:04: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 06:04:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:04:59 INFO - Downloading/unpacking functools32 (from jsonschema) 06:04: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 06:04: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 06:04: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 06:04: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 06:04: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 06:04: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 06:05:00 INFO - Downloading functools32-3.2.3-2.tar.gz 06:05:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:05:00 INFO - warning: no files found matching '*.txt' 06:05:00 INFO - no previously-included directories found matching 'build' 06:05:00 INFO - no previously-included directories found matching 'dist' 06:05:00 INFO - no previously-included directories found matching '.git*' 06:05:00 INFO - Installing collected packages: jsonschema, functools32 06:05:00 INFO - Running setup.py install for functools32 06:05:00 INFO - warning: no files found matching '*.txt' 06:05:00 INFO - no previously-included directories found matching 'build' 06:05:00 INFO - no previously-included directories found matching 'dist' 06:05:00 INFO - no previously-included directories found matching '.git*' 06:05:00 INFO - Successfully installed jsonschema functools32 06:05:00 INFO - Cleaning up... 06:05:00 INFO - Return code: 0 06:05:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:00 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 0x7ffd16f79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x176e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17fd9c0>, '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 0x17fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17fed50>, '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': '0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462', '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 06:05:00 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 06:05:00 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 06:05:00 INFO - Using env: {'DISPLAY': ':0', 06:05:00 INFO - 'HOME': '/home/cltbld', 06:05:00 INFO - 'LANG': 'en_US.UTF-8', 06:05:00 INFO - 'LANGUAGE': 'en_US:en', 06:05:00 INFO - 'LOGNAME': 'cltbld', 06:05:00 INFO - 'MAIL': '/var/mail/cltbld', 06:05:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:00 INFO - 'MOZ_NO_REMOTE': '1', 06:05:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:00 INFO - 'NO_EM_RESTART': '1', 06:05:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:00 INFO - 'PWD': '/builds/slave/test', 06:05:00 INFO - 'SHELL': '/bin/bash', 06:05:00 INFO - 'SHLVL': '1', 06:05:00 INFO - 'TERM': 'linux', 06:05:00 INFO - 'TMOUT': '86400', 06:05:00 INFO - 'USER': 'cltbld', 06:05:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462', 06:05:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:00 INFO - '_': '/tools/buildbot/bin/python'} 06:05:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:00 INFO - Downloading/unpacking flake8 06:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:05:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:05:02 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 06:05:02 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 06:05:02 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 06:05:02 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 06:05:02 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 06:05:02 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 06:05:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:05:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:05:02 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 06:05:02 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 06:05:02 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 06:05:02 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 06:05:02 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 06:05:02 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 06:05:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:05:02 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 06:05:02 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 06:05:02 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 06:05:02 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 06:05:02 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 06:05:02 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 06:05:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:05:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:05:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:05:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:05:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:05:03 INFO - no previously-included directories found matching 'docs/_build' 06:05:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:05:03 INFO - Running setup.py install for pep8 06:05:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:05:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:05:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:05:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:05:03 INFO - no previously-included directories found matching 'docs/_build' 06:05:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:05:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:05:03 INFO - Cleaning up... 06:05:03 INFO - Return code: 0 06:05:03 INFO - Running post-action listener: _resource_record_post_action 06:05:03 INFO - Running post-action listener: _start_resource_monitoring 06:05:03 INFO - Starting resource monitoring. 06:05:03 INFO - ##### 06:05:03 INFO - ##### Finished create-virtualenv step (success) 06:05:03 INFO - ##### 06:05:03 INFO - ##### 06:05:03 INFO - ##### Running install step. 06:05:03 INFO - ##### 06:05:03 INFO - Running pre-action listener: _resource_record_pre_action 06:05:03 INFO - Running main action method: install 06:05:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:05:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:05:03 INFO - Reading from file tmpfile_stdout 06:05:03 INFO - Detecting whether we're running mozinstall >=1.0... 06:05:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:05:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:05:03 INFO - Reading from file tmpfile_stdout 06:05:03 INFO - Output received: 06:05:03 INFO - Usage: mozinstall [options] installer 06:05:03 INFO - Options: 06:05:03 INFO - -h, --help show this help message and exit 06:05:03 INFO - -d DEST, --destination=DEST 06:05:03 INFO - Directory to install application into. [default: 06:05:03 INFO - "/builds/slave/test"] 06:05:03 INFO - --app=APP Application being installed. [default: firefox] 06:05:03 INFO - mkdir: /builds/slave/test/build/application 06:05:03 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'] 06:05:03 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 06:05:19 INFO - Reading from file tmpfile_stdout 06:05:19 INFO - Output received: 06:05:19 INFO - /builds/slave/test/build/application/firefox/firefox 06:05:19 INFO - Running post-action listener: _resource_record_post_action 06:05:19 INFO - ##### 06:05:19 INFO - ##### Finished install step (success) 06:05:19 INFO - ##### 06:05:19 INFO - ##### 06:05:19 INFO - ##### Running run-tests step. 06:05:19 INFO - ##### 06:05:19 INFO - Running pre-action listener: _resource_record_pre_action 06:05:19 INFO - Running main action method: run_tests 06:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:05:19 INFO - Python 2.7.3 06:05:19 INFO - Return code: 0 06:05:19 INFO - grabbing minidump binary from tooltool 06:05:19 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')]} 06:05:19 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 0x17fd9c0>, '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 0x17fe8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17fed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:05:19 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 06:05:19 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 06:05:19 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 06:05:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:05:19 INFO - Return code: 0 06:05:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:05:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:05:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:05:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:05:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:05:20 INFO - Return code: 0 06:05:20 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/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 06:05:20 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/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 06:05:20 INFO - Using env: {'DISPLAY': ':0', 06:05:20 INFO - 'HOME': '/home/cltbld', 06:05:20 INFO - 'LANG': 'en_US.UTF-8', 06:05:20 INFO - 'LANGUAGE': 'en_US:en', 06:05:20 INFO - 'LOGNAME': 'cltbld', 06:05:20 INFO - 'MAIL': '/var/mail/cltbld', 06:05:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:05:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:20 INFO - 'MOZ_NO_REMOTE': '1', 06:05:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:05:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:20 INFO - 'NO_EM_RESTART': '1', 06:05:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:20 INFO - 'PWD': '/builds/slave/test', 06:05:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:05:20 INFO - 'SHELL': '/bin/bash', 06:05:20 INFO - 'SHLVL': '1', 06:05:20 INFO - 'TERM': 'linux', 06:05:20 INFO - 'TMOUT': '86400', 06:05:20 INFO - 'USER': 'cltbld', 06:05:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462', 06:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:20 INFO - '_': '/tools/buildbot/bin/python'} 06:05:20 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/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 06:05:20 INFO - mozversion application_buildid: 20160516051534 06:05:20 INFO - mozversion application_changeset: 26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89 06:05:20 INFO - mozversion application_display_name: Nightly 06:05:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:05:20 INFO - mozversion application_name: Firefox 06:05:20 INFO - mozversion application_remotingname: firefox 06:05:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:05:20 INFO - mozversion application_vendor: Mozilla 06:05:20 INFO - mozversion application_version: 49.0a1 06:05:20 INFO - mozversion platform_buildid: 20160516051534 06:05:20 INFO - mozversion platform_changeset: 26656bbb6d39afcac4fbe4d7763ed2c9f05f6f89 06:05:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:05:20 INFO - mozversion platform_version: 49.0a1 06:05:20 INFO - using testdate: 1463403920 06:05:20 INFO - actual date: 1463403920 06:05:20 INFO - starting webserver on 'localhost:52853' 06:05:20 INFO - SUITE-START | Running 2 tests 06:05:20 INFO - TEST-START | dromaeo_css 06:05:20 INFO - operating with platform_type : linux_ 06:05:20 INFO - Initialising browser for dromaeo_css test... 06:05:20 INFO - TEST-INFO | started process 22966 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxX2XGL/profile http://localhost:52853/getInfo.html) 06:05:24 INFO - PROCESS | 22966 | __metrics Screen width/height:1600/1200 06:05:24 INFO - PROCESS | 22966 | colorDepth:24 06:05:24 INFO - PROCESS | 22966 | Browser inner width/height: 1024/697 06:05:24 INFO - PROCESS | 22966 | __metrics 06:05:25 ERROR - PROCESS | 22966 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:05:26 INFO - TEST-INFO | 22966: exit 0 06:05:26 INFO - Browser initialized. 06:05:26 INFO - Running cycle 1/1 for dromaeo_css test... 06:05:26 INFO - TEST-INFO | started process 23049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxX2XGL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:38 INFO - PROCESS | 23049 | RSS: Main: 154488832 06:05:38 INFO - PROCESS | 23049 | 06:06:29 INFO - PROCESS | 23049 | 1463403989728 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] 06:08:41 INFO - PROCESS | 23049 | Cycle 1(1): loaded http://localhost:52853/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52853/tests/dromaeo/cssquery-ext.html) 06:08:42 INFO - PROCESS | 23049 | RSS: Main: 245334016 06:08:42 INFO - PROCESS | 23049 | 06:11:44 INFO - PROCESS | 23049 | Cycle 1(1): loaded http://localhost:52853/tests/dromaeo/cssquery-ext.html (next: http://localhost:52853/tests/dromaeo/cssquery-jquery.html) 06:11:45 INFO - PROCESS | 23049 | RSS: Main: 238485504 06:11:45 INFO - PROCESS | 23049 | 06:14:47 INFO - PROCESS | 23049 | Cycle 1(1): loaded http://localhost:52853/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52853/tests/dromaeo/cssquery-mootools.html) 06:14:48 INFO - PROCESS | 23049 | RSS: Main: 237314048 06:14:48 INFO - PROCESS | 23049 | 06:17:50 INFO - PROCESS | 23049 | Cycle 1(1): loaded http://localhost:52853/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52853/tests/dromaeo/cssquery-prototype.html) 06:17:50 INFO - PROCESS | 23049 | RSS: Main: 236978176 06:17:50 INFO - PROCESS | 23049 | 06:20:53 INFO - PROCESS | 23049 | Cycle 1(1): loaded http://localhost:52853/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52853/tests/dromaeo/cssquery-yui.html) 06:20:54 INFO - PROCESS | 23049 | RSS: Main: 210989056 06:20:54 INFO - PROCESS | 23049 | 06:23:57 INFO - PROCESS | 23049 | Cycle 1(1): loaded http://localhost:52853/tests/dromaeo/cssquery-yui.html (next: http://localhost:52853/tests/dromaeo/cssquery-dojo.html) 06:23:57 INFO - PROCESS | 23049 | RSS: Main: 327581696 06:23:57 INFO - PROCESS | 23049 | 06:23:57 INFO - PROCESS | 23049 | __start_tp_report 06:23:57 INFO - PROCESS | 23049 | _x_x_mozilla_page_load 06:23:57 INFO - PROCESS | 23049 | _x_x_mozilla_page_load_details 06:23:57 INFO - PROCESS | 23049 | |i|pagename|runs| 06:23:57 INFO - PROCESS | 23049 | |0;dojo.html;2672.0914888937764;2684.342336127649;2720.714324995875;2722.060888993298;2727.086426047274;4640.930386044203;4706.341112244284;4707.835225767099;4762.095201911634;4836.032793441308;4694.037722266936;4699.553542413474;4705.0119474910225;4720.126776546342;4764.047190561884;4333.5016473105525;4377.649788016967;4432.534583868695;4464.308032255006;4510.300903359985;4425.446819147606;4444.444444444444;4455.77721113943;4482.350059241408;4505;4242.490901091858;4291.699581029329;4344.087741574257;4398.230309695822;4433.246348120795;4344.413504176927;4353.608175264209;4357.651387888961;4444.888877778049;4461.06317673289;4363.694541382105;4377.102693947733;4377.671674624416;4426.535213802536;4429.047754732748;4453.064856380164;4582.793774280165;4638.976805115953;4690.507496712864;4723.102610503994;5068.594512438996;5098.260752190949;5112.36095488064;5116.155834287338;5117.1556693145585;5061.013102445025;5092.337996060525;5096.388433388017;5135.024345374367;5136.0241554104605;4587.128445595326;4750.809967601257;4765.666403351732;4794.041191761662;4827.758612069382;5228.764705588258;5262.815801446931;5266.78932842682;5278.9208161877605;5289.814856480005;5015.17249653803;5025.39695236574;5058.8482345528955;5068.898622027539;5078.13671675816;4956.10790057793;4979.751012449363;5008.524190201925;5021.422536408287;5115.590752739772;5011.774470148852;5011.899762004739;5014.047331007097;5021.347224860745;5031.77357018935;4975.10448119342;4978.4025916890205;4982.302477653131;4989.80040798364;5028.195488721787;4124.938125928114;4162.271602469556;4170.91658166835;4216.704830661824;4217.578242175758;3743.981280093582;3768.4724138620613;3781.205946751213;3785.621437856192;3786.0345611869348;4348.543402942709;4391.319345501389;4399.12017596482;4411.492678341968;4415.66882483815;5094.490550944876;5099.9490005100215;5103.260027296022;5108.923366149511;5144.022635699205;4401.493828209733;4411.2721400968485;4413.845515406945;4417.558244175557;4459.7993090310365;4390.846320378771;4493.662975276802;4503;4528.660350473728;4536.274196128604;4758.262469317261;4770.570648641639;4780.354652121989;4797.976010119927;4833.154198015333;4941.678790878582;5017.799288028438;5060.367454068241;5071.619628527801;5125.8718532037;4799.760011999316;4830.227163653799;4849.830255941025;4858.805647774191;4862.92705609409;5018.799248030038;5024.171011783015;5039.571636410799;5040.193569028937;5093.490650934877;4946.579540739078;5051.4443411225475;5126.53861152498;5139.6145289102715;5191.143461328989;4929.630277729257;4933.087378834927;4961.3798275215595;4965;5008.924866127084;4951.405831300267;4959.578435832995;4963.255511673278;4973.577245933991;5013.122703526796;4747.715137091785;4805.495422980537;4834.7824347903725;4879.780409881635;4960.578350840219;4943.134951383566;4969.031038947371;4971.105201063843;5005.299258103942;5027.2207807789855;4866.099771542276;4872.512748725099;4873.537013983666;4874.439439464507;4927.433345165208 06:23:57 INFO - PROCESS | 23049 | |1;ext.html;560.6579986208415;593.8515371157214;601.9789307374243;602.1629934391196;612.9478994285486;27606.205596636206;28089.29776755582;29947.251318717044;30065.098047058567;30087.398252034945;41112.794436027856;42397.57602423975;42429.36355954655;45844.312335315;46306.53693463065;7909.485883417588;8072.273495385414;8084.312833409138;8091.069527004382;8101;7949.682012719484;8005.559694216816;8020.759377218664;8025.23760242776;8043.276105150535;8046.718364857231;8059.476134051297;8080.272775450208;8080.797980050487;8081.757547273592;8004.359651227888;8055.194480551927;8060.073091594483;8061;8064.838703225962;7903.407244456689;7953.840923181562;7955.443118981673;7960;7960.084590272077;40044;40348.39477407812;40370;40381.394279085835;40382;3367.2002775437186;3481.582210134775;3523.71810255179;3558.6085530591613;3831.1954489556947;26667.599986000227;26695.265300434974;31027.22431939197;31307.686923130706;31382.372352553048;3401.302732939766;3406.557147570825;3467.8439470223902;3486.599041110254;3501.894943151684;268615;271574;272247.999999998;272418;273425;44873.32690009652;46360.7681961588;46559.534404656195;47583;54150.45849541533;58461.70769146127;58503.41496585065;58844;58892.41107588955;58925;14586;14815.25923703832;14821.481248156479;14823.18472484002;14864.702705946036;10100.545475453622;11078.778424431628;11276.379799111128;11329.830052549218;11621.418929053514;16194.919025405034;16219.51341459758;16234.269457874423;16244;16254.349826007065;6655.700493477805;6806.052489556046;6837.461571146552;6921.342472465108;6928.584284942819;843.6077224090704;985.2462865907586;986.3292960786733;1073.758404359013;1090.8527348807809;28145.127843819322;28528.714712852605;28551.143465696063;28755.856220718764;28843.711562884524;1018.1193267823279;1020.5713600287748;1069.1820757120809;1104.3594715065242;1117.6032508459543;14896.255187240811;15367.924245302946;15413.768793468107;15614.366167882643;15714;384529;388194;388207;388575;388580;50762.492375076516;51106.74446627743;51205.7439712799;51206;51309.48690513122;1144.4392247798519;1261.2936755416813;1281.250468475952;1294.3981048812348;1324.913880597758;26334.868325658248;28936.855315723285;30212;30224.212557103187;30729.539056913716;45343.093138137716;46320.53679463297;46355.76822115868;46442.76778616085;46484.07031859276;350684;361316;361505;361711;363396;33140.668593314724;38979;39589.2082158361;40135.3979690299;40701.76140312193;43533.78233108814;43560.34659480174;44075.559244407144;44616;44893.87765305763;37597;37968.430473542365;37977.582017618544;38269.80865095657;38443.846684599506;35526.28947421089;38336.42495362516;38596.80701596587;39146.80426597963;39448.40827387649;36691.81654091713;37249.6275037257;37536.812315938245;37796.62203378041;38047.809760951015;31998.52002220015;33208.833955830065;33329.50005749867;33512.32975340528;33571.32857342888;25963.87018064973;26015.30900491462;26516.867415662797;26553.33616659599;26835.865820670773 06:23:57 INFO - PROCESS | 23049 | |2;jquery.html;386.31814846795413;389.8031494095482;390.8065507573751;395.6841666831948;413.31596208275295;16357.60960318373;17273.309067637278;17390.652186956253;17831.465056048324;17842.553936151602;17407.82592174078;17532.82467175328;17662.558436039104;17826;18323.358682446116;5073.771680274378;5191.662541934781;5371.999999999981;5385.78456861725;5392.514673679368;5249.947500524984;5259.132243179871;5303.257543943851;5354.785808567653;5356.705381204032;5194.27280180775;5239.292695486099;5239.711815850127;5241.973790131063;5244.895102097975;5144.717040562768;5231.738413079369;5260.132078207092;5264.157734762439;5299.443558426367;4507.1211113832815;4678.087772884289;4683.180443422421;4709.458412282563;4712.905741885177;20815.583688326147;21042.263520776698;21074;21173.576528469344;21356.893215533823;1822.8723989320754;1963.234338607944;1994.371772891549;2148.892555372225;2158;9552;9757.12185903265;9797.706068817946;10057.295989280754;13192.934035329858;1791.2297711983842;1792.1610359128422;1815.3646223821556;1843.327185577268;1880.2103116690887;65371.67314163446;67360.6631966842;69190.65404672995;69572;70142.29857701408;9566.56950437232;9615.423074615546;9808.558614862348;9882;9898.109160244778;12934.741305174031;12964.351782410842;13004.674883127998;13060.934695326463;13158.342082895817;7258.346748792528;7276.96361518189;7362.116546014512;7482.551046937201;7502.17476077631;7246.6376681166785;7257.092863392076;7263.055802745609;7357.301056399633;7373.963130184422;4369.6722745794195;4460.286354183315;4583.854036490878;4619.815207391734;4702.482726900038;1852.3609354772582;1887.8112188781013;1888.122023259191;1905.6569817432994;1941.4563922101834;823.9752807415787;904.0913881549001;917.7338571814099;956.3496822160859;1008.9798204035878;16352.264148113363;16560.6687866242;17049.147542623068;17604.91197544004;17609.471715848544;895.1004240738016;910.8451563234266;960.0495509445599;961.8845738511424;984.9409035457895;6824.454043676494;9826.459544725109;9840.409575425498;9903;10076.546555405024;401676;423268;423281;424634;424697.3946693455;76684.61657691788;78071.60964195142;78115.2188478108;79144.20855791484;79821;946.976325591852;952.2144231009445;961.1974001708512;965.9420434773936;967.5017366056486;15264.236788160326;15381.15403652765;15512.689746204787;15521.76717349218;15736.370545178064;34691.47962780611;34941.47587786236;35412.64587354093;35590.64409355977;35616.28767424689;45012.54987450084;50204.49795502144;50373.49626503688;50384.748076259384;50781.23828142507;7719.652615632198;7801.648925798239;7813.5935531604855;7817.140114587277;7981.082175549886;6668.033135195273;8910.955445222733;9623.893252276079;10870.130389568974;11515.654530364103;9687.467189304656;9802.460864652227;9832.213422926006;10031.097201251923;10074.345167564084;9685.17675997548;9929.404235745878;9947.552360143665;10299.073083422529;10462.110720588531;6335.683215839097;9399.765005874908;9555.474448905377;9908.207343412654;10070.892201857936;7567.246835442951;7852.528848269122;7943;8010.879836802569;8127.1466496017065;7538.246175382418;9215.49314787693;9384.95307523458;9413.811723765622;9601.663941762004 06:23:57 INFO - PROCESS | 23049 | |3;mootools.html;1268.20103334899;1520.961975950601;1542.575791657294;1741.7387391891223;1855.9814401855976;6947.131608548932;7788.4158688098405;7998.32014278787;8006.7597972060785;8022.598870056503;7801.804954876116;8051.798705032377;8066.838663226732;8226.465279756827;8244.29923456507;2280.7947284744328;2332.2187067332466;2337.31049340445;2340.5201933603657;2341.2273949596593;2192.583409152256;2255.8759268240324;2338.754430784769;2341.508283260517;2349.1543044503965;2259.570681570496;2303.8156947444163;2313.1672597864754;2326.116075891159;2327.6857624220684;2240.1711366794307;2244.618414869476;2276.635738281867;2278.1343089626002;2282.429392651837;2297.3337732057685;2298.781615746518;2303.0442366417915;2322.291701031185;2326.430024643956;7821.608919554056;8073.919260807375;8102.918970810276;8145;8147.714829980981;4831.4926932671915;4968.105740966625;4981.153203955337;4982.60139188864;4985.601151907838;2936.6476022877177;2948.6019387382858;2972.1529364131334;3008.6239220097486;3076.7846250762454;908.1962463220098;928.0858354520792;929.7117893453051;935.069605742284;947.0671388682142;11277.210595258335;11468.19722619417;11481.88518114825;11491.42542872853;11492.712682182928;4378.321360189176;4509.7970591323465;4544.113897789965;4600.987782687804;4612.838550650778;9732.70801875945;9757.90242097584;9799.11807937289;9802.460864652512;9804.117629413387;4851.805927762921;4856.271559266068;4859.465458799529;4862.270659401047;4865.781039853215;3749.5687995880276;4352.368906508538;4373.453318335208;4517.390152329459;4526.094781043805;3782.791946442972;3823.770573765583;3857.286402015636;3896.7661940283674;3909.100906791454;1253.59258241072;1266.9809952850715;1287.4013583683632;1290.283892439705;1299.226959958823;712.3837880233664;788.688468055115;820.5158956215861;841.2030791207033;925.3753716241511;5170.45710200431;5341.465853414705;5487.560995120461;5530;5765.913511297334;821.0844907927618;892.1791951404723;917;921.0973246218609;946.8011717539393;3499;3519.137811236212;3587.0852932502044;3605.94591081134;3666.7066634669163;9721.513924303756;10170.135538479164;10266.127379172854;10273.229507786946;10284.331518451278;9900.108990190773;10138;10150;10153.898461015444;10164.0344167304;7544.962275188699;7579.431542634325;7686.500377475446;7704.6532906019365;7706.229377062361;5173.560247378864;5348.919766203432;5424.755885985219;5483.150111732688;5503.422140675331;8778.868316975122;9075.364724469488;9161.77095572616;9195.586198621211;9260.814783704423;8931.598078086372;9235.445873247627;9429;9462.101100395452;9465.432074075577;7184.892226616709;7282.344588987016;7326.084239470067;7348.632568371453;7366.300201480851;7744.5740484271655;7955;7956.721514746956;7963.482373645695;7965.4822436541435;6895.482838787011;7118.359347658736;7161.283871612797;7230.927690723025;7382.778516644509;6911.861762764817;6945.583265004116;7020.7893763187185;7097.858042839011;7121.9643901780155;6460.547761656639;6540.280569137296;6613.636250006296;6620.470362371095;6623.205215374186;4689.554492323224;4806.47128815823;4884.316195732671;4915.5330243626795;4940.308356829974;4831.0820944020525;4863.805447782049;4933.6299777516115;5012.573931215888;5015.5736762374145 06:23:57 INFO - PROCESS | 23049 | |4;prototype.html;319.0810465858328;319.13991792120237;325.6694455128045;328.30235749033307;329.11960505647403;4691.296305554169;4759.762011899405;4779.569838714515;4792.784324705388;4793.0413917216565;4646.744429056401;4665.88335291617;4725.362076119723;4740;4742.810287588501;3555.7333200009975;3627.455881617752;3663.7069034477177;3726.4596633488127;3775.433684947266;3724.8696295629657;3728.4407338899246;3743.9812800936093;3746.868859589915;3748.8125593720342;3541.654171414859;3710.8515659373593;3713.2573485302914;3714.9442758358646;3717.9070523236865;3588.856445742167;3715.6655900969045;3716.7955762433326;3725.807741522714;3740.36413809653;3320.3193345364143;3329.766916315859;3345.548350972612;3348.698617124446;3382.52644629752;4479.843205487792;4484.847273308797;4495.393121928563;4502.414686090788;4516.728996260234;3994.3009973254566;4227.175700738358;4228.851990180329;4311.253942153401;4315.978420107879;4893.608511319086;4897.485763994765;4900.681455705403;4901.950980490185;4908.828191013333;3577.4276115821604;3587.497750314958;3592.191756854713;3597.892063238107;3604.5494313210847;4980.576650984671;5135.486451354872;5171.948280517222;5178.689278643255;5194.506521880416;3625.637436256406;3636.4545318201954;3639.927201455956;3654.543182102237;3671.504346913186;3714.925701486009;3738.3084129436143;3739.5886452490204;3741.607131251234;3742.1018955450495;4231.534531201565;4239.194553034913;4246.787660617018;4247.384129301296;4263.232618128766;4823.614110871122;4868.855818882631;4907.214845624754;4910.779014944336;4945.530174633404;1274.694073422372;1276.8572127945622;1291.3672300572653;1291.4575878131207;1296.4554886947506;838.2815228780975;842.3345557010016;862.719616124762;889.5374405309203;890.8708237305555;4342.457192850894;4343.9348409773875;4344.891377715519;4352.737706065205;4367.912641747147;4988.6009119270375;4996.625253106032;5022.89954200914;5038.79844806211;5052.494750524918;4141.192467468875;4322.848700295474;4329.164397319761;4332.220200363965;4341.479022517318;2640.4719056188837;2645.5105805426056;2651.8674066296608;2664.427148163154;2670.172246603559;4689.600039970994;4732.763361831895;4739.857804265877;4740.691855029412;4754.763761421986;4913.410390753133;5069.670471419346;5104.668196567285;5107.591392688576;5181.715005674724;4808.663393562417;4820.6020254126615;4823.27650852375;4841.685290456109;4843.2250839865455;5075.7969681212335;5079.593632509464;5082.263071854486;5115.437301896863;5131.179011358165;4837.467878533288;4973.45292017885;4986.7257300848805;4991.301217829579;4998.925016124688;4738.8341408050555;4770.236762118045;4798.808047678054;4829.492903245108;4833.782479788489;3633.981830090833;3653.6481501844487;3661.670449659437;3662.7252956028938;3690.8154592270816;4852.8301509447;5045.899082018413;5060.3927528696795;5063.949360506348;5108.66793658411;4873.465797785203;4901.975490122527;4902.730349830794;4906.877328066684;4907.263910413467;4885.413750349839;4898.265260210855;4908.901821963612;4916.877078072934;4927.5565199130815;4625.352450656844;4824.780600923615;4842.6368022397755;4849.224124140262;4852.93235488192;4721.881952951204;4798.760061996956;4923.236898280772;4928;4941.65408421407;4832.178529650038;4839.854804355875;4842.903141937071;4843.564079232886;4849.854504364875 06:23:57 INFO - PROCESS | 23049 | |5;yui.html;635.8887194740921;656.4780999105712;657.9605223686582;679.5650783498564;682.5495173185699;11630.592929247478;12222.266664000166;12255.999999999989;12258.57095001675;12273.324967126804;11541.307521548713;11553.075753939685;11591.768164636702;12515.812262816065;12902.032347573922;679.4734081087148;882.5410786391088;892.8705337726026;898.8921329440443;899.6491368366343;859.6948083430354;896.5203616065406;898.1961144775422;899.4962820820361;899.9145081217274;940.7365937537501;949.0414681171997;949.1315446366566;950.1970834644749;950.980980380392;708.3093983366228;898.4294972692387;941.8163458125634;941.9811603767886;942.2038377570941;676.4216594811414;678.1794029224644;678.5589366911497;678.8506528563709;678.8811957907396;12911.935440322832;12959.740805183937;12959.935200323938;12972.351382430936;12980.415881285271;11956.342401167933;12147.149699521036;12260.693482663004;12430.316332601704;12796.808047879289;11489.425528723614;11536.423178841025;11644.650660480114;11646.76706465866;11729.472173752116;4234.767087810169;4262.2754131797665;4313.352997050468;4315.719478233905;4354.08564201518;48492.51507484915;48768.756156219344;48772;49303.753481232365;51490.74254628703;10258.692239232834;10455;10687.946560267304;10741.087007604441;10798.51406686701;19106.044697765057;19107.713384299248;19109.235630574898;19172.71240931387;19208.13563389651;6783.525153239226;6884.862302754017;6932.445404367639;6950.200726916368;6956.478264130211;3817.2174704185577;3824.847006119724;3901.941470877939;3923.1957448723515;3948.8815335539407;2817.14077206454;2901.695321991203;2902.1873875314946;2903.970960290412;2908.1420980810713;513.2583416962453;514.5369167748981;517.3688100517363;526.1739069660596;526.5497999210696;565.7850016993516;594.3818428833964;609.6037575575912;612.4182027074297;621.5897507645024;7973.20267973198;8268.627911743986;8305.584720763938;8342.188632774929;8438.282745966539;524.910765169922;577.2726364780407;592.6355291495785;596.8716725903864;602.1599868183858;3688.575813781396;3709.740318177756;3710.7216958728204;3729.589745128034;3879.5344558652578;56436;61670.38329616736;61780.69109654423;61999.38000620026;62232.377676222655;52692.73653631784;54400;54469.455305447234;55269;55339;42426.575734242266;42965.57034429678;46114;46228.306575401395;48964;8426.915730842613;8484.703035393732;8592.914070859211;8599.509820980218;8732.738017859474;31041.8447907759;31373.686263137988;32036;32312.83843580767;32394.35211295808;39935.80032099821;41479.170416592104;42048.579514204466;42314.15371692488;42795.35806962836;10487.895121048692;10522.579096836042;10564.26050176511;10754.516046777757;11120.443977800916;12659.367031648564;12698.111132220656;12731.108822382344;13144.671383215496;13463.12489688167;11786.233894796811;11880.287182769061;11997;12320.691982700504;12351.93824030874;11808.173427859967;11942.104342174545;12237.694057648274;12502.812457813323;12533.623991280276;11641.126915481542;11677.88322116802;11843.111766617365;12199.451024703732;12235;9498.715038548855;9755.512224388895;9829.803403931739;9836.016398360392;10022;8892.333989227354;9625;9632.47021413829;9798.644985096867;9988.151007164472 06:23:57 INFO - PROCESS | 23049 | __end_tp_report 06:23:57 INFO - PROCESS | 23049 | __start_cc_report 06:23:57 INFO - PROCESS | 23049 | _x_x_mozilla_cycle_collect,938 06:23:57 INFO - PROCESS | 23049 | __end_cc_report 06:23:57 INFO - PROCESS | 23049 | __startTimestamp1463405037357__endTimestamp 06:23:57 INFO - PROCESS | 23049 | 06:23:57 INFO - PROCESS | 23049 | ------- Summary: start ------- 06:23:57 INFO - PROCESS | 23049 | Number of tests: 6 06:23:57 INFO - PROCESS | 23049 | 06:23:57 INFO - PROCESS | 23049 | [#0] dojo.html Cycles:165 Average:4693.73 Median:4833.15 stddev:486.49 (10.1%) stddev-sans-first:461.41 06:23:57 INFO - PROCESS | 23049 | Values: 2672.1 2684.3 2720.7 2722.1 2727.1 4640.9 4706.3 4707.8 4762.1 4836.0 4694.0 4699.6 4705.0 4720.1 4764.0 4333.5 4377.6 4432.5 4464.3 4510.3 4425.4 4444.4 4455.8 4482.4 4505.0 4242.5 4291.7 4344.1 4398.2 4433.2 4344.4 4353.6 4357.7 4444.9 4461.1 4363.7 4377.1 4377.7 4426.5 4429.0 4453.1 4582.8 4639.0 4690.5 4723.1 5068.6 5098.3 5112.4 5116.2 5117.2 5061.0 5092.3 5096.4 5135.0 5136.0 4587.1 4750.8 4765.7 4794.0 4827.8 5228.8 5262.8 5266.8 5278.9 5289.8 5015.2 5025.4 5058.8 5068.9 5078.1 4956.1 4979.8 5008.5 5021.4 5115.6 5011.8 5011.9 5014.0 5021.3 5031.8 4975.1 4978.4 4982.3 4989.8 5028.2 4124.9 4162.3 4170.9 4216.7 4217.6 3744.0 3768.5 3781.2 3785.6 3786.0 4348.5 4391.3 4399.1 4411.5 4415.7 5094.5 5099.9 5103.3 5108.9 5144.0 4401.5 4411.3 4413.8 4417.6 4459.8 4390.8 4493.7 4503.0 4528.7 4536.3 4758.3 4770.6 4780.4 4798.0 4833.2 4941.7 5017.8 5060.4 5071.6 5125.9 4799.8 4830.2 4849.8 4858.8 4862.9 5018.8 5024.2 5039.6 5040.2 5093.5 4946.6 5051.4 5126.5 5139.6 5191.1 4929.6 4933.1 4961.4 4965.0 5008.9 4951.4 4959.6 4963.3 4973.6 5013.1 4747.7 4805.5 4834.8 4879.8 4960.6 4943.1 4969.0 4971.1 5005.3 5027.2 4866.1 4872.5 4873.5 4874.4 4927.4 06:23:57 INFO - PROCESS | 23049 | 06:23:57 INFO - PROCESS | 23049 | [#1] ext.html Cycles:180 Average:49848.06 Median:38158.81 stddev:90348.82 (236.8%) stddev-sans-first:90526.49 06:23:57 INFO - PROCESS | 23049 | Values: 560.7 593.9 602.0 602.2 612.9 27606.2 28089.3 29947.3 30065.1 30087.4 41112.8 42397.6 42429.4 45844.3 46306.5 7909.5 8072.3 8084.3 8091.1 8101.0 7949.7 8005.6 8020.8 8025.2 8043.3 8046.7 8059.5 8080.3 8080.8 8081.8 8004.4 8055.2 8060.1 8061.0 8064.8 7903.4 7953.8 7955.4 7960.0 7960.1 40044.0 40348.4 40370.0 40381.4 40382.0 3367.2 3481.6 3523.7 3558.6 3831.2 26667.6 26695.3 31027.2 31307.7 31382.4 3401.3 3406.6 3467.8 3486.6 3501.9 268615.0 271574.0 272248.0 272418.0 273425.0 44873.3 46360.8 46559.5 47583.0 54150.5 58461.7 58503.4 58844.0 58892.4 58925.0 14586.0 14815.3 14821.5 14823.2 14864.7 10100.5 11078.8 11276.4 11329.8 11621.4 16194.9 16219.5 16234.3 16244.0 16254.3 6655.7 6806.1 6837.5 6921.3 6928.6 843.6 985.2 986.3 1073.8 1090.9 28145.1 28528.7 28551.1 28755.9 28843.7 1018.1 1020.6 1069.2 1104.4 1117.6 14896.3 15367.9 15413.8 15614.4 15714.0 384529.0 388194.0 388207.0 388575.0 388580.0 50762.5 51106.7 51205.7 51206.0 51309.5 1144.4 1261.3 1281.3 1294.4 1324.9 26334.9 28936.9 30212.0 30224.2 30729.5 45343.1 46320.5 46355.8 46442.8 46484.1 350684.0 361316.0 361505.0 361711.0 363396.0 33140.7 38979.0 39589.2 40135.4 40701.8 43533.8 43560.3 44075.6 44616.0 44893.9 37597.0 37968.4 37977.6 38269.8 38443.8 35526.3 38336.4 38596.8 39146.8 39448.4 36691.8 37249.6 37536.8 37796.6 38047.8 31998.5 33208.8 33329.5 33512.3 33571.3 25963.9 26015.3 26516.9 26553.3 26835.9 06:23:57 INFO - PROCESS | 23049 | 06:23:57 INFO - PROCESS | 23049 | [#2] jquery.html Cycles:180 Average:24978.60 Median:5235.52 stddev:69116.14 (1320.1%) stddev-sans-first:69285.37 06:23:57 INFO - PROCESS | 23049 | Values: 386.3 389.8 390.8 395.7 413.3 16357.6 17273.3 17390.7 17831.5 17842.6 17407.8 17532.8 17662.6 17826.0 18323.4 5073.8 5191.7 5372.0 5385.8 5392.5 5249.9 5259.1 5303.3 5354.8 5356.7 5194.3 5239.3 5239.7 5242.0 5244.9 5144.7 5231.7 5260.1 5264.2 5299.4 4507.1 4678.1 4683.2 4709.5 4712.9 20815.6 21042.3 21074.0 21173.6 21356.9 1822.9 1963.2 1994.4 2148.9 2158.0 9552.0 9757.1 9797.7 10057.3 13192.9 1791.2 1792.2 1815.4 1843.3 1880.2 65371.7 67360.7 69190.7 69572.0 70142.3 9566.6 9615.4 9808.6 9882.0 9898.1 12934.7 12964.4 13004.7 13060.9 13158.3 7258.3 7277.0 7362.1 7482.6 7502.2 7246.6 7257.1 7263.1 7357.3 7374.0 4369.7 4460.3 4583.9 4619.8 4702.5 1852.4 1887.8 1888.1 1905.7 1941.5 824.0 904.1 917.7 956.3 1009.0 16352.3 16560.7 17049.1 17604.9 17609.5 895.1 910.8 960.0 961.9 984.9 6824.5 9826.5 9840.4 9903.0 10076.5 401676.0 423268.0 423281.0 424634.0 424697.4 76684.6 78071.6 78115.2 79144.2 79821.0 947.0 952.2 961.2 965.9 967.5 15264.2 15381.2 15512.7 15521.8 15736.4 34691.5 34941.5 35412.6 35590.6 35616.3 45012.5 50204.5 50373.5 50384.7 50781.2 7719.7 7801.6 7813.6 7817.1 7981.1 6668.0 8911.0 9623.9 10870.1 11515.7 9687.5 9802.5 9832.2 10031.1 10074.3 9685.2 9929.4 9947.6 10299.1 10462.1 6335.7 9399.8 9555.5 9908.2 10070.9 7567.2 7852.5 7943.0 8010.9 8127.1 7538.2 9215.5 9385.0 9413.8 9601.7 06:23:57 INFO - PROCESS | 23049 | 06:23:57 INFO - PROCESS | 23049 | [#3] mootools.html Cycles:180 Average:5390.69 Median:4999.09 stddev:3022.10 (60.5%) stddev-sans-first:3014.69 06:23:57 INFO - PROCESS | 23049 | Values: 1268.2 1521.0 1542.6 1741.7 1856.0 6947.1 7788.4 7998.3 8006.8 8022.6 7801.8 8051.8 8066.8 8226.5 8244.3 2280.8 2332.2 2337.3 2340.5 2341.2 2192.6 2255.9 2338.8 2341.5 2349.2 2259.6 2303.8 2313.2 2326.1 2327.7 2240.2 2244.6 2276.6 2278.1 2282.4 2297.3 2298.8 2303.0 2322.3 2326.4 7821.6 8073.9 8102.9 8145.0 8147.7 4831.5 4968.1 4981.2 4982.6 4985.6 2936.6 2948.6 2972.2 3008.6 3076.8 908.2 928.1 929.7 935.1 947.1 11277.2 11468.2 11481.9 11491.4 11492.7 4378.3 4509.8 4544.1 4601.0 4612.8 9732.7 9757.9 9799.1 9802.5 9804.1 4851.8 4856.3 4859.5 4862.3 4865.8 3749.6 4352.4 4373.5 4517.4 4526.1 3782.8 3823.8 3857.3 3896.8 3909.1 1253.6 1267.0 1287.4 1290.3 1299.2 712.4 788.7 820.5 841.2 925.4 5170.5 5341.5 5487.6 5530.0 5765.9 821.1 892.2 917.0 921.1 946.8 3499.0 3519.1 3587.1 3605.9 3666.7 9721.5 10170.1 10266.1 10273.2 10284.3 9900.1 10138.0 10150.0 10153.9 10164.0 7545.0 7579.4 7686.5 7704.7 7706.2 5173.6 5348.9 5424.8 5483.2 5503.4 8778.9 9075.4 9161.8 9195.6 9260.8 8931.6 9235.4 9429.0 9462.1 9465.4 7184.9 7282.3 7326.1 7348.6 7366.3 7744.6 7955.0 7956.7 7963.5 7965.5 6895.5 7118.4 7161.3 7230.9 7382.8 6911.9 6945.6 7020.8 7097.9 7122.0 6460.5 6540.3 6613.6 6620.5 6623.2 4689.6 4806.5 4884.3 4915.5 4940.3 4831.1 4863.8 4933.6 5012.6 5015.6 06:23:57 INFO - PROCESS | 23049 | 06:23:57 INFO - PROCESS | 23049 | [#4] prototype.html Cycles:180 Average:4103.46 Median:4723.62 stddev:1169.47 (24.8%) stddev-sans-first:1137.74 06:23:57 INFO - PROCESS | 23049 | Values: 319.1 319.1 325.7 328.3 329.1 4691.3 4759.8 4779.6 4792.8 4793.0 4646.7 4665.9 4725.4 4740.0 4742.8 3555.7 3627.5 3663.7 3726.5 3775.4 3724.9 3728.4 3744.0 3746.9 3748.8 3541.7 3710.9 3713.3 3714.9 3717.9 3588.9 3715.7 3716.8 3725.8 3740.4 3320.3 3329.8 3345.5 3348.7 3382.5 4479.8 4484.8 4495.4 4502.4 4516.7 3994.3 4227.2 4228.9 4311.3 4316.0 4893.6 4897.5 4900.7 4902.0 4908.8 3577.4 3587.5 3592.2 3597.9 3604.5 4980.6 5135.5 5171.9 5178.7 5194.5 3625.6 3636.5 3639.9 3654.5 3671.5 3714.9 3738.3 3739.6 3741.6 3742.1 4231.5 4239.2 4246.8 4247.4 4263.2 4823.6 4868.9 4907.2 4910.8 4945.5 1274.7 1276.9 1291.4 1291.5 1296.5 838.3 842.3 862.7 889.5 890.9 4342.5 4343.9 4344.9 4352.7 4367.9 4988.6 4996.6 5022.9 5038.8 5052.5 4141.2 4322.8 4329.2 4332.2 4341.5 2640.5 2645.5 2651.9 2664.4 2670.2 4689.6 4732.8 4739.9 4740.7 4754.8 4913.4 5069.7 5104.7 5107.6 5181.7 4808.7 4820.6 4823.3 4841.7 4843.2 5075.8 5079.6 5082.3 5115.4 5131.2 4837.5 4973.5 4986.7 4991.3 4998.9 4738.8 4770.2 4798.8 4829.5 4833.8 3634.0 3653.6 3661.7 3662.7 3690.8 4852.8 5045.9 5060.4 5063.9 5108.7 4873.5 4902.0 4902.7 4906.9 4907.3 4885.4 4898.3 4908.9 4916.9 4927.6 4625.4 4824.8 4842.6 4849.2 4852.9 4721.9 4798.8 4923.2 4928.0 4941.7 4832.2 4839.9 4842.9 4843.6 4849.9 06:23:57 INFO - PROCESS | 23049 | 06:23:57 INFO - PROCESS | 23049 | [#5] yui.html Cycles:180 Average:13850.78 Median:4314.54 stddev:16202.39 (375.5%) stddev-sans-first:16217.45 06:23:57 INFO - PROCESS | 23049 | Values: 635.9 656.5 658.0 679.6 682.5 11630.6 12222.3 12256.0 12258.6 12273.3 11541.3 11553.1 11591.8 12515.8 12902.0 679.5 882.5 892.9 898.9 899.6 859.7 896.5 898.2 899.5 899.9 940.7 949.0 949.1 950.2 951.0 708.3 898.4 941.8 942.0 942.2 676.4 678.2 678.6 678.9 678.9 12911.9 12959.7 12959.9 12972.4 12980.4 11956.3 12147.1 12260.7 12430.3 12796.8 11489.4 11536.4 11644.7 11646.8 11729.5 4234.8 4262.3 4313.4 4315.7 4354.1 48492.5 48768.8 48772.0 49303.8 51490.7 10258.7 10455.0 10687.9 10741.1 10798.5 19106.0 19107.7 19109.2 19172.7 19208.1 6783.5 6884.9 6932.4 6950.2 6956.5 3817.2 3824.8 3901.9 3923.2 3948.9 2817.1 2901.7 2902.2 2904.0 2908.1 513.3 514.5 517.4 526.2 526.5 565.8 594.4 609.6 612.4 621.6 7973.2 8268.6 8305.6 8342.2 8438.3 524.9 577.3 592.6 596.9 602.2 3688.6 3709.7 3710.7 3729.6 3879.5 56436.0 61670.4 61780.7 61999.4 62232.4 52692.7 54400.0 54469.5 55269.0 55339.0 42426.6 42965.6 46114.0 46228.3 48964.0 8426.9 8484.7 8592.9 8599.5 8732.7 31041.8 31373.7 32036.0 32312.8 32394.4 39935.8 41479.2 42048.6 42314.2 42795.4 10487.9 10522.6 10564.3 10754.5 11120.4 12659.4 12698.1 12731.1 13144.7 13463.1 11786.2 11880.3 11997.0 12320.7 12351.9 11808.2 11942.1 12237.7 12502.8 12533.6 11641.1 11677.9 11843.1 12199.5 12235.0 9498.7 9755.5 9829.8 9836.0 10022.0 8892.3 9625.0 9632.5 9798.6 9988.2 06:23:57 INFO - PROCESS | 23049 | -------- Summary: end -------- 06:23:57 INFO - PROCESS | 23049 | 06:23:58 INFO - TEST-INFO | 23049: exit 0 06:23:58 INFO - TEST-OK | dromaeo_css | took 1117588ms 06:23:58 INFO - TEST-START | kraken 06:23:58 INFO - operating with platform_type : linux_ 06:23:58 INFO - Initialising browser for kraken test... 06:23:58 INFO - TEST-INFO | started process 23228 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD4GiRG/profile http://localhost:52853/getInfo.html) 06:24:02 INFO - PROCESS | 23228 | __metrics Screen width/height:1600/1200 06:24:02 INFO - PROCESS | 23228 | colorDepth:24 06:24:02 INFO - PROCESS | 23228 | Browser inner width/height: 1024/697 06:24:02 INFO - PROCESS | 23228 | __metrics 06:24:02 ERROR - PROCESS | 23228 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:24:03 INFO - TEST-INFO | 23228: exit 0 06:24:03 INFO - Browser initialized. 06:24:03 INFO - Running cycle 1/1 for kraken test... 06:24:03 INFO - TEST-INFO | started process 23310 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD4GiRG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:24:15 INFO - PROCESS | 23310 | RSS: Main: 154042368 06:24:15 INFO - PROCESS | 23310 | 06:24:18 INFO - PROCESS | 23310 | Cycle 1(1): loaded http://localhost:52853/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52853/tests/kraken/driver.html?testName=audio-beat-detection) 06:24:19 INFO - PROCESS | 23310 | RSS: Main: 211173376 06:24:19 INFO - PROCESS | 23310 | 06:24:22 INFO - PROCESS | 23310 | Cycle 1(1): loaded http://localhost:52853/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52853/tests/kraken/driver.html?testName=audio-dft) 06:24:22 INFO - PROCESS | 23310 | RSS: Main: 198873088 06:24:22 INFO - PROCESS | 23310 | 06:24:26 INFO - PROCESS | 23310 | Cycle 1(1): loaded http://localhost:52853/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52853/tests/kraken/driver.html?testName=audio-fft) 06:24:26 INFO - PROCESS | 23310 | RSS: Main: 267010048 06:24:26 INFO - PROCESS | 23310 | 06:24:29 INFO - PROCESS | 23310 | Cycle 1(1): loaded http://localhost:52853/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52853/tests/kraken/driver.html?testName=audio-oscillator) 06:24:29 INFO - PROCESS | 23310 | RSS: Main: 175910912 06:24:29 INFO - PROCESS | 23310 | 06:24:32 INFO - PROCESS | 23310 | Cycle 1(1): loaded http://localhost:52853/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52853/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:24:32 INFO - PROCESS | 23310 | RSS: Main: 179818496 06:24:32 INFO - PROCESS | 23310 | 06:24:35 INFO - PROCESS | 23310 | Cycle 1(1): loaded http://localhost:52853/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52853/tests/kraken/driver.html?testName=imaging-darkroom) 06:24:36 INFO - PROCESS | 23310 | RSS: Main: 215625728 06:24:36 INFO - PROCESS | 23310 | 06:24:40 INFO - PROCESS | 23310 | Cycle 1(1): loaded http://localhost:52853/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52853/tests/kraken/driver.html?testName=imaging-desaturate) 06:24:40 INFO - PROCESS | 23310 | RSS: Main: 214736896 06:24:40 INFO - PROCESS | 23310 | 06:24:43 INFO - PROCESS | 23310 | Cycle 1(1): loaded http://localhost:52853/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52853/tests/kraken/driver.html?testName=json-parse-financial) 06:24:44 INFO - PROCESS | 23310 | RSS: Main: 215293952 06:24:44 INFO - PROCESS | 23310 | 06:24:46 INFO - PROCESS | 23310 | Cycle 1(1): loaded http://localhost:52853/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52853/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:24:46 INFO - PROCESS | 23310 | RSS: Main: 207642624 06:24:46 INFO - PROCESS | 23310 | 06:24:48 INFO - PROCESS | 23310 | Cycle 1(1): loaded http://localhost:52853/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52853/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:24:49 INFO - PROCESS | 23310 | RSS: Main: 210001920 06:24:49 INFO - PROCESS | 23310 | 06:24:51 INFO - PROCESS | 23310 | Cycle 1(1): loaded http://localhost:52853/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52853/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:24:52 INFO - PROCESS | 23310 | RSS: Main: 214204416 06:24:52 INFO - PROCESS | 23310 | 06:24:55 INFO - PROCESS | 23310 | Cycle 1(1): loaded http://localhost:52853/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52853/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:24:55 INFO - PROCESS | 23310 | RSS: Main: 218468352 06:24:55 INFO - PROCESS | 23310 | 06:24:58 INFO - PROCESS | 23310 | Cycle 1(1): loaded http://localhost:52853/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52853/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:24:59 INFO - PROCESS | 23310 | RSS: Main: 218148864 06:24:59 INFO - PROCESS | 23310 | 06:25:01 INFO - PROCESS | 23310 | Cycle 1(1): loaded http://localhost:52853/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52853/tests/kraken/driver.html?testName=ai-astar) 06:25:01 INFO - PROCESS | 23310 | RSS: Main: 264691712 06:25:01 INFO - PROCESS | 23310 | 06:25:01 INFO - PROCESS | 23310 | __start_tp_report 06:25:01 INFO - PROCESS | 23310 | _x_x_mozilla_page_load 06:25:01 INFO - PROCESS | 23310 | _x_x_mozilla_page_load_details 06:25:01 INFO - PROCESS | 23310 | |i|pagename|runs| 06:25:01 INFO - PROCESS | 23310 | |0;ai-astar;112;109;112;113;111;115;114;112;113;112 06:25:01 INFO - PROCESS | 23310 | |1;audio-beat-detection;153;137;155;216;131;163;164;131;186;128 06:25:01 INFO - PROCESS | 23310 | |2;audio-dft;161;160;159;160;162;160;162;161;162;160 06:25:01 INFO - PROCESS | 23310 | |3;audio-fft;76;76;76;156;77;78;77;84;127;77 06:25:01 INFO - PROCESS | 23310 | |4;audio-oscillator;94;94;153;93;92;93;129;93;94;116 06:25:01 INFO - PROCESS | 23310 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;117;116;116 06:25:01 INFO - PROCESS | 23310 | |6;imaging-darkroom;146;146;146;146;145;146;145;146;146;145 06:25:01 INFO - PROCESS | 23310 | |7;imaging-desaturate;94;95;94;95;95;94;94;95;94;95 06:25:01 INFO - PROCESS | 23310 | |8;json-parse-financial;67;65;66;65;65;63;64;64;64;65 06:25:01 INFO - PROCESS | 23310 | |9;json-stringify-tinderbox;64;65;65;74;65;64;64;64;64;64 06:25:01 INFO - PROCESS | 23310 | |10;stanford-crypto-aes;84;87;84;88;87;85;83;83;159;82 06:25:01 INFO - PROCESS | 23310 | |11;stanford-crypto-ccm;136;142;141;131;136;135;129;129;156;132 06:25:01 INFO - PROCESS | 23310 | |12;stanford-crypto-pbkdf2;172;171;170;174;171;168;174;170;170;165 06:25:01 INFO - PROCESS | 23310 | |13;stanford-crypto-sha256-iterative;69;71;67;72;79;66;68;65;69;66 06:25:01 INFO - PROCESS | 23310 | __end_tp_report 06:25:01 INFO - PROCESS | 23310 | __start_cc_report 06:25:01 INFO - PROCESS | 23310 | _x_x_mozilla_cycle_collect,2089 06:25:01 INFO - PROCESS | 23310 | __end_cc_report 06:25:01 INFO - PROCESS | 23310 | __startTimestamp1463405101636__endTimestamp 06:25:01 INFO - PROCESS | 23310 | 06:25:01 INFO - PROCESS | 23310 | ------- Summary: start ------- 06:25:01 INFO - PROCESS | 23310 | Number of tests: 14 06:25:01 INFO - PROCESS | 23310 | 06:25:01 INFO - PROCESS | 23310 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.50 stddev:1.64 (1.5%) stddev-sans-first:1.73 06:25:01 INFO - PROCESS | 23310 | Values: 112.0 109.0 112.0 113.0 111.0 115.0 114.0 112.0 113.0 112.0 06:25:01 INFO - PROCESS | 23310 | 06:25:01 INFO - PROCESS | 23310 | [#1] audio-beat-detection Cycles:10 Average:156.40 Median:159.00 stddev:27.92 (17.6%) stddev-sans-first:29.59 06:25:01 INFO - PROCESS | 23310 | Values: 153.0 137.0 155.0 216.0 131.0 163.0 164.0 131.0 186.0 128.0 06:25:01 INFO - PROCESS | 23310 | 06:25:01 INFO - PROCESS | 23310 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 06:25:01 INFO - PROCESS | 23310 | Values: 161.0 160.0 159.0 160.0 162.0 160.0 162.0 161.0 162.0 160.0 06:25:01 INFO - PROCESS | 23310 | 06:25:01 INFO - PROCESS | 23310 | [#3] audio-fft Cycles:10 Average:90.40 Median:77.00 stddev:27.89 (36.2%) stddev-sans-first:29.09 06:25:01 INFO - PROCESS | 23310 | Values: 76.0 76.0 76.0 156.0 77.0 78.0 77.0 84.0 127.0 77.0 06:25:01 INFO - PROCESS | 23310 | 06:25:01 INFO - PROCESS | 23310 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:93.00 stddev:20.99 (22.6%) stddev-sans-first:21.87 06:25:01 INFO - PROCESS | 23310 | Values: 94.0 94.0 153.0 93.0 92.0 93.0 129.0 93.0 94.0 116.0 06:25:01 INFO - PROCESS | 23310 | 06:25:01 INFO - PROCESS | 23310 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:25:01 INFO - PROCESS | 23310 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 06:25:01 INFO - PROCESS | 23310 | 06:25:01 INFO - PROCESS | 23310 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 06:25:01 INFO - PROCESS | 23310 | Values: 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 146.0 145.0 06:25:01 INFO - PROCESS | 23310 | 06:25:01 INFO - PROCESS | 23310 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 06:25:01 INFO - PROCESS | 23310 | Values: 94.0 95.0 94.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 06:25:01 INFO - PROCESS | 23310 | 06:25:01 INFO - PROCESS | 23310 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:1.14 (1.7%) stddev-sans-first:0.88 06:25:01 INFO - PROCESS | 23310 | Values: 67.0 65.0 66.0 65.0 65.0 63.0 64.0 64.0 64.0 65.0 06:25:01 INFO - PROCESS | 23310 | 06:25:01 INFO - PROCESS | 23310 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:64.50 stddev:3.09 (4.8%) stddev-sans-first:3.24 06:25:01 INFO - PROCESS | 23310 | Values: 64.0 65.0 65.0 74.0 65.0 64.0 64.0 64.0 64.0 64.0 06:25:01 INFO - PROCESS | 23310 | 06:25:01 INFO - PROCESS | 23310 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:84.50 stddev:23.56 (27.9%) stddev-sans-first:24.80 06:25:01 INFO - PROCESS | 23310 | Values: 84.0 87.0 84.0 88.0 87.0 85.0 83.0 83.0 159.0 82.0 06:25:01 INFO - PROCESS | 23310 | 06:25:01 INFO - PROCESS | 23310 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:136.00 stddev:8.14 (6.0%) stddev-sans-first:8.63 06:25:01 INFO - PROCESS | 23310 | Values: 136.0 142.0 141.0 131.0 136.0 135.0 129.0 129.0 156.0 132.0 06:25:01 INFO - PROCESS | 23310 | 06:25:01 INFO - PROCESS | 23310 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:171.00 stddev:2.68 (1.6%) stddev-sans-first:2.78 06:25:01 INFO - PROCESS | 23310 | Values: 172.0 171.0 170.0 174.0 171.0 168.0 174.0 170.0 170.0 165.0 06:25:01 INFO - PROCESS | 23310 | 06:25:01 INFO - PROCESS | 23310 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:4.10 (5.9%) stddev-sans-first:4.35 06:25:01 INFO - PROCESS | 23310 | Values: 69.0 71.0 67.0 72.0 79.0 66.0 68.0 65.0 69.0 66.0 06:25:01 INFO - PROCESS | 23310 | -------- Summary: end -------- 06:25:01 INFO - PROCESS | 23310 | 06:25:02 INFO - TEST-INFO | 23310: exit 0 06:25:02 INFO - TEST-OK | kraken | took 64594ms 06:25:02 INFO - SUITE-END | took 1182s 06:25:03 INFO - Completed test suite (00:19:42) 06:25:03 INFO - javascript benchmark 06:25:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2672.0914888937764, 2684.342336127649, 2720.714324995875, 2722.060888993298, 2727.086426047274, 4640.930386044203, 4706.341112244284, 4707.835225767099, 4762.095201911634, 4836.032793441308, 4694.037722266936, 4699.553542413474, 4705.0119474910225, 4720.126776546342, 4764.047190561884, 4333.5016473105525, 4377.649788016967, 4432.534583868695, 4464.308032255006, 4510.300903359985, 4425.446819147606, 4444.444444444444, 4455.77721113943, 4482.350059241408, 4505.0, 4242.490901091858, 4291.699581029329, 4344.087741574257, 4398.230309695822, 4433.246348120795, 4344.413504176927, 4353.608175264209, 4357.651387888961, 4444.888877778049, 4461.06317673289, 4363.694541382105, 4377.102693947733, 4377.671674624416, 4426.535213802536, 4429.047754732748, 4453.064856380164, 4582.793774280165, 4638.976805115953, 4690.507496712864, 4723.102610503994, 5068.594512438996, 5098.260752190949, 5112.36095488064, 5116.155834287338, 5117.1556693145585, 5061.013102445025, 5092.337996060525, 5096.388433388017, 5135.024345374367, 5136.0241554104605, 4587.128445595326, 4750.809967601257, 4765.666403351732, 4794.041191761662, 4827.758612069382, 5228.764705588258, 5262.815801446931, 5266.78932842682, 5278.9208161877605, 5289.814856480005, 5015.17249653803, 5025.39695236574, 5058.8482345528955, 5068.898622027539, 5078.13671675816, 4956.10790057793, 4979.751012449363, 5008.524190201925, 5021.422536408287, 5115.590752739772, 5011.774470148852, 5011.899762004739, 5014.047331007097, 5021.347224860745, 5031.77357018935, 4975.10448119342, 4978.4025916890205, 4982.302477653131, 4989.80040798364, 5028.195488721787, 4124.938125928114, 4162.271602469556, 4170.91658166835, 4216.704830661824, 4217.578242175758, 3743.981280093582, 3768.4724138620613, 3781.205946751213, 3785.621437856192, 3786.0345611869348, 4348.543402942709, 4391.319345501389, 4399.12017596482, 4411.492678341968, 4415.66882483815, 5094.490550944876, 5099.9490005100215, 5103.260027296022, 5108.923366149511, 5144.022635699205, 4401.493828209733, 4411.2721400968485, 4413.845515406945, 4417.558244175557, 4459.7993090310365, 4390.846320378771, 4493.662975276802, 4503.0, 4528.660350473728, 4536.274196128604, 4758.262469317261, 4770.570648641639, 4780.354652121989, 4797.976010119927, 4833.154198015333, 4941.678790878582, 5017.799288028438, 5060.367454068241, 5071.619628527801, 5125.8718532037, 4799.760011999316, 4830.227163653799, 4849.830255941025, 4858.805647774191, 4862.92705609409, 5018.799248030038, 5024.171011783015, 5039.571636410799, 5040.193569028937, 5093.490650934877, 4946.579540739078, 5051.4443411225475, 5126.53861152498, 5139.6145289102715, 5191.143461328989, 4929.630277729257, 4933.087378834927, 4961.3798275215595, 4965.0, 5008.924866127084, 4951.405831300267, 4959.578435832995, 4963.255511673278, 4973.577245933991, 5013.122703526796, 4747.715137091785, 4805.495422980537, 4834.7824347903725, 4879.780409881635, 4960.578350840219, 4943.134951383566, 4969.031038947371, 4971.105201063843, 5005.299258103942, 5027.2207807789855, 4866.099771542276, 4872.512748725099, 4873.537013983666, 4874.439439464507, 4927.433345165208], "value": 4663.380363070914, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.6579986208415, 593.8515371157214, 601.9789307374243, 602.1629934391196, 612.9478994285486, 27606.205596636206, 28089.29776755582, 29947.251318717044, 30065.098047058567, 30087.398252034945, 41112.794436027856, 42397.57602423975, 42429.36355954655, 45844.312335315, 46306.53693463065, 7909.485883417588, 8072.273495385414, 8084.312833409138, 8091.069527004382, 8101.0, 7949.682012719484, 8005.559694216816, 8020.759377218664, 8025.23760242776, 8043.276105150535, 8046.718364857231, 8059.476134051297, 8080.272775450208, 8080.797980050487, 8081.757547273592, 8004.359651227888, 8055.194480551927, 8060.073091594483, 8061.0, 8064.838703225962, 7903.407244456689, 7953.840923181562, 7955.443118981673, 7960.0, 7960.084590272077, 40044.0, 40348.39477407812, 40370.0, 40381.394279085835, 40382.0, 3367.2002775437186, 3481.582210134775, 3523.71810255179, 3558.6085530591613, 3831.1954489556947, 26667.599986000227, 26695.265300434974, 31027.22431939197, 31307.686923130706, 31382.372352553048, 3401.302732939766, 3406.557147570825, 3467.8439470223902, 3486.599041110254, 3501.894943151684, 268615.0, 271574.0, 272247.999999998, 272418.0, 273425.0, 44873.32690009652, 46360.7681961588, 46559.534404656195, 47583.0, 54150.45849541533, 58461.70769146127, 58503.41496585065, 58844.0, 58892.41107588955, 58925.0, 14586.0, 14815.25923703832, 14821.481248156479, 14823.18472484002, 14864.702705946036, 10100.545475453622, 11078.778424431628, 11276.379799111128, 11329.830052549218, 11621.418929053514, 16194.919025405034, 16219.51341459758, 16234.269457874423, 16244.0, 16254.349826007065, 6655.700493477805, 6806.052489556046, 6837.461571146552, 6921.342472465108, 6928.584284942819, 843.6077224090704, 985.2462865907586, 986.3292960786733, 1073.758404359013, 1090.8527348807809, 28145.127843819322, 28528.714712852605, 28551.143465696063, 28755.856220718764, 28843.711562884524, 1018.1193267823279, 1020.5713600287748, 1069.1820757120809, 1104.3594715065242, 1117.6032508459543, 14896.255187240811, 15367.924245302946, 15413.768793468107, 15614.366167882643, 15714.0, 384529.0, 388194.0, 388207.0, 388575.0, 388580.0, 50762.492375076516, 51106.74446627743, 51205.7439712799, 51206.0, 51309.48690513122, 1144.4392247798519, 1261.2936755416813, 1281.250468475952, 1294.3981048812348, 1324.913880597758, 26334.868325658248, 28936.855315723285, 30212.0, 30224.212557103187, 30729.539056913716, 45343.093138137716, 46320.53679463297, 46355.76822115868, 46442.76778616085, 46484.07031859276, 350684.0, 361316.0, 361505.0, 361711.0, 363396.0, 33140.668593314724, 38979.0, 39589.2082158361, 40135.3979690299, 40701.76140312193, 43533.78233108814, 43560.34659480174, 44075.559244407144, 44616.0, 44893.87765305763, 37597.0, 37968.430473542365, 37977.582017618544, 38269.80865095657, 38443.846684599506, 35526.28947421089, 38336.42495362516, 38596.80701596587, 39146.80426597963, 39448.40827387649, 36691.81654091713, 37249.6275037257, 37536.812315938245, 37796.62203378041, 38047.809760951015, 31998.52002220015, 33208.833955830065, 33329.50005749867, 33512.32975340528, 33571.32857342888, 25963.87018064973, 26015.30900491462, 26516.867415662797, 26553.33616659599, 26835.865820670773], "value": 18208.476008299174, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.31814846795413, 389.8031494095482, 390.8065507573751, 395.6841666831948, 413.31596208275295, 16357.60960318373, 17273.309067637278, 17390.652186956253, 17831.465056048324, 17842.553936151602, 17407.82592174078, 17532.82467175328, 17662.558436039104, 17826.0, 18323.358682446116, 5073.771680274378, 5191.662541934781, 5371.999999999981, 5385.78456861725, 5392.514673679368, 5249.947500524984, 5259.132243179871, 5303.257543943851, 5354.785808567653, 5356.705381204032, 5194.27280180775, 5239.292695486099, 5239.711815850127, 5241.973790131063, 5244.895102097975, 5144.717040562768, 5231.738413079369, 5260.132078207092, 5264.157734762439, 5299.443558426367, 4507.1211113832815, 4678.087772884289, 4683.180443422421, 4709.458412282563, 4712.905741885177, 20815.583688326147, 21042.263520776698, 21074.0, 21173.576528469344, 21356.893215533823, 1822.8723989320754, 1963.234338607944, 1994.371772891549, 2148.892555372225, 2158.0, 9552.0, 9757.12185903265, 9797.706068817946, 10057.295989280754, 13192.934035329858, 1791.2297711983842, 1792.1610359128422, 1815.3646223821556, 1843.327185577268, 1880.2103116690887, 65371.67314163446, 67360.6631966842, 69190.65404672995, 69572.0, 70142.29857701408, 9566.56950437232, 9615.423074615546, 9808.558614862348, 9882.0, 9898.109160244778, 12934.741305174031, 12964.351782410842, 13004.674883127998, 13060.934695326463, 13158.342082895817, 7258.346748792528, 7276.96361518189, 7362.116546014512, 7482.551046937201, 7502.17476077631, 7246.6376681166785, 7257.092863392076, 7263.055802745609, 7357.301056399633, 7373.963130184422, 4369.6722745794195, 4460.286354183315, 4583.854036490878, 4619.815207391734, 4702.482726900038, 1852.3609354772582, 1887.8112188781013, 1888.122023259191, 1905.6569817432994, 1941.4563922101834, 823.9752807415787, 904.0913881549001, 917.7338571814099, 956.3496822160859, 1008.9798204035878, 16352.264148113363, 16560.6687866242, 17049.147542623068, 17604.91197544004, 17609.471715848544, 895.1004240738016, 910.8451563234266, 960.0495509445599, 961.8845738511424, 984.9409035457895, 6824.454043676494, 9826.459544725109, 9840.409575425498, 9903.0, 10076.546555405024, 401676.0, 423268.0, 423281.0, 424634.0, 424697.3946693455, 76684.61657691788, 78071.60964195142, 78115.2188478108, 79144.20855791484, 79821.0, 946.976325591852, 952.2144231009445, 961.1974001708512, 965.9420434773936, 967.5017366056486, 15264.236788160326, 15381.15403652765, 15512.689746204787, 15521.76717349218, 15736.370545178064, 34691.47962780611, 34941.47587786236, 35412.64587354093, 35590.64409355977, 35616.28767424689, 45012.54987450084, 50204.49795502144, 50373.49626503688, 50384.748076259384, 50781.23828142507, 7719.652615632198, 7801.648925798239, 7813.5935531604855, 7817.140114587277, 7981.082175549886, 6668.033135195273, 8910.955445222733, 9623.893252276079, 10870.130389568974, 11515.654530364103, 9687.467189304656, 9802.460864652227, 9832.213422926006, 10031.097201251923, 10074.345167564084, 9685.17675997548, 9929.404235745878, 9947.552360143665, 10299.073083422529, 10462.110720588531, 6335.683215839097, 9399.765005874908, 9555.474448905377, 9908.207343412654, 10070.892201857936, 7567.246835442951, 7852.528848269122, 7943.0, 8010.879836802569, 8127.1466496017065, 7538.246175382418, 9215.49314787693, 9384.95307523458, 9413.811723765622, 9601.663941762004], "value": 8203.648925367437, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1268.20103334899, 1520.961975950601, 1542.575791657294, 1741.7387391891223, 1855.9814401855976, 6947.131608548932, 7788.4158688098405, 7998.32014278787, 8006.7597972060785, 8022.598870056503, 7801.804954876116, 8051.798705032377, 8066.838663226732, 8226.465279756827, 8244.29923456507, 2280.7947284744328, 2332.2187067332466, 2337.31049340445, 2340.5201933603657, 2341.2273949596593, 2192.583409152256, 2255.8759268240324, 2338.754430784769, 2341.508283260517, 2349.1543044503965, 2259.570681570496, 2303.8156947444163, 2313.1672597864754, 2326.116075891159, 2327.6857624220684, 2240.1711366794307, 2244.618414869476, 2276.635738281867, 2278.1343089626002, 2282.429392651837, 2297.3337732057685, 2298.781615746518, 2303.0442366417915, 2322.291701031185, 2326.430024643956, 7821.608919554056, 8073.919260807375, 8102.918970810276, 8145.0, 8147.714829980981, 4831.4926932671915, 4968.105740966625, 4981.153203955337, 4982.60139188864, 4985.601151907838, 2936.6476022877177, 2948.6019387382858, 2972.1529364131334, 3008.6239220097486, 3076.7846250762454, 908.1962463220098, 928.0858354520792, 929.7117893453051, 935.069605742284, 947.0671388682142, 11277.210595258335, 11468.19722619417, 11481.88518114825, 11491.42542872853, 11492.712682182928, 4378.321360189176, 4509.7970591323465, 4544.113897789965, 4600.987782687804, 4612.838550650778, 9732.70801875945, 9757.90242097584, 9799.11807937289, 9802.460864652512, 9804.117629413387, 4851.805927762921, 4856.271559266068, 4859.465458799529, 4862.270659401047, 4865.781039853215, 3749.5687995880276, 4352.368906508538, 4373.453318335208, 4517.390152329459, 4526.094781043805, 3782.791946442972, 3823.770573765583, 3857.286402015636, 3896.7661940283674, 3909.100906791454, 1253.59258241072, 1266.9809952850715, 1287.4013583683632, 1290.283892439705, 1299.226959958823, 712.3837880233664, 788.688468055115, 820.5158956215861, 841.2030791207033, 925.3753716241511, 5170.45710200431, 5341.465853414705, 5487.560995120461, 5530.0, 5765.913511297334, 821.0844907927618, 892.1791951404723, 917.0, 921.0973246218609, 946.8011717539393, 3499.0, 3519.137811236212, 3587.0852932502044, 3605.94591081134, 3666.7066634669163, 9721.513924303756, 10170.135538479164, 10266.127379172854, 10273.229507786946, 10284.331518451278, 9900.108990190773, 10138.0, 10150.0, 10153.898461015444, 10164.0344167304, 7544.962275188699, 7579.431542634325, 7686.500377475446, 7704.6532906019365, 7706.229377062361, 5173.560247378864, 5348.919766203432, 5424.755885985219, 5483.150111732688, 5503.422140675331, 8778.868316975122, 9075.364724469488, 9161.77095572616, 9195.586198621211, 9260.814783704423, 8931.598078086372, 9235.445873247627, 9429.0, 9462.101100395452, 9465.432074075577, 7184.892226616709, 7282.344588987016, 7326.084239470067, 7348.632568371453, 7366.300201480851, 7744.5740484271655, 7955.0, 7956.721514746956, 7963.482373645695, 7965.4822436541435, 6895.482838787011, 7118.359347658736, 7161.283871612797, 7230.927690723025, 7382.778516644509, 6911.861762764817, 6945.583265004116, 7020.7893763187185, 7097.858042839011, 7121.9643901780155, 6460.547761656639, 6540.280569137296, 6613.636250006296, 6620.470362371095, 6623.205215374186, 4689.554492323224, 4806.47128815823, 4884.316195732671, 4915.5330243626795, 4940.308356829974, 4831.0820944020525, 4863.805447782049, 4933.6299777516115, 5012.573931215888, 5015.5736762374145], "value": 4337.068138792187, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.0810465858328, 319.13991792120237, 325.6694455128045, 328.30235749033307, 329.11960505647403, 4691.296305554169, 4759.762011899405, 4779.569838714515, 4792.784324705388, 4793.0413917216565, 4646.744429056401, 4665.88335291617, 4725.362076119723, 4740.0, 4742.810287588501, 3555.7333200009975, 3627.455881617752, 3663.7069034477177, 3726.4596633488127, 3775.433684947266, 3724.8696295629657, 3728.4407338899246, 3743.9812800936093, 3746.868859589915, 3748.8125593720342, 3541.654171414859, 3710.8515659373593, 3713.2573485302914, 3714.9442758358646, 3717.9070523236865, 3588.856445742167, 3715.6655900969045, 3716.7955762433326, 3725.807741522714, 3740.36413809653, 3320.3193345364143, 3329.766916315859, 3345.548350972612, 3348.698617124446, 3382.52644629752, 4479.843205487792, 4484.847273308797, 4495.393121928563, 4502.414686090788, 4516.728996260234, 3994.3009973254566, 4227.175700738358, 4228.851990180329, 4311.253942153401, 4315.978420107879, 4893.608511319086, 4897.485763994765, 4900.681455705403, 4901.950980490185, 4908.828191013333, 3577.4276115821604, 3587.497750314958, 3592.191756854713, 3597.892063238107, 3604.5494313210847, 4980.576650984671, 5135.486451354872, 5171.948280517222, 5178.689278643255, 5194.506521880416, 3625.637436256406, 3636.4545318201954, 3639.927201455956, 3654.543182102237, 3671.504346913186, 3714.925701486009, 3738.3084129436143, 3739.5886452490204, 3741.607131251234, 3742.1018955450495, 4231.534531201565, 4239.194553034913, 4246.787660617018, 4247.384129301296, 4263.232618128766, 4823.614110871122, 4868.855818882631, 4907.214845624754, 4910.779014944336, 4945.530174633404, 1274.694073422372, 1276.8572127945622, 1291.3672300572653, 1291.4575878131207, 1296.4554886947506, 838.2815228780975, 842.3345557010016, 862.719616124762, 889.5374405309203, 890.8708237305555, 4342.457192850894, 4343.9348409773875, 4344.891377715519, 4352.737706065205, 4367.912641747147, 4988.6009119270375, 4996.625253106032, 5022.89954200914, 5038.79844806211, 5052.494750524918, 4141.192467468875, 4322.848700295474, 4329.164397319761, 4332.220200363965, 4341.479022517318, 2640.4719056188837, 2645.5105805426056, 2651.8674066296608, 2664.427148163154, 2670.172246603559, 4689.600039970994, 4732.763361831895, 4739.857804265877, 4740.691855029412, 4754.763761421986, 4913.410390753133, 5069.670471419346, 5104.668196567285, 5107.591392688576, 5181.715005674724, 4808.663393562417, 4820.6020254126615, 4823.27650852375, 4841.685290456109, 4843.2250839865455, 5075.7969681212335, 5079.593632509464, 5082.263071854486, 5115.437301896863, 5131.179011358165, 4837.467878533288, 4973.45292017885, 4986.7257300848805, 4991.301217829579, 4998.925016124688, 4738.8341408050555, 4770.236762118045, 4798.808047678054, 4829.492903245108, 4833.782479788489, 3633.981830090833, 3653.6481501844487, 3661.670449659437, 3662.7252956028938, 3690.8154592270816, 4852.8301509447, 5045.899082018413, 5060.3927528696795, 5063.949360506348, 5108.66793658411, 4873.465797785203, 4901.975490122527, 4902.730349830794, 4906.877328066684, 4907.263910413467, 4885.413750349839, 4898.265260210855, 4908.901821963612, 4916.877078072934, 4927.5565199130815, 4625.352450656844, 4824.780600923615, 4842.6368022397755, 4849.224124140262, 4852.93235488192, 4721.881952951204, 4798.760061996956, 4923.236898280772, 4928.0, 4941.65408421407, 4832.178529650038, 4839.854804355875, 4842.903141937071, 4843.564079232886, 4849.854504364875], "value": 3741.9516677292786, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.8887194740921, 656.4780999105712, 657.9605223686582, 679.5650783498564, 682.5495173185699, 11630.592929247478, 12222.266664000166, 12255.999999999989, 12258.57095001675, 12273.324967126804, 11541.307521548713, 11553.075753939685, 11591.768164636702, 12515.812262816065, 12902.032347573922, 679.4734081087148, 882.5410786391088, 892.8705337726026, 898.8921329440443, 899.6491368366343, 859.6948083430354, 896.5203616065406, 898.1961144775422, 899.4962820820361, 899.9145081217274, 940.7365937537501, 949.0414681171997, 949.1315446366566, 950.1970834644749, 950.980980380392, 708.3093983366228, 898.4294972692387, 941.8163458125634, 941.9811603767886, 942.2038377570941, 676.4216594811414, 678.1794029224644, 678.5589366911497, 678.8506528563709, 678.8811957907396, 12911.935440322832, 12959.740805183937, 12959.935200323938, 12972.351382430936, 12980.415881285271, 11956.342401167933, 12147.149699521036, 12260.693482663004, 12430.316332601704, 12796.808047879289, 11489.425528723614, 11536.423178841025, 11644.650660480114, 11646.76706465866, 11729.472173752116, 4234.767087810169, 4262.2754131797665, 4313.352997050468, 4315.719478233905, 4354.08564201518, 48492.51507484915, 48768.756156219344, 48772.0, 49303.753481232365, 51490.74254628703, 10258.692239232834, 10455.0, 10687.946560267304, 10741.087007604441, 10798.51406686701, 19106.044697765057, 19107.713384299248, 19109.235630574898, 19172.71240931387, 19208.13563389651, 6783.525153239226, 6884.862302754017, 6932.445404367639, 6950.200726916368, 6956.478264130211, 3817.2174704185577, 3824.847006119724, 3901.941470877939, 3923.1957448723515, 3948.8815335539407, 2817.14077206454, 2901.695321991203, 2902.1873875314946, 2903.970960290412, 2908.1420980810713, 513.2583416962453, 514.5369167748981, 517.3688100517363, 526.1739069660596, 526.5497999210696, 565.7850016993516, 594.3818428833964, 609.6037575575912, 612.4182027074297, 621.5897507645024, 7973.20267973198, 8268.627911743986, 8305.584720763938, 8342.188632774929, 8438.282745966539, 524.910765169922, 577.2726364780407, 592.6355291495785, 596.8716725903864, 602.1599868183858, 3688.575813781396, 3709.740318177756, 3710.7216958728204, 3729.589745128034, 3879.5344558652578, 56436.0, 61670.38329616736, 61780.69109654423, 61999.38000620026, 62232.377676222655, 52692.73653631784, 54400.0, 54469.455305447234, 55269.0, 55339.0, 42426.575734242266, 42965.57034429678, 46114.0, 46228.306575401395, 48964.0, 8426.915730842613, 8484.703035393732, 8592.914070859211, 8599.509820980218, 8732.738017859474, 31041.8447907759, 31373.686263137988, 32036.0, 32312.83843580767, 32394.35211295808, 39935.80032099821, 41479.170416592104, 42048.579514204466, 42314.15371692488, 42795.35806962836, 10487.895121048692, 10522.579096836042, 10564.26050176511, 10754.516046777757, 11120.443977800916, 12659.367031648564, 12698.111132220656, 12731.108822382344, 13144.671383215496, 13463.12489688167, 11786.233894796811, 11880.287182769061, 11997.0, 12320.691982700504, 12351.93824030874, 11808.173427859967, 11942.104342174545, 12237.694057648274, 12502.812457813323, 12533.623991280276, 11641.126915481542, 11677.88322116802, 11843.111766617365, 12199.451024703732, 12235.0, 9498.715038548855, 9755.512224388895, 9829.803403931739, 9836.016398360392, 10022.0, 8892.333989227354, 9625.0, 9632.47021413829, 9798.644985096867, 9988.151007164472], "value": 6290.13707256482, "unit": "score"}], "name": "dromaeo_css", "value": 6436.716648842836, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 112.0, 113.0, 111.0, 115.0, 114.0, 112.0, 113.0, 112.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 137.0, 155.0, 216.0, 131.0, 163.0, 164.0, 131.0, 186.0, 128.0], "value": 156.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 160.0, 162.0, 160.0, 162.0, 161.0, 162.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 156.0, 77.0, 78.0, 77.0, 84.0, 127.0, 77.0], "value": 90.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 153.0, 93.0, 92.0, 93.0, 129.0, 93.0, 94.0, 116.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 65.0, 65.0, 63.0, 64.0, 64.0, 64.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 74.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 84.0, 88.0, 87.0, 85.0, 83.0, 83.0, 159.0, 82.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 142.0, 141.0, 131.0, 136.0, 135.0, 129.0, 129.0, 156.0, 132.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 170.0, 174.0, 171.0, 168.0, 174.0, 170.0, 170.0, 165.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 67.0, 72.0, 79.0, 66.0, 68.0, 65.0, 69.0, 66.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1580.4, "alertThreshold": 2.0}]} 06:25:03 INFO - Return code: 0 06:25:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:25:03 ERROR - # TBPL SUCCESS # 06:25:03 INFO - Running post-action listener: _resource_record_post_action 06:25:03 INFO - ##### 06:25:03 INFO - ##### Finished run-tests step (success) 06:25:03 INFO - ##### 06:25:03 INFO - Running post-run listener: _resource_record_post_run 06:25:03 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 532676608; Read time: 12; Write time: 382444 06:25:03 INFO - TinderboxPrint: CPU usage
13.0% 06:25:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:25:03 INFO - TinderboxPrint: I/O write bytes / time
532,676,608 / 382,444 06:25:03 INFO - TinderboxPrint: CPU idle
8,327.2 (86.9%) 06:25:03 INFO - TinderboxPrint: CPU user
1,208.8 (12.6%) 06:25:03 INFO - TinderboxPrint: Swap in / out
0 / 0 06:25:03 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236204032; Read time: 0; Write time: 213324 06:25:03 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296472576; Read time: 12; Write time: 169120 06:25:04 INFO - Running post-run listener: _upload_blobber_files 06:25:04 INFO - Blob upload gear active. 06:25:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:25:04 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 06:25:04 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'] 06:25:04 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 06:25:04 INFO - (blobuploader) - INFO - Open directory for files ... 06:25:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:25:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:25:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:25:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:25:05 INFO - (blobuploader) - INFO - Done attempting. 06:25:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:25:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:25:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:25:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:25:06 INFO - (blobuploader) - INFO - Done attempting. 06:25:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:25:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:25:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:25:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:25:10 INFO - (blobuploader) - INFO - Done attempting. 06:25:10 INFO - (blobuploader) - INFO - Iteration through files over. 06:25:10 INFO - Return code: 0 06:25:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:25:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:25:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8015fa9226171028544c2e9a0d8275406b1bf769e4cc379a4d42f9791c4cd36b0e47f578cf48ba9dd1e2ed8ce998b52631448fc834e2ac8fae6af389d8630c47", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ee7dc175d7f716f320d03fd5416bd3b45c2e548011448db316ac86d4c82a3869c0c5a4ae75a48a2f235f64132893a8faf88bb33a86d6e30306a2d5340f5eb9b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e209282bdb55a770f91f92f10a3df3f699fe418bc17a6e267fb36fb52725444a525f82f2e2716d556a523bba50f20557ece35f7d2f25c6d31d6d5f49b825c0c"} 06:25:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:25:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:25:10 INFO - Contents: 06:25:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8015fa9226171028544c2e9a0d8275406b1bf769e4cc379a4d42f9791c4cd36b0e47f578cf48ba9dd1e2ed8ce998b52631448fc834e2ac8fae6af389d8630c47", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ee7dc175d7f716f320d03fd5416bd3b45c2e548011448db316ac86d4c82a3869c0c5a4ae75a48a2f235f64132893a8faf88bb33a86d6e30306a2d5340f5eb9b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e209282bdb55a770f91f92f10a3df3f699fe418bc17a6e267fb36fb52725444a525f82f2e2716d556a523bba50f20557ece35f7d2f25c6d31d6d5f49b825c0c"} 06:25:10 INFO - Running post-run listener: copy_logs_to_upload_dir 06:25:10 INFO - Copying logs to upload dir... 06:25:10 INFO - mkdir: /builds/slave/test/build/upload/logs 06:25:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.705683 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-05-16 06:25:10.389771) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 06:25:10.393245) ========= 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=0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462 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/8015fa9226171028544c2e9a0d8275406b1bf769e4cc379a4d42f9791c4cd36b0e47f578cf48ba9dd1e2ed8ce998b52631448fc834e2ac8fae6af389d8630c47", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ee7dc175d7f716f320d03fd5416bd3b45c2e548011448db316ac86d4c82a3869c0c5a4ae75a48a2f235f64132893a8faf88bb33a86d6e30306a2d5340f5eb9b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e209282bdb55a770f91f92f10a3df3f699fe418bc17a6e267fb36fb52725444a525f82f2e2716d556a523bba50f20557ece35f7d2f25c6d31d6d5f49b825c0c"} build_url:https://queue.taskcluster.net/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/MZ8VelB5TiiHKvuwLJ7hvg/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/8015fa9226171028544c2e9a0d8275406b1bf769e4cc379a4d42f9791c4cd36b0e47f578cf48ba9dd1e2ed8ce998b52631448fc834e2ac8fae6af389d8630c47", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ee7dc175d7f716f320d03fd5416bd3b45c2e548011448db316ac86d4c82a3869c0c5a4ae75a48a2f235f64132893a8faf88bb33a86d6e30306a2d5340f5eb9b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e209282bdb55a770f91f92f10a3df3f699fe418bc17a6e267fb36fb52725444a525f82f2e2716d556a523bba50f20557ece35f7d2f25c6d31d6d5f49b825c0c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 06:25:10.418804) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 06:25:10.419191) ========= 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=0333a256a5e4f052382dd180000001b1-1463403521.549414-241775462 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 06:25:10.501890) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 06:25:10.502264) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 06:25:10.502624) ========= ========= Total master_lag: 0.16 =========