builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1465430944.47 results: success (0) buildid: 20160608143002 builduid: 97e75280e81449e3b3a4410e9740a2e3 revision: 97074800423c429ca7ae01ca5db8c2e61b0fee17 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:04.469931) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:04.470416) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:04.470718) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:04.485667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:04.486055) ========= 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=5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 17:09:04-- 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% 82.0M=0s 2016-06-08 17:09:04 (82.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154100 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:04.653922) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:04.654263) ========= 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=5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014886 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:04.704695) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 17:09:04.705051) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 97074800423c429ca7ae01ca5db8c2e61b0fee17 --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 97074800423c429ca7ae01ca5db8c2e61b0fee17 --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=5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 17:09:05,055 truncating revision to first 12 chars 2016-06-08 17:09:05,055 Setting DEBUG logging. 2016-06-08 17:09:05,055 attempt 1/10 2016-06-08 17:09:05,055 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/97074800423c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 17:09:06,071 unpacking tar archive at: fx-team-97074800423c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.338427 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 17:09:06.056787) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:06.057110) ========= script_repo_revision: 97074800423c429ca7ae01ca5db8c2e61b0fee17 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:06.057543) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:06.057810) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 17:09:06.067999) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-08 17:09:06.068281) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:09:06 INFO - MultiFileLogger online at 20160608 17:09:06 in /builds/slave/test 17:09:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:09:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:09:06 INFO - {'append_to_log': False, 17:09:06 INFO - 'base_work_dir': '/builds/slave/test', 17:09:06 INFO - 'blob_upload_branch': 'Fx-Team', 17:09:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:09:06 INFO - 'branch': 'Fx-Team', 17:09:06 INFO - 'buildbot_json_path': 'buildprops.json', 17:09:06 INFO - 'config_files': ('talos/linux_config.py',), 17:09:06 INFO - 'default_actions': ('clobber', 17:09:06 INFO - 'read-buildbot-config', 17:09:06 INFO - 'download-and-extract', 17:09:06 INFO - 'populate-webroot', 17:09:06 INFO - 'create-virtualenv', 17:09:06 INFO - 'install', 17:09:06 INFO - 'run-tests'), 17:09:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:09:06 INFO - 'download_minidump_stackwalk': True, 17:09:06 INFO - 'download_symbols': 'ondemand', 17:09:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:09:06 INFO - 'tooltool.py': '/tools/tooltool.py', 17:09:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:09:06 INFO - '/tools/misc-python/virtualenv.py')}, 17:09:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:09:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:09:06 INFO - 'installer_path': 'installer.exe', 17:09:06 INFO - 'log_level': 'info', 17:09:06 INFO - 'log_name': 'talos', 17:09:06 INFO - 'log_to_console': True, 17:09:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:09:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:09:06 INFO - 'opt_config_files': (), 17:09:06 INFO - 'pip_index': False, 17:09:06 INFO - 'sps_profile': False, 17:09:06 INFO - 'sps_profile_interval': 0, 17:09:06 INFO - 'suite': 'dromaeojs', 17:09:06 INFO - 'system_bits': '32', 17:09:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:09:06 INFO - 'title': 'talos-linux64-ix-039', 17:09:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:09:06 INFO - 'use_talos_json': True, 17:09:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:09:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:09:06 INFO - 'work_dir': 'build'} 17:09:06 INFO - ##### 17:09:06 INFO - ##### Running clobber step. 17:09:06 INFO - ##### 17:09:06 INFO - Running pre-action listener: _resource_record_pre_action 17:09:06 INFO - Running main action method: clobber 17:09:06 INFO - rmtree: /builds/slave/test/build 17:09:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:09:07 INFO - Running post-action listener: _resource_record_post_action 17:09:07 INFO - ##### 17:09:07 INFO - ##### Finished clobber step (success) 17:09:07 INFO - ##### 17:09:07 INFO - ##### 17:09:07 INFO - ##### Running read-buildbot-config step. 17:09:07 INFO - ##### 17:09:07 INFO - Running pre-action listener: _resource_record_pre_action 17:09:07 INFO - Running main action method: read_buildbot_config 17:09:07 INFO - Using buildbot properties: 17:09:07 INFO - { 17:09:07 INFO - "project": "", 17:09:07 INFO - "product": "firefox", 17:09:07 INFO - "script_repo_revision": "production", 17:09:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:09:07 INFO - "repository": "", 17:09:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:09:07 INFO - "buildid": "20160608143002", 17:09:07 INFO - "pgo_build": "True", 17:09:07 INFO - "basedir": "/builds/slave/test", 17:09:07 INFO - "buildnumber": 784, 17:09:07 INFO - "slavename": "talos-linux64-ix-039", 17:09:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:09:07 INFO - "platform": "ubuntu64_hw", 17:09:07 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:09:07 INFO - "branch": "fx-team", 17:09:07 INFO - "repo_path": "integration/fx-team", 17:09:07 INFO - "revision": "97074800423c429ca7ae01ca5db8c2e61b0fee17", 17:09:07 INFO - "stage_platform": "linux64-pgo", 17:09:07 INFO - "builduid": "97e75280e81449e3b3a4410e9740a2e3", 17:09:07 INFO - "slavebuilddir": "test" 17:09:07 INFO - } 17:09:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:09:07 INFO - Running post-action listener: _resource_record_post_action 17:09:07 INFO - ##### 17:09:07 INFO - ##### Finished read-buildbot-config step (success) 17:09:07 INFO - ##### 17:09:07 INFO - ##### 17:09:07 INFO - ##### Running download-and-extract step. 17:09:07 INFO - ##### 17:09:07 INFO - Running pre-action listener: _resource_record_pre_action 17:09:07 INFO - Running main action method: download_and_extract 17:09:07 INFO - mkdir: /builds/slave/test/build/tests 17:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:07 INFO - https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:09:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:09:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:09:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:09:08 INFO - Downloaded 1361 bytes. 17:09:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:09:08 INFO - Using the following test package requirements: 17:09:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:09:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:09:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:08 INFO - u'jsshell-linux-x86_64.zip'], 17:09:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:09:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:09:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:09:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:09:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:09:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:09:08 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')]} 17:09:08 INFO - https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:09:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:09:09 INFO - Downloaded 24450461 bytes. 17:09:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:09:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:09:10 INFO - Return code: 0 17:09:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:10 INFO - https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:09:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:09:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:09:11 INFO - Downloaded 24450461 bytes. 17:09:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:09:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:09:13 INFO - Return code: 0 17:09:13 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')]} 17:09:13 INFO - https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:09:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:09:14 INFO - Downloaded 10833369 bytes. 17:09:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:09:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:09:15 INFO - Return code: 0 17:09:15 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')]} 17:09:15 INFO - https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:09:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:09:16 INFO - Downloaded 59325241 bytes. 17:09:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:16 INFO - mkdir: /builds/slave/test/properties 17:09:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:09:16 INFO - Writing to file /builds/slave/test/properties/build_url 17:09:16 INFO - Contents: 17:09:16 INFO - build_url:https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:09:17 INFO - Running post-action listener: _resource_record_post_action 17:09:17 INFO - Running post-action listener: set_extra_try_arguments 17:09:17 INFO - ##### 17:09:17 INFO - ##### Finished download-and-extract step (success) 17:09:17 INFO - ##### 17:09:17 INFO - ##### 17:09:17 INFO - ##### Running populate-webroot step. 17:09:17 INFO - ##### 17:09:17 INFO - Running pre-action listener: _resource_record_pre_action 17:09:17 INFO - Running main action method: populate_webroot 17:09:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:09:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:09:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:09:17 INFO - '--tppagecycles', 17:09:17 INFO - '7'], 17:09:17 INFO - 'tests': ['tsvgm']}}, 17:09:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:09:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:09:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:09:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:09:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:09:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:09:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:17 INFO - 'talos_options': ['--disable-e10s'], 17:09:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:17 INFO - 'talos_options': ['--disable-e10s'], 17:09:17 INFO - 'tests': ['damp', 'tps']}, 17:09:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:17 INFO - 'tests': ['damp', 'tps']}, 17:09:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:09:17 INFO - 'tests': ['dromaeo_dom']}, 17:09:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:09:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:09:17 INFO - 'tests': ['a11yr', 17:09:17 INFO - 'ts_paint', 17:09:17 INFO - 'tpaint', 17:09:17 INFO - 'sessionrestore', 17:09:17 INFO - 'sessionrestore_no_auto_restore', 17:09:17 INFO - 'tabpaint']}, 17:09:17 INFO - 'other-e10s': {'tests': ['a11yr', 17:09:17 INFO - 'ts_paint', 17:09:17 INFO - 'tpaint', 17:09:17 INFO - 'sessionrestore', 17:09:17 INFO - 'sessionrestore_no_auto_restore', 17:09:17 INFO - 'tabpaint']}, 17:09:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:09:17 INFO - 'ts_paint', 17:09:17 INFO - 'tpaint', 17:09:17 INFO - 'sessionrestore', 17:09:17 INFO - 'sessionrestore_no_auto_restore', 17:09:17 INFO - 'tabpaint']}, 17:09:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:09:17 INFO - 'ts_paint', 17:09:17 INFO - 'tpaint', 17:09:17 INFO - 'sessionrestore', 17:09:17 INFO - 'sessionrestore_no_auto_restore', 17:09:17 INFO - 'tabpaint']}, 17:09:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:09:17 INFO - 'tests': ['a11yr', 17:09:17 INFO - 'ts_paint', 17:09:17 INFO - 'tpaint', 17:09:17 INFO - 'sessionrestore', 17:09:17 INFO - 'sessionrestore_no_auto_restore', 17:09:17 INFO - 'tabpaint']}, 17:09:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:09:17 INFO - 'tests': ['a11yr', 17:09:17 INFO - 'ts_paint', 17:09:17 INFO - 'tpaint', 17:09:17 INFO - 'sessionrestore', 17:09:17 INFO - 'sessionrestore_no_auto_restore', 17:09:17 INFO - 'tabpaint']}, 17:09:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:09:17 INFO - 'tests': ['tsvgx', 17:09:17 INFO - 'tsvgr_opacity', 17:09:17 INFO - 'tart', 17:09:17 INFO - 'tscrollx', 17:09:17 INFO - 'cart']}, 17:09:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:09:17 INFO - 'tsvgr_opacity', 17:09:17 INFO - 'tart', 17:09:17 INFO - 'tscrollx', 17:09:17 INFO - 'cart']}, 17:09:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:17 INFO - 'talos_options': ['--disable-e10s'], 17:09:17 INFO - 'tests': ['tp5o']}, 17:09:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:17 INFO - 'tests': ['tp5o']}, 17:09:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:17 INFO - 'talos_options': ['--disable-e10s', 17:09:17 INFO - '--xperf_path', 17:09:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:17 INFO - 'tests': ['tp5n']}, 17:09:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:17 INFO - 'talos_options': ['--xperf_path', 17:09:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:17 INFO - 'tests': ['tp5n']}}, 17:09:17 INFO - 'talos.zip': {'path': '', 17:09:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:09:17 INFO - Running post-action listener: _resource_record_post_action 17:09:17 INFO - ##### 17:09:17 INFO - ##### Finished populate-webroot step (success) 17:09:17 INFO - ##### 17:09:17 INFO - ##### 17:09:17 INFO - ##### Running create-virtualenv step. 17:09:17 INFO - ##### 17:09:17 INFO - Running pre-action listener: _resource_record_pre_action 17:09:17 INFO - Running main action method: create_virtualenv 17:09:17 INFO - Creating virtualenv /builds/slave/test/build/venv 17:09:17 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 17:09:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:09:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:09:17 INFO - Using real prefix '/usr' 17:09:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:09:17 INFO - Installing distribute.............................................................................................................................................................................................done. 17:09:19 INFO - Installing pip.................done. 17:09:19 INFO - Return code: 0 17:09:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:19 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 0x7f203322cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e110>, '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 0x1d7a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7a6c0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', '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 17:09:19 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 17:09:19 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 17:09:19 INFO - Using env: {'DISPLAY': ':0', 17:09:19 INFO - 'HOME': '/home/cltbld', 17:09:19 INFO - 'LANG': 'en_US.UTF-8', 17:09:19 INFO - 'LANGUAGE': 'en_US:en', 17:09:19 INFO - 'LOGNAME': 'cltbld', 17:09:19 INFO - 'MAIL': '/var/mail/cltbld', 17:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:19 INFO - 'MOZ_NO_REMOTE': '1', 17:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:19 INFO - 'NO_EM_RESTART': '1', 17:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:19 INFO - 'PWD': '/builds/slave/test', 17:09:19 INFO - 'SHELL': '/bin/bash', 17:09:19 INFO - 'SHLVL': '1', 17:09:19 INFO - 'TERM': 'linux', 17:09:19 INFO - 'TMOUT': '86400', 17:09:19 INFO - 'USER': 'cltbld', 17:09:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', 17:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:19 INFO - '_': '/tools/buildbot/bin/python'} 17:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:20 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 17:09:20 INFO - Cleaning up... 17:09:20 INFO - Return code: 0 17:09:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:20 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 0x7f203322cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e110>, '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 0x1d7a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7a6c0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', '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 17:09:20 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 17:09:20 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 17:09:20 INFO - Using env: {'DISPLAY': ':0', 17:09:20 INFO - 'HOME': '/home/cltbld', 17:09:20 INFO - 'LANG': 'en_US.UTF-8', 17:09:20 INFO - 'LANGUAGE': 'en_US:en', 17:09:20 INFO - 'LOGNAME': 'cltbld', 17:09:20 INFO - 'MAIL': '/var/mail/cltbld', 17:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:20 INFO - 'MOZ_NO_REMOTE': '1', 17:09:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:20 INFO - 'NO_EM_RESTART': '1', 17:09:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:20 INFO - 'PWD': '/builds/slave/test', 17:09:20 INFO - 'SHELL': '/bin/bash', 17:09:20 INFO - 'SHLVL': '1', 17:09:20 INFO - 'TERM': 'linux', 17:09:20 INFO - 'TMOUT': '86400', 17:09:20 INFO - 'USER': 'cltbld', 17:09:20 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', 17:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:20 INFO - '_': '/tools/buildbot/bin/python'} 17:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:20 INFO - Downloading/unpacking psutil>=3.1.1 17:09:20 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 17:09:20 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 17:09:20 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 17:09:20 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 17:09:20 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 17:09:20 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 17:09:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:09:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:22 INFO - Installing collected packages: psutil 17:09:22 INFO - Running setup.py install for psutil 17:09:22 INFO - building 'psutil._psutil_linux' extension 17:09:22 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 17:09:22 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 17:09:22 INFO - building 'psutil._psutil_posix' extension 17:09:22 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 17:09:22 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 17:09:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:22 INFO - Successfully installed psutil 17:09:22 INFO - Cleaning up... 17:09:22 INFO - Return code: 0 17:09:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:22 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 0x7f203322cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e110>, '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 0x1d7a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7a6c0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', '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 17:09:22 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 17:09:22 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 17:09:22 INFO - Using env: {'DISPLAY': ':0', 17:09:22 INFO - 'HOME': '/home/cltbld', 17:09:22 INFO - 'LANG': 'en_US.UTF-8', 17:09:22 INFO - 'LANGUAGE': 'en_US:en', 17:09:22 INFO - 'LOGNAME': 'cltbld', 17:09:22 INFO - 'MAIL': '/var/mail/cltbld', 17:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:22 INFO - 'MOZ_NO_REMOTE': '1', 17:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:22 INFO - 'NO_EM_RESTART': '1', 17:09:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:22 INFO - 'PWD': '/builds/slave/test', 17:09:22 INFO - 'SHELL': '/bin/bash', 17:09:22 INFO - 'SHLVL': '1', 17:09:22 INFO - 'TERM': 'linux', 17:09:22 INFO - 'TMOUT': '86400', 17:09:22 INFO - 'USER': 'cltbld', 17:09:22 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', 17:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:22 INFO - '_': '/tools/buildbot/bin/python'} 17:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:09:23 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 17:09:23 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 17:09:23 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 17:09:23 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 17:09:23 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 17:09:23 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 17:09:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:09:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:09:24 INFO - Installing collected packages: mozsystemmonitor 17:09:24 INFO - Running setup.py install for mozsystemmonitor 17:09:25 INFO - Successfully installed mozsystemmonitor 17:09:25 INFO - Cleaning up... 17:09:25 INFO - Return code: 0 17:09:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:25 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f203322cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e110>, '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 0x1d7a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7a6c0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', '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 17:09:25 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==2.5.1'] in /builds/slave/test/build 17:09:25 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==2.5.1 17:09:25 INFO - Using env: {'DISPLAY': ':0', 17:09:25 INFO - 'HOME': '/home/cltbld', 17:09:25 INFO - 'LANG': 'en_US.UTF-8', 17:09:25 INFO - 'LANGUAGE': 'en_US:en', 17:09:25 INFO - 'LOGNAME': 'cltbld', 17:09:25 INFO - 'MAIL': '/var/mail/cltbld', 17:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:25 INFO - 'MOZ_NO_REMOTE': '1', 17:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:25 INFO - 'NO_EM_RESTART': '1', 17:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:25 INFO - 'PWD': '/builds/slave/test', 17:09:25 INFO - 'SHELL': '/bin/bash', 17:09:25 INFO - 'SHLVL': '1', 17:09:25 INFO - 'TERM': 'linux', 17:09:25 INFO - 'TMOUT': '86400', 17:09:25 INFO - 'USER': 'cltbld', 17:09:25 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', 17:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:25 INFO - '_': '/tools/buildbot/bin/python'} 17:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:25 INFO - Downloading/unpacking jsonschema==2.5.1 17:09:25 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 17:09:25 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 17:09:25 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 17:09:25 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 17:09:25 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 17:09:25 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 17:09:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:09:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:09:27 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 17:09:27 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 17:09:27 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 17:09:27 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 17:09:27 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 17:09:27 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 17:09:27 INFO - Downloading functools32-3.2.3-2.tar.gz 17:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:09:27 INFO - warning: no files found matching '*.txt' 17:09:27 INFO - no previously-included directories found matching 'build' 17:09:27 INFO - no previously-included directories found matching 'dist' 17:09:27 INFO - no previously-included directories found matching '.git*' 17:09:27 INFO - Installing collected packages: jsonschema, functools32 17:09:27 INFO - Running setup.py install for functools32 17:09:27 INFO - warning: no files found matching '*.txt' 17:09:27 INFO - no previously-included directories found matching 'build' 17:09:27 INFO - no previously-included directories found matching 'dist' 17:09:27 INFO - no previously-included directories found matching '.git*' 17:09:27 INFO - Successfully installed jsonschema functools32 17:09:27 INFO - Cleaning up... 17:09:27 INFO - Return code: 0 17:09:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:27 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 0x7f203322cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e110>, '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 0x1d7a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7a6c0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', '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 17:09:27 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 17:09:27 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 17:09:27 INFO - Using env: {'DISPLAY': ':0', 17:09:27 INFO - 'HOME': '/home/cltbld', 17:09:27 INFO - 'LANG': 'en_US.UTF-8', 17:09:27 INFO - 'LANGUAGE': 'en_US:en', 17:09:27 INFO - 'LOGNAME': 'cltbld', 17:09:27 INFO - 'MAIL': '/var/mail/cltbld', 17:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:27 INFO - 'MOZ_NO_REMOTE': '1', 17:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:27 INFO - 'NO_EM_RESTART': '1', 17:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:27 INFO - 'PWD': '/builds/slave/test', 17:09:27 INFO - 'SHELL': '/bin/bash', 17:09:27 INFO - 'SHLVL': '1', 17:09:27 INFO - 'TERM': 'linux', 17:09:27 INFO - 'TMOUT': '86400', 17:09:27 INFO - 'USER': 'cltbld', 17:09:27 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', 17:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:27 INFO - '_': '/tools/buildbot/bin/python'} 17:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:27 INFO - Downloading/unpacking blobuploader==1.2.4 17:09:27 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 17:09:27 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 17:09:27 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 17:09:27 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 17:09:27 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 17:09:27 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 17:09:29 INFO - Downloading blobuploader-1.2.4.tar.gz 17:09:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:09:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:09:29 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 17:09:29 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 17:09:29 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 17:09:29 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 17:09:29 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 17:09:29 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 17:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:09:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:09:30 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 17:09:30 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 17:09:30 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 17:09:30 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 17:09:30 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 17:09:30 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 17:09:30 INFO - Downloading docopt-0.6.1.tar.gz 17:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:09:30 INFO - Installing collected packages: blobuploader, requests, docopt 17:09:30 INFO - Running setup.py install for blobuploader 17:09:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:09:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:09:30 INFO - Running setup.py install for requests 17:09:31 INFO - Running setup.py install for docopt 17:09:31 INFO - Successfully installed blobuploader requests docopt 17:09:31 INFO - Cleaning up... 17:09:31 INFO - Return code: 0 17:09:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:31 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')]} 17:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:31 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')]} 17:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:31 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 0x7f203322cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e110>, '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 0x1d7a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7a6c0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', '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 17:09:31 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 17:09:31 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 17:09:31 INFO - Using env: {'DISPLAY': ':0', 17:09:31 INFO - 'HOME': '/home/cltbld', 17:09:31 INFO - 'LANG': 'en_US.UTF-8', 17:09:31 INFO - 'LANGUAGE': 'en_US:en', 17:09:31 INFO - 'LOGNAME': 'cltbld', 17:09:31 INFO - 'MAIL': '/var/mail/cltbld', 17:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:31 INFO - 'MOZ_NO_REMOTE': '1', 17:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:31 INFO - 'NO_EM_RESTART': '1', 17:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:31 INFO - 'PWD': '/builds/slave/test', 17:09:31 INFO - 'SHELL': '/bin/bash', 17:09:31 INFO - 'SHLVL': '1', 17:09:31 INFO - 'TERM': 'linux', 17:09:31 INFO - 'TMOUT': '86400', 17:09:31 INFO - 'USER': 'cltbld', 17:09:31 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', 17:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:31 INFO - '_': '/tools/buildbot/bin/python'} 17:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:31 INFO - Running setup.py (path:/tmp/pip-YaZGCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:31 INFO - Running setup.py (path:/tmp/pip-34zvlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:31 INFO - Running setup.py (path:/tmp/pip-CjFPwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:31 INFO - Running setup.py (path:/tmp/pip-xhxn9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:31 INFO - Running setup.py (path:/tmp/pip-jtatdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:31 INFO - Running setup.py (path:/tmp/pip-jdZnFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:31 INFO - Running setup.py (path:/tmp/pip-3tVf_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:32 INFO - Running setup.py (path:/tmp/pip-LZFfYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:32 INFO - Running setup.py (path:/tmp/pip-s5_aB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:32 INFO - Running setup.py (path:/tmp/pip-J2vWko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:32 INFO - Running setup.py (path:/tmp/pip-gxOK93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:32 INFO - Running setup.py (path:/tmp/pip-2usNjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:32 INFO - Running setup.py (path:/tmp/pip-bw2KJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:32 INFO - Running setup.py (path:/tmp/pip-uN1Ntv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:32 INFO - Running setup.py (path:/tmp/pip-Rahhff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:32 INFO - Running setup.py (path:/tmp/pip-2JB9z9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:32 INFO - Running setup.py (path:/tmp/pip-64WVaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:09:32 INFO - Running setup.py install for manifestparser 17:09:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:09:32 INFO - Running setup.py install for mozcrash 17:09:32 INFO - Running setup.py install for mozdebug 17:09:33 INFO - Running setup.py install for mozdevice 17:09:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:09:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:09:33 INFO - Running setup.py install for mozfile 17:09:33 INFO - Running setup.py install for mozhttpd 17:09:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:09:33 INFO - Running setup.py install for mozinfo 17:09:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:09:33 INFO - Running setup.py install for mozInstall 17:09:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:09:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:09:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:09:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:09:33 INFO - Running setup.py install for mozleak 17:09:33 INFO - Running setup.py install for mozlog 17:09:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:09:33 INFO - Running setup.py install for moznetwork 17:09:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:09:33 INFO - Running setup.py install for mozprocess 17:09:33 INFO - Running setup.py install for mozprofile 17:09:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:09:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:09:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:09:34 INFO - Running setup.py install for mozrunner 17:09:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:09:34 INFO - Running setup.py install for mozscreenshot 17:09:34 INFO - Running setup.py install for moztest 17:09:34 INFO - Running setup.py install for mozversion 17:09:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:09:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:09:34 INFO - Cleaning up... 17:09:34 INFO - Return code: 0 17:09:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:34 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')]} 17:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:34 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')]} 17:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:34 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 0x7f203322cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e110>, '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 0x1d7a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7a6c0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', '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 17:09:34 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 17:09:34 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 17:09:34 INFO - Using env: {'DISPLAY': ':0', 17:09:34 INFO - 'HOME': '/home/cltbld', 17:09:34 INFO - 'LANG': 'en_US.UTF-8', 17:09:34 INFO - 'LANGUAGE': 'en_US:en', 17:09:34 INFO - 'LOGNAME': 'cltbld', 17:09:34 INFO - 'MAIL': '/var/mail/cltbld', 17:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:34 INFO - 'MOZ_NO_REMOTE': '1', 17:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:34 INFO - 'NO_EM_RESTART': '1', 17:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:34 INFO - 'PWD': '/builds/slave/test', 17:09:34 INFO - 'SHELL': '/bin/bash', 17:09:34 INFO - 'SHLVL': '1', 17:09:34 INFO - 'TERM': 'linux', 17:09:34 INFO - 'TMOUT': '86400', 17:09:34 INFO - 'USER': 'cltbld', 17:09:34 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', 17:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:34 INFO - '_': '/tools/buildbot/bin/python'} 17:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:34 INFO - Running setup.py (path:/tmp/pip-KqTuXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:34 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)) 17:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:34 INFO - Running setup.py (path:/tmp/pip-tu9rw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:34 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)) 17:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:34 INFO - Running setup.py (path:/tmp/pip-0rCkIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:34 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)) 17:09:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:34 INFO - Running setup.py (path:/tmp/pip-l1bHt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:35 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)) 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:35 INFO - Running setup.py (path:/tmp/pip-UaxCL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:35 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)) 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:35 INFO - Running setup.py (path:/tmp/pip-CqcIZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:35 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)) 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:35 INFO - Running setup.py (path:/tmp/pip-SvT8ZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:35 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)) 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:35 INFO - Running setup.py (path:/tmp/pip-nQubpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:35 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)) 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:35 INFO - Running setup.py (path:/tmp/pip-JxMXVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:35 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)) 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:35 INFO - Running setup.py (path:/tmp/pip-PFpNko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:35 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)) 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:35 INFO - Running setup.py (path:/tmp/pip-NeiJwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:35 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)) 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:35 INFO - Running setup.py (path:/tmp/pip-wKwqzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:35 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)) 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:35 INFO - Running setup.py (path:/tmp/pip-PJEm3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:35 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)) 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:35 INFO - Running setup.py (path:/tmp/pip-uDpDoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:35 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)) 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:35 INFO - Running setup.py (path:/tmp/pip-vqij5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:35 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)) 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:35 INFO - Running setup.py (path:/tmp/pip-FPUXvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:35 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)) 17:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:35 INFO - Running setup.py (path:/tmp/pip-8zhBj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:35 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)) 17:09:35 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)) 17:09:35 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)) 17:09:35 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)) 17:09:35 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)) 17:09:35 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)) 17:09:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:09:35 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 17:09:35 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 17:09:35 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 17:09:35 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 17:09:35 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 17:09:35 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 17:09:37 INFO - Downloading blessings-1.6.tar.gz 17:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:09:37 INFO - Installing collected packages: blessings 17:09:37 INFO - Running setup.py install for blessings 17:09:38 INFO - Successfully installed blessings 17:09:38 INFO - Cleaning up... 17:09:38 INFO - Return code: 0 17:09:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:09:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:38 INFO - Reading from file tmpfile_stdout 17:09:38 INFO - Current package versions: 17:09:38 INFO - argparse == 1.2.1 17:09:38 INFO - blessings == 1.6 17:09:38 INFO - blobuploader == 1.2.4 17:09:38 INFO - docopt == 0.6.1 17:09:38 INFO - functools32 == 3.2.3-2 17:09:38 INFO - jsonschema == 2.5.1 17:09:38 INFO - manifestparser == 1.1 17:09:38 INFO - mozInstall == 1.12 17:09:38 INFO - mozcrash == 0.17 17:09:38 INFO - mozdebug == 0.1 17:09:38 INFO - mozdevice == 0.48 17:09:38 INFO - mozfile == 1.2 17:09:38 INFO - mozhttpd == 0.7 17:09:38 INFO - mozinfo == 0.9 17:09:38 INFO - mozleak == 0.1 17:09:38 INFO - mozlog == 3.2 17:09:38 INFO - moznetwork == 0.27 17:09:38 INFO - mozprocess == 0.22 17:09:38 INFO - mozprofile == 0.28 17:09:38 INFO - mozrunner == 6.11 17:09:38 INFO - mozscreenshot == 0.1 17:09:38 INFO - mozsystemmonitor == 0.3 17:09:38 INFO - moztest == 0.7 17:09:38 INFO - mozversion == 1.4 17:09:38 INFO - psutil == 3.1.1 17:09:38 INFO - requests == 1.2.3 17:09:38 INFO - wsgiref == 0.1.2 17:09:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:38 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')]} 17:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:38 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')]} 17:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:38 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 0x7f203322cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e110>, '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 0x1d7a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7a6c0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', '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 17:09:38 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 17:09:38 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 17:09:38 INFO - Using env: {'DISPLAY': ':0', 17:09:38 INFO - 'HOME': '/home/cltbld', 17:09:38 INFO - 'LANG': 'en_US.UTF-8', 17:09:38 INFO - 'LANGUAGE': 'en_US:en', 17:09:38 INFO - 'LOGNAME': 'cltbld', 17:09:38 INFO - 'MAIL': '/var/mail/cltbld', 17:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:38 INFO - 'MOZ_NO_REMOTE': '1', 17:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:38 INFO - 'NO_EM_RESTART': '1', 17:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:38 INFO - 'PWD': '/builds/slave/test', 17:09:38 INFO - 'SHELL': '/bin/bash', 17:09:38 INFO - 'SHLVL': '1', 17:09:38 INFO - 'TERM': 'linux', 17:09:38 INFO - 'TMOUT': '86400', 17:09:38 INFO - 'USER': 'cltbld', 17:09:38 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', 17:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:38 INFO - '_': '/tools/buildbot/bin/python'} 17:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:38 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)) 17:09:38 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)) 17:09:38 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)) 17:09:38 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)) 17:09:38 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)) 17:09:38 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)) 17:09:38 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)) 17:09:38 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)) 17:09:38 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)) 17:09:38 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)) 17:09:38 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)) 17:09:38 INFO - Cleaning up... 17:09:38 INFO - Return code: 0 17:09:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:09:38 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')]} 17:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:38 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')]} 17:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:38 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 0x7f203322cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e110>, '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 0x1d7a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7a6c0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', '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 17:09:38 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 17:09:38 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 17:09:38 INFO - Using env: {'DISPLAY': ':0', 17:09:38 INFO - 'HOME': '/home/cltbld', 17:09:38 INFO - 'LANG': 'en_US.UTF-8', 17:09:38 INFO - 'LANGUAGE': 'en_US:en', 17:09:38 INFO - 'LOGNAME': 'cltbld', 17:09:38 INFO - 'MAIL': '/var/mail/cltbld', 17:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:38 INFO - 'MOZ_NO_REMOTE': '1', 17:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:38 INFO - 'NO_EM_RESTART': '1', 17:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:38 INFO - 'PWD': '/builds/slave/test', 17:09:38 INFO - 'SHELL': '/bin/bash', 17:09:38 INFO - 'SHLVL': '1', 17:09:38 INFO - 'TERM': 'linux', 17:09:38 INFO - 'TMOUT': '86400', 17:09:38 INFO - 'USER': 'cltbld', 17:09:38 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', 17:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:38 INFO - '_': '/tools/buildbot/bin/python'} 17:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:09:38 INFO - Cleaning up... 17:09:38 INFO - Return code: 0 17:09:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:09:38 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')]} 17:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:38 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')]} 17:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:38 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 0x7f203322cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d7c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0e110>, '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 0x1d7a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7a6c0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', '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 17:09:38 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 17:09:38 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 17:09:38 INFO - Using env: {'DISPLAY': ':0', 17:09:38 INFO - 'HOME': '/home/cltbld', 17:09:38 INFO - 'LANG': 'en_US.UTF-8', 17:09:38 INFO - 'LANGUAGE': 'en_US:en', 17:09:38 INFO - 'LOGNAME': 'cltbld', 17:09:38 INFO - 'MAIL': '/var/mail/cltbld', 17:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:38 INFO - 'MOZ_NO_REMOTE': '1', 17:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:38 INFO - 'NO_EM_RESTART': '1', 17:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:38 INFO - 'PWD': '/builds/slave/test', 17:09:38 INFO - 'SHELL': '/bin/bash', 17:09:38 INFO - 'SHLVL': '1', 17:09:38 INFO - 'TERM': 'linux', 17:09:38 INFO - 'TMOUT': '86400', 17:09:38 INFO - 'USER': 'cltbld', 17:09:38 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', 17:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:38 INFO - '_': '/tools/buildbot/bin/python'} 17:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:38 INFO - Downloading/unpacking flake8 17:09:38 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 17:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:09:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:09:40 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 17:09:40 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 17:09:40 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 17:09:40 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 17:09:40 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 17:09:40 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 17:09:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:09:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:09:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:09:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:09:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:09:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:09:41 INFO - no previously-included directories found matching 'docs/_build' 17:09:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:09:41 INFO - Running setup.py install for pep8 17:09:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:09:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:09:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:09:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:09:41 INFO - no previously-included directories found matching 'docs/_build' 17:09:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:09:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:09:41 INFO - Cleaning up... 17:09:41 INFO - Return code: 0 17:09:41 INFO - Running post-action listener: _resource_record_post_action 17:09:41 INFO - Running post-action listener: _start_resource_monitoring 17:09:41 INFO - Starting resource monitoring. 17:09:41 INFO - ##### 17:09:41 INFO - ##### Finished create-virtualenv step (success) 17:09:41 INFO - ##### 17:09:41 INFO - ##### 17:09:41 INFO - ##### Running install step. 17:09:41 INFO - ##### 17:09:41 INFO - Running pre-action listener: _resource_record_pre_action 17:09:41 INFO - Running main action method: install 17:09:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:42 INFO - Reading from file tmpfile_stdout 17:09:42 INFO - Detecting whether we're running mozinstall >=1.0... 17:09:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:09:42 INFO - Reading from file tmpfile_stdout 17:09:42 INFO - Output received: 17:09:42 INFO - Usage: mozinstall [options] installer 17:09:42 INFO - Options: 17:09:42 INFO - -h, --help show this help message and exit 17:09:42 INFO - -d DEST, --destination=DEST 17:09:42 INFO - Directory to install application into. [default: 17:09:42 INFO - "/builds/slave/test"] 17:09:42 INFO - --app=APP Application being installed. [default: firefox] 17:09:42 INFO - mkdir: /builds/slave/test/build/application 17:09:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:09:59 INFO - Reading from file tmpfile_stdout 17:09:59 INFO - Output received: 17:09:59 INFO - /builds/slave/test/build/application/firefox/firefox 17:09:59 INFO - Running post-action listener: _resource_record_post_action 17:09:59 INFO - ##### 17:09:59 INFO - ##### Finished install step (success) 17:09:59 INFO - ##### 17:09:59 INFO - ##### 17:09:59 INFO - ##### Running run-tests step. 17:09:59 INFO - ##### 17:09:59 INFO - Running pre-action listener: _resource_record_pre_action 17:09:59 INFO - Running main action method: run_tests 17:09:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:09:59 INFO - Python 2.7.3 17:09:59 INFO - Return code: 0 17:09:59 INFO - grabbing minidump binary from tooltool 17:09:59 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')]} 17:09:59 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 0x1e0e110>, '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 0x1d7a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7a6c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:09:59 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 17:09:59 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 17:09:59 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 17:09:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:09:59 INFO - Return code: 0 17:09:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:09:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:09:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:09:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:09:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:09:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:10:00 INFO - Return code: 0 17:10:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 17:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 17:10:00 INFO - Using env: {'DISPLAY': ':0', 17:10:00 INFO - 'HOME': '/home/cltbld', 17:10:00 INFO - 'LANG': 'en_US.UTF-8', 17:10:00 INFO - 'LANGUAGE': 'en_US:en', 17:10:00 INFO - 'LOGNAME': 'cltbld', 17:10:00 INFO - 'MAIL': '/var/mail/cltbld', 17:10:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:10:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:00 INFO - 'MOZ_NO_REMOTE': '1', 17:10:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:00 INFO - 'NO_EM_RESTART': '1', 17:10:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:00 INFO - 'PWD': '/builds/slave/test', 17:10:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:10:00 INFO - 'SHELL': '/bin/bash', 17:10:00 INFO - 'SHLVL': '1', 17:10:00 INFO - 'TERM': 'linux', 17:10:00 INFO - 'TMOUT': '86400', 17:10:00 INFO - 'USER': 'cltbld', 17:10:00 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643', 17:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:00 INFO - '_': '/tools/buildbot/bin/python'} 17:10:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 17:10:00 INFO - mozversion application_buildid: 20160608143002 17:10:00 INFO - mozversion application_changeset: 97074800423c429ca7ae01ca5db8c2e61b0fee17 17:10:00 INFO - mozversion application_display_name: Nightly 17:10:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:10:00 INFO - mozversion application_name: Firefox 17:10:00 INFO - mozversion application_remotingname: firefox 17:10:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:10:00 INFO - mozversion application_vendor: Mozilla 17:10:00 INFO - mozversion application_version: 50.0a1 17:10:00 INFO - mozversion platform_buildid: 20160608143002 17:10:00 INFO - mozversion platform_changeset: 97074800423c429ca7ae01ca5db8c2e61b0fee17 17:10:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:10:00 INFO - mozversion platform_version: 50.0a1 17:10:00 INFO - using testdate: 1465431000 17:10:00 INFO - actual date: 1465431000 17:10:00 INFO - starting webserver on 'localhost:33411' 17:10:00 INFO - SUITE-START | Running 2 tests 17:10:00 INFO - TEST-START | dromaeo_css 17:10:00 INFO - operating with platform_type : linux_ 17:10:00 INFO - Initialising browser for dromaeo_css test... 17:10:00 INFO - TEST-INFO | started process 28444 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjKiJf3/profile http://localhost:33411/getInfo.html) 17:10:04 INFO - PROCESS | 28444 | __metrics Screen width/height:1600/1200 17:10:04 INFO - PROCESS | 28444 | colorDepth:24 17:10:04 INFO - PROCESS | 28444 | Browser inner width/height: 1024/697 17:10:04 INFO - PROCESS | 28444 | __metrics 17:10:05 ERROR - PROCESS | 28444 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:10:05 INFO - PROCESS | 28444 | console.error: PushService: 17:10:05 INFO - PROCESS | 28444 | stateChangeProcessEnqueue: Error transitioning state 17:10:05 INFO - PROCESS | 28444 | UnknownError 17:10:06 INFO - TEST-INFO | 28444: exit 0 17:10:06 INFO - Browser initialized. 17:10:06 INFO - Running cycle 1/1 for dromaeo_css test... 17:10:06 INFO - TEST-INFO | started process 28527 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjKiJf3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:18 INFO - PROCESS | 28527 | RSS: Main: 156160000 17:10:18 INFO - PROCESS | 28527 | 17:11:09 INFO - PROCESS | 28527 | 1465431069086 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] 17:13:16 INFO - PROCESS | 28527 | Cycle 1(1): loaded http://localhost:33411/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33411/tests/dromaeo/cssquery-ext.html) 17:13:17 INFO - PROCESS | 28527 | RSS: Main: 252940288 17:13:17 INFO - PROCESS | 28527 | 17:16:20 INFO - PROCESS | 28527 | Cycle 1(1): loaded http://localhost:33411/tests/dromaeo/cssquery-ext.html (next: http://localhost:33411/tests/dromaeo/cssquery-jquery.html) 17:16:20 INFO - PROCESS | 28527 | RSS: Main: 239300608 17:16:20 INFO - PROCESS | 28527 | 17:19:22 INFO - PROCESS | 28527 | Cycle 1(1): loaded http://localhost:33411/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33411/tests/dromaeo/cssquery-mootools.html) 17:19:23 INFO - PROCESS | 28527 | RSS: Main: 243748864 17:19:23 INFO - PROCESS | 28527 | 17:22:25 INFO - PROCESS | 28527 | Cycle 1(1): loaded http://localhost:33411/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33411/tests/dromaeo/cssquery-prototype.html) 17:22:26 INFO - PROCESS | 28527 | RSS: Main: 238018560 17:22:26 INFO - PROCESS | 28527 | 17:25:28 INFO - PROCESS | 28527 | Cycle 1(1): loaded http://localhost:33411/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33411/tests/dromaeo/cssquery-yui.html) 17:25:29 INFO - PROCESS | 28527 | RSS: Main: 223432704 17:25:29 INFO - PROCESS | 28527 | 17:28:32 INFO - PROCESS | 28527 | Cycle 1(1): loaded http://localhost:33411/tests/dromaeo/cssquery-yui.html (next: http://localhost:33411/tests/dromaeo/cssquery-dojo.html) 17:28:32 INFO - PROCESS | 28527 | RSS: Main: 297467904 17:28:32 INFO - PROCESS | 28527 | 17:28:32 INFO - PROCESS | 28527 | __start_tp_report 17:28:32 INFO - PROCESS | 28527 | _x_x_mozilla_page_load 17:28:32 INFO - PROCESS | 28527 | _x_x_mozilla_page_load_details 17:28:32 INFO - PROCESS | 28527 | |i|pagename|runs| 17:28:32 INFO - PROCESS | 28527 | |0;dojo.html;3142.481490554059;3158.368326334732;3169.9366012679748;3179.650238473769;3215.9839200803995;5128.640995130342;5160.458151894053;5272.710000949946;5334.919976200355;5362.410134885165;5241.973790131054;5266.183741520061;5302.045631786277;5312.521873031426;5330.413654498002;4784.234522476413;4813.253945638432;4871.12319782439;4876.707397556158;4997.375328083989;4908.582770464497;4928.162212423878;4930.728809915453;4981.5018498150075;4995;4701.388819453467;4702.247640377524;4779.928301075487;4782.856514304576;4813.3983252093485;4800.447948485934;4812.254100614376;4866.902661946777;4888.169011268093;4923.876903077416;4708.152532544141;4824.300476430933;4840.6127509799135;4861.659683822134;4889.584385327252;5225;5295.443978382292;5304.6286759926825;5384.380796208447;5405.621606487547;5790.305163380422;5795.304563452412;5808.041673123929;5835.679037652927;5835.854103647401;5462.781488740446;5587.106063029895;5754.1944127822135;5765.625234359753;5807.5644326675665;5266.368035835686;5358.91961620576;5363.758630861621;5365.248865158881;5365.865853353658;5839;5857.794977175864;5858.736356863951;5860.8534786629825;5863.882722345615;5322.36131664195;5520.447955204448;5593.692346920877;5614.326280846324;5627.268455100892;5701.486866182064;5732.627379220421;5750.453706897838;5756.683382414008;5761.3950535194035;5675.347335056521;5692.089265717548;5693.345265294462;5696.686682232434;5696.857578560569;5442.4829641184815;5533.22534845122;5615.494605485526;5644.491995720405;5673.06394444912;4352.107817897323;4371.934420983688;4374.431323927869;4374.606285434326;4410.404595379647;3893.824777885002;3901.882943511699;3904.863329783501;3926.784026878492;3930.606939306104;5135.820246291437;5260.763265653055;5335.226392173113;5429.538489228381;5443.727813609304;5783.94216057834;5793.913091303634;5807.070868660994;5809.7966571170655;5836.766529338864;5444.782208711607;5481.917771233435;5483.479069488392;5484.204790305464;5484.396716361197;4761.619070474354;4851.975740121276;4890.828820991248;4903.681260718042;4909.091818013679;5867.911981320283;5876.471117599436;5876.970615146897;5878.382769809194;5878.617889837147;5472.972635136799;5670.432956704379;5685.090385538294;5694.06048002075;5701.629394089371;5775.047117225611;5869.031609784338;5894.852628684145;5918.911216331672;5946.13781001761;5607.859803504945;5620.578456615852;5634.408387119293;5638.041532939492;5640.689762063126;5416.970775552632;5560.7219639018695;5706.058500347563;5708.543316534584;5737.483626473638;5468.699221542854;5510.641808282448;5526.447355264441;5564.860878477908;5573.665580065209;5452.291202143696;5477.780888764405;5486.451354864482;5506.64206826555;5511.173324001432;5220;5342.973285133549;5348.465153484621;5367.651102678314;5441.7551210196425;5549.1676248563035;5614.354349249726;5618.915716264178;5625.015622266005;5625.071863142535;5450.645708029124;5459.099248624091;5462.644928079662;5463.508284254277;5509.586780991362 17:28:32 INFO - PROCESS | 28527 | |1;ext.html;596.633070661543;624.4068135271492;627.792828366639;639.4117411980978;649.194998202229;31379.372412551736;34388.484172737364;34407.827960860195;34473.31053378937;40923.386149207785;42022.57977420225;42528;42731.35902961458;42775.57224427755;42950.78524607381;8626.999999999984;8739.60671769772;8821.51481668508;8829.117088291183;8832.072632373605;8600.096989816073;8757.562121893912;8770.12298770121;8772.736817895473;8773.166549177819;8711.085336039689;8729.650813967433;8731.781705457382;8733.214010739031;8773.210411063003;8610.182032706884;8652.134786521361;8656.8701469478;8704.56477176145;8720.171583699539;8629.870551941725;8693.652253909837;8754.518501482416;8756.693515726918;8759.649614015432;40183;40471;40565.59434405677;40625.79687101545;40631.18737625261;3219.8551065201887;3224.774265801395;3244.6593107723584;3465.1683595936793;3558.448440491728;28303;30426;30950;31161.688383116107;31903.202419939455;4003.6997225208224;4022.1352409232154;4142.46148000758;4221.113566151112;4221.80307823305;318924;320769;321685;321968.39015805005;322415;33549.32901341959;34250;56770.71614641983;57490;57653.135202971986;35469.29061418809;35641.1089722759;35694.28611427809;35705.642943570754;35748.642513575054;14476.059056161315;14665.853341466662;14678;14682;14686.632834179018;12934.288614126126;12989.675258118434;13017.674558136123;13017.869821301856;13018.674533136558;8136.430449868452;8169.428140030141;8193.672253109928;8260.793480163044;8269.751907442786;3157.826319552401;3179.856906439216;3241.8865339712997;3245.6429792722784;3245.7666086886834;961.4711908450324;1032.2877214721818;1033.478093562746;1037.7872536130076;1069.0752499088233;30821.383572328876;31370.37259254802;31567.84216078905;31607.84196079051;32226.83886580552;1070.2936062198912;1083.6369816111533;1099.2686518733028;1181.6986668399675;1227.2513766602365;16701.164941752864;16907.323707051826;16933.576660583585;16959.915200424166;16984.23570939286;483643;488536;488645;489485;489486;54977.72511137419;56368.718156408955;56373;56399.43600564024;56502;1244.4835393311855;1302.4139137388213;1313.678148853518;1315.7763180259378;1347.5755137131773;25190.874045629655;31512.32145267678;32880.34239315153;34095.82952085224;34176.65823341834;46831.29753053639;46895.29657055215;47288;47299.290510643055;47403.762981184875;411587;422713;423103;423654;424044;23095.769042309363;23895.40261493407;26776;27014.1895743128;27442;45996;46445.303320449544;46651.30023049589;46951;47021;37174.6282537182;39615.603843961195;43046;43316.35025474684;43996;38911.41632875452;39378.80310598543;40239.597604023584;40242.798786005886;40519.3922091163;34334.31331373309;38989.2202155961;40456;40555.1888962225;40868.386974194815;32831.83584082064;35940.82029589835;36122.277554448236;36165.45751813777;36472.27055458929;26516.337091572866;27012.59481107824;27567;27969.580456292766;28994 17:28:32 INFO - PROCESS | 28527 | |2;jquery.html;385.6028290860415;395.97624142551433;397.53488418550313;399.958004409537;413.6504653567736;14303.284835758222;17677.82322176778;18495.722564161548;18971.52571185721;19034.428967130993;18314.175862086206;18334.633307333846;18388.816111838878;18796.624067518642;18800.43598692038;5535.612507124503;5668.518175955028;5736;5739.339975902762;5740.253767010283;4064.9390259146135;4277.059047009653;5534.059209934321;5692.829215123553;5704.11586204139;4286.892827679318;5920.141579470974;6290.905636415458;6291;6414.390632889868;6312.084747711579;6375;6384.808455746335;6407.135036770046;6422.165118534607;5535.114381698949;5651.943480565183;5658.519025882805;5662.292213473316;5682.51698605619;21194.78805211959;21479.570408591742;22242.666360004452;22318.21886233974;22350.888245558668;2198.351486311542;2243.741969673492;2308.6190778521523;2410.9873852981614;2720.5239083160563;12992.545260915822;13398.799018014737;13531.932340338235;14180.22008789516;14187.219702916336;1927.4699457649258;1929.807019298073;1933.2846846666823;1953.2772874036698;1999.8700084494462;76585;76937.23062769357;77343.6132819338;79117.60441197814;80039.19960800375;9934.254930880068;10314.638987635397;10354.53404596795;10640.627578034731;10731.624393146358;12729.745405091846;13390.665233369244;14740.852591473948;14742.11547307165;14766.48317308889;7695.6921723130445;7877;8106.47307924983;8283.461574997606;8326.084130745614;7892.210778922062;7894.21057894206;7921.207879212148;8029.156938521488;8058.476199047043;6459.321771214049;6540.803775886731;6585.440237579764;6638.499104590738;6675.4325882300545;1876.6581893945895;1900.249401486405;1917.7179156803359;1949.6003319319504;1957.9804201957797;930.5254320296698;960.8991055939166;962.711186644004;1032.1123833503182;1060.7189094889861;18336.358227461973;18587.44237672872;18722.531936701693;18765.906170469334;19201.135948882053;993.4486360070231;998.3510718033336;1009.0716540782352;1042.8696412948382;1043.5408420295198;9742.512874356396;10539.578416863393;10702.678919632424;10775.191860610486;10816.351018938889;485120;487103;489122;497198;498102;81584.59207704042;94899;99390.50304748575;100475.49762251142;101164;1022.2639699416409;1043.2280112716687;1062.617457715222;1068.3589846092439;1072.2976450424985;16714;16753.552384640476;16784.58038549046;16918.32326706918;17453.040082795567;40726;40973.59026409817;41153;41433.79283103565;41502.584974149875;54577.45422545724;54957.72521137369;56355.34719256368;56530.43469565416;57380;7148.428125749823;7418.888716669362;8359.164083591591;8371.539565323965;8583.18459746323;12126.454309556268;12186.939065304618;12197.573084941985;12319.63041108768;12818.871811281768;5498.697571633598;11172.262795615126;11184.161187910777;11206.159538034517;11209.103271738404;11019.72450688707;11309.491072901903;11313.490892909675;11319.943400282946;11360.431978401211;10982.682078150672;11136.16478764112;11327.943360283145;11530.711732206426;11662.76674466489;7519.586422746802;7541.396688265036;7597.392208623407;7600.619969001638;7653.268976750085;10644.787104258026;11218.270812397168;11383.260088094248;11428.2000259981;11535.596254131066 17:28:32 INFO - PROCESS | 28527 | |3;mootools.html;1344.636948024033;1480.7556753135734;1506.6986602679463;1635.8445947634978;1807.9367222147227;8498.192671696186;8792.472451652897;8844.248238899701;9108.134727200922;9119.407238529491;8779.122087791233;8968.46189228645;8981.236594889442;9007.189352958232;9012.594433250502;2030.4213299209728;2079.875207487548;2268.4669102760836;2334.87158206299;2362.196853069956;2293.655951607264;2314.259436980167;2319.6868422762964;2319.7912187903084;2324.3491822289784;2316;2332.54515369503;2370.3718514593647;2371.3952941999764;2372.086746602562;1931.507465596278;2179.400664817172;2230.732312122556;2241.4732537853592;2255.086689890597;2231.642937130068;2237.8097861681777;2250.9549809003893;2257.2663884237522;2257.7064981552294;8903.287736981027;8997;8999.820003599956;9004.77488062797;9022.18800307969;5128.615353848476;5296.576273898079;5297.841064768063;5300.681959082467;5302.814401495929;3181;3254.9511757323658;3282.2286762610765;3320.7841490303053;3321.8173000484962;1065.3047789093605;1086.7935092332432;1089.9891001089966;1092.6230450494568;1111.4831603304422;12285.631431057083;12339.321337326444;12347.567835125728;12362.196457230251;12380.938095309555;4462.642988560908;4542.772861356919;4571.22289210835;4650.883727906762;4655.23188673865;10528;10540.736481587868;10546.630867919586;10550.525226364833;10563.524641391155;5237.9476205238225;5295.285136506599;5295.391030031518;5295.967286379119;5303.0454518186325;4267.551907049778;4663;4769.379980602499;4780.020095880336;4838.7338696372035;4040.711967745131;4050.6151915567975;4121.732087414309;4145.771982540929;4181.540030596632;1220.7192345760525;1232.3653318540958;1248.9000879929765;1249.3628249592591;1266.8416447944007;924.9537523123817;1018.6791160784329;1019.9490025498695;1022.4632068164274;1030.057497389895;6108.450239478469;6132.08018797184;6199.814005579839;6231.660193058514;6260.812175634738;450.1626973828676;460.9815607375667;462.53977292594084;464.4867421499262;466.89494863655403;4157.5010998679745;4219.135077309144;4221.282381995068;4223.598758117974;4245.341971994346;10614.840777388345;10828.404437755842;10894.61868834587;10975.725606859893;11094.278871873465;10766.73083172927;10837.891621083845;10872.075873550837;10887.346759194315;10907.29102608328;7533.54798712079;7743.651535680908;7759.922400776033;7857.449978501564;8000.8799868002025;5915.37888521699;5939.643621382731;6013.518918486423;6084.847878803065;6166.784162554289;10036.548355323883;10130.696079117639;10220.59117635316;10229.693109206735;10241.283110182514;10149;10406.895931040895;10443.216758742972;10567.577296908037;10602.363858168535;7227.891581626174;7538.811529711582;7686.500377475446;7707.113681926426;7819.0617125945255;8684.2184203422;8684.522351270742;8721.607527661397;8742.912570874465;8775.956120219358;7521.4734968551675;7674.884876726966;7749.612519373896;7753.883691744515;8025.438219324591;7741.109772376249;7771.72798952034;7813.492123011986;7922.326602238874;7954.681812727426;6796.728130874907;6831.795046148623;6851.588904665736;6858.794236172923;6869.141357330333;5249.816256431007;5271.551918086852;5389.622726409114;5458.645188062763;5520.420355862577;5120.769565369493;5174.586033117266;5233.319668443078;5376.112941364631;5402.432744561765 17:28:32 INFO - PROCESS | 28527 | |4;prototype.html;316.81308028263305;329.80047071521733;332.3983589702638;334.79744754423564;335.67271909887876;5310.3893052299;5366.356037275523;5371.677699338043;5382.946170538298;5386.380566234884;4981;5123.820666276681;5135.22971554267;5142.640015198928;5277.604179686529;3994.460747799039;4074.592540745924;4111.198316328318;4146.771927543984;4165.354684899463;4072.902455235556;4125.422440858282;4132.73137246078;4133.813978370966;4153.525498448038;3879.767213967171;4055.4322394864744;4098.364753463203;4130.876073717794;4137.379393091045;4039.6063358141396;4052.3921411788174;4077.571854955246;4082.83668653252;4105.199486100211;3573.3032058748554;3583.33708263972;3586.8385922633283;3591.1381268495634;3598.4242521196743;4818.02460990992;5079.136546787018;5082.313887625197;5139.820106296262;5161.74191290434;4678.695884767513;4685.859424217245;4706.835260765857;4712.128256272601;4720.504347043579;5458;5473.644213126134;5479.807817166577;5485.424030476783;5502.669839809624;3951.3480275754464;3998.2203470323298;4024.7182697211206;4049.7165198436123;4064;5639.210510528529;5652.208690783294;5658.886822263532;5661.433856614388;5677.460641239076;4058.066644671742;4066.3290557057753;4082.3468245080644;4086.652634526039;4105.199486100182;4144.854930077493;4149.232392007428;4162.439085342997;4163.417121602978;4163.5420103789165;4512.142692888341;4626.282926146453;4655.185342565038;4687.9765601171775;4699.553542413533;5505.485501888493;5533.612647114664;5537.667739935617;5542.806001789918;5551.833444996657;1377.6418131285939;1396.3995481942861;1427.5431861804332;1435.8635929586674;1440.6974535347485;923.0031565908803;939.3049143633798;943.8112377524523;950.5627411390699;967.4678926590348;4711.3639658646325;4719.9292010619865;4726.527347265246;4781.2111001685025;4820.807167713322;4890.388701412324;5002.699838009658;5011.3986321640905;5035.1188542005;5047.116754567936;4592.288195329729;4696.2486002239475;4729.597984171384;4742.5020372861045;4772.737499437564;2652.8010399220134;2657.8803953822126;2666.5733482642686;2666.586679064748;2668.799840011968;5144.871378215575;5170.560502357342;5189.417227745574;5189.7405129743365;5215.6609820361555;4905.828296009622;5068.366454193226;5071.036503064406;5124.385073791094;5133.178691409356;5103.21387514367;5121.92317115251;5153.793848246103;5164;5175.974120129451;4953.603711702983;4962.3052772611145;4994.525520075587;4997.026769072396;5006.974965125151;4769.332293478985;4777.570018698334;4867.926981095357;4913.9017219656125;4964.361760619059;5035.798568057383;5105.795768169231;5165.302684137593;5168.819091331936;5198.556678361164;3733.5146430964887;3741.401375779862;3779.9244015118993;3808.714346423974;3816.904577385588;4784.545468180518;5001.7749201285305;5067.923981140212;5094.694318340911;5097.515736005073;4926.802927882844;4949.861531847767;4955.389498412958;4960.6031517477795;4961.950380496149;4778.187708089564;4826.565609095058;4829.623557286157;4846.80612775485;4892.584130348961;4533;4809.470958194526;4839.2983017462975;4901;4915.574483399774;4940.925886111783;4948.599929034487;4964.900701985868;4970.7514624267915;4974.726390048582;4758.524147585353;4813.374261346003;4854.077725232195;4869.683470574401;4894.800773810439 17:28:32 INFO - PROCESS | 28527 | |5;yui.html;688.6006116452456;694.4583225084433;723.2442098007582;725.5030304241595;754.9393102690722;14443.133411995288;15560.68878622427;15570.221488925537;15623.609409764762;15646.295916683763;13997.440102395893;14063.648408789786;14105.083169593969;14114.364853581588;14116.223607701573;664.9102371179902;765.8468306338726;780.1457404142483;788.3259812860008;790.9841803163933;776.8290975985302;781.679511400326;781.7263957614817;782.12402109637;782.9960850195741;824.1758241758242;825.6697321071559;825.7357645553425;826.8222332198576;827.735124760077;692.190137539078;812.427238796647;822.8683410654296;831.9708810191614;835.1106072033326;585.8242527241811;585.9355470898198;586.2730214533947;586.2818047891299;588.485075558886;13812.585622431343;13845.446182152702;13858.475567687547;13908;14025.018248722594;13065.934670326682;13566.186028838301;13916.443342266297;13980.300984950814;14021.5092471763;10150.28947973642;10548.261621686484;10621.522031508523;11878.703032424171;11945.701357466047;3744.513213282256;3865.9226815463535;4391.736495810262;4402.449693788277;4504.662150338705;70514.64742676305;71836.28163718348;72084.6395768023;74718.62640686816;75060.62469687617;9685.41887486753;10298.124659403884;10347.327423717585;10439.582416703399;10640.627578034731;19645.607087858163;19805.504862378268;19808.108635111166;19853.801461985197;19893.204271828963;8197.959010204911;8365;8423.620937057847;8501.277391421674;8563.529005904611;4419.226635338803;4422.823087076546;4452.864051049417;4528.207563676344;4558.133954548625;3409;3502.404591219499;3502.562179727534;3504.0714210734177;3505.5267538882435;596.0641792385912;597.6234971967633;600.8317671052113;607.6354187487473;630.2468550082699;642.0305338938143;680.3808534233823;740.0305599664457;747.8130467383154;773.9729109481141;9409.48247846375;9483.28875334339;9541.952290238505;9622;9753.9024609753;660.7026837922858;663.2836536540525;709.1525626875937;729.7956572159803;758.7154816943646;4115.403266526397;4438.622717069021;4440.089781594766;4445.422095127613;4490.281554951192;105433;105534;106755.46622266839;109542.45228773805;112450.43774781073;81672.59163704143;89395.2953528488;90398;97010.51494742623;98227.50886245666;65744.6712766433;66154.00768988469;82898.58550707207;87833.5608321967;91018.54490727503;9583.808323833346;9659.093747969953;9677.903220967983;9718.222542196467;9741.805163896825;47016.7649161752;51398;51837.22244166416;52473.7376313116;53425;62314.68842655758;70769.29230707628;74688;76456.61771691329;76713;12400.317982510687;12681.492740290285;12726;13008.869911300766;13666.11170273929;12900.8064879025;13049.543265985645;13240.701281454358;13302.268375239455;13355.599332020054;13092.541761038317;13154.183797096512;13326.405384006412;13397.799033014318;13413.932930335677;12539.686507837378;12823.358832058546;13164.47342106305;13189.604311870658;13647.658808529866;12767.297798621164;13208.207507549578;13433.932830335785;13440;13568.321583920962;10553.419561924167;10865.185111116856;11110;11353.205275630626;11502.53989840397;10389.37663740178;10666.8399974002;10707.250492465453;10925.672229833117;11019.779604408028 17:28:32 INFO - PROCESS | 28527 | __end_tp_report 17:28:32 INFO - PROCESS | 28527 | __start_cc_report 17:28:32 INFO - PROCESS | 28527 | _x_x_mozilla_cycle_collect,899 17:28:32 INFO - PROCESS | 28527 | __end_cc_report 17:28:32 INFO - PROCESS | 28527 | __startTimestamp1465432112261__endTimestamp 17:28:32 INFO - PROCESS | 28527 | 17:28:32 INFO - PROCESS | 28527 | ------- Summary: start ------- 17:28:32 INFO - PROCESS | 28527 | Number of tests: 6 17:28:32 INFO - PROCESS | 28527 | 17:28:32 INFO - PROCESS | 28527 | [#0] dojo.html Cycles:165 Average:5284.20 Median:5462.64 stddev:587.79 (10.8%) stddev-sans-first:565.07 17:28:32 INFO - PROCESS | 28527 | Values: 3142.5 3158.4 3169.9 3179.7 3216.0 5128.6 5160.5 5272.7 5334.9 5362.4 5242.0 5266.2 5302.0 5312.5 5330.4 4784.2 4813.3 4871.1 4876.7 4997.4 4908.6 4928.2 4930.7 4981.5 4995.0 4701.4 4702.2 4779.9 4782.9 4813.4 4800.4 4812.3 4866.9 4888.2 4923.9 4708.2 4824.3 4840.6 4861.7 4889.6 5225.0 5295.4 5304.6 5384.4 5405.6 5790.3 5795.3 5808.0 5835.7 5835.9 5462.8 5587.1 5754.2 5765.6 5807.6 5266.4 5358.9 5363.8 5365.2 5365.9 5839.0 5857.8 5858.7 5860.9 5863.9 5322.4 5520.4 5593.7 5614.3 5627.3 5701.5 5732.6 5750.5 5756.7 5761.4 5675.3 5692.1 5693.3 5696.7 5696.9 5442.5 5533.2 5615.5 5644.5 5673.1 4352.1 4371.9 4374.4 4374.6 4410.4 3893.8 3901.9 3904.9 3926.8 3930.6 5135.8 5260.8 5335.2 5429.5 5443.7 5783.9 5793.9 5807.1 5809.8 5836.8 5444.8 5481.9 5483.5 5484.2 5484.4 4761.6 4852.0 4890.8 4903.7 4909.1 5867.9 5876.5 5877.0 5878.4 5878.6 5473.0 5670.4 5685.1 5694.1 5701.6 5775.0 5869.0 5894.9 5918.9 5946.1 5607.9 5620.6 5634.4 5638.0 5640.7 5417.0 5560.7 5706.1 5708.5 5737.5 5468.7 5510.6 5526.4 5564.9 5573.7 5452.3 5477.8 5486.5 5506.6 5511.2 5220.0 5343.0 5348.5 5367.7 5441.8 5549.2 5614.4 5618.9 5625.0 5625.1 5450.6 5459.1 5462.6 5463.5 5509.6 17:28:32 INFO - PROCESS | 28527 | 17:28:32 INFO - PROCESS | 28527 | [#1] ext.html Cycles:180 Average:55435.66 Median:21809.65 stddev:110290.00 (505.7%) stddev-sans-first:110522.53 17:28:32 INFO - PROCESS | 28527 | Values: 596.6 624.4 627.8 639.4 649.2 31379.4 34388.5 34407.8 34473.3 40923.4 42022.6 42528.0 42731.4 42775.6 42950.8 8627.0 8739.6 8821.5 8829.1 8832.1 8600.1 8757.6 8770.1 8772.7 8773.2 8711.1 8729.7 8731.8 8733.2 8773.2 8610.2 8652.1 8656.9 8704.6 8720.2 8629.9 8693.7 8754.5 8756.7 8759.6 40183.0 40471.0 40565.6 40625.8 40631.2 3219.9 3224.8 3244.7 3465.2 3558.4 28303.0 30426.0 30950.0 31161.7 31903.2 4003.7 4022.1 4142.5 4221.1 4221.8 318924.0 320769.0 321685.0 321968.4 322415.0 33549.3 34250.0 56770.7 57490.0 57653.1 35469.3 35641.1 35694.3 35705.6 35748.6 14476.1 14665.9 14678.0 14682.0 14686.6 12934.3 12989.7 13017.7 13017.9 13018.7 8136.4 8169.4 8193.7 8260.8 8269.8 3157.8 3179.9 3241.9 3245.6 3245.8 961.5 1032.3 1033.5 1037.8 1069.1 30821.4 31370.4 31567.8 31607.8 32226.8 1070.3 1083.6 1099.3 1181.7 1227.3 16701.2 16907.3 16933.6 16959.9 16984.2 483643.0 488536.0 488645.0 489485.0 489486.0 54977.7 56368.7 56373.0 56399.4 56502.0 1244.5 1302.4 1313.7 1315.8 1347.6 25190.9 31512.3 32880.3 34095.8 34176.7 46831.3 46895.3 47288.0 47299.3 47403.8 411587.0 422713.0 423103.0 423654.0 424044.0 23095.8 23895.4 26776.0 27014.2 27442.0 45996.0 46445.3 46651.3 46951.0 47021.0 37174.6 39615.6 43046.0 43316.4 43996.0 38911.4 39378.8 40239.6 40242.8 40519.4 34334.3 38989.2 40456.0 40555.2 40868.4 32831.8 35940.8 36122.3 36165.5 36472.3 26516.3 27012.6 27567.0 27969.6 28994.0 17:28:32 INFO - PROCESS | 28527 | 17:28:32 INFO - PROCESS | 28527 | [#2] jquery.html Cycles:180 Average:28807.26 Median:2276.18 stddev:81044.48 (3560.5%) stddev-sans-first:81243.73 17:28:32 INFO - PROCESS | 28527 | Values: 385.6 396.0 397.5 400.0 413.7 14303.3 17677.8 18495.7 18971.5 19034.4 18314.2 18334.6 18388.8 18796.6 18800.4 5535.6 5668.5 5736.0 5739.3 5740.3 4064.9 4277.1 5534.1 5692.8 5704.1 4286.9 5920.1 6290.9 6291.0 6414.4 6312.1 6375.0 6384.8 6407.1 6422.2 5535.1 5651.9 5658.5 5662.3 5682.5 21194.8 21479.6 22242.7 22318.2 22350.9 2198.4 2243.7 2308.6 2411.0 2720.5 12992.5 13398.8 13531.9 14180.2 14187.2 1927.5 1929.8 1933.3 1953.3 1999.9 76585.0 76937.2 77343.6 79117.6 80039.2 9934.3 10314.6 10354.5 10640.6 10731.6 12729.7 13390.7 14740.9 14742.1 14766.5 7695.7 7877.0 8106.5 8283.5 8326.1 7892.2 7894.2 7921.2 8029.2 8058.5 6459.3 6540.8 6585.4 6638.5 6675.4 1876.7 1900.2 1917.7 1949.6 1958.0 930.5 960.9 962.7 1032.1 1060.7 18336.4 18587.4 18722.5 18765.9 19201.1 993.4 998.4 1009.1 1042.9 1043.5 9742.5 10539.6 10702.7 10775.2 10816.4 485120.0 487103.0 489122.0 497198.0 498102.0 81584.6 94899.0 99390.5 100475.5 101164.0 1022.3 1043.2 1062.6 1068.4 1072.3 16714.0 16753.6 16784.6 16918.3 17453.0 40726.0 40973.6 41153.0 41433.8 41502.6 54577.5 54957.7 56355.3 56530.4 57380.0 7148.4 7418.9 8359.2 8371.5 8583.2 12126.5 12186.9 12197.6 12319.6 12818.9 5498.7 11172.3 11184.2 11206.2 11209.1 11019.7 11309.5 11313.5 11319.9 11360.4 10982.7 11136.2 11327.9 11530.7 11662.8 7519.6 7541.4 7597.4 7600.6 7653.3 10644.8 11218.3 11383.3 11428.2 11535.6 17:28:32 INFO - PROCESS | 28527 | 17:28:32 INFO - PROCESS | 28527 | [#3] mootools.html Cycles:180 Average:5817.94 Median:2456.40 stddev:3354.47 (136.6%) stddev-sans-first:3347.04 17:28:32 INFO - PROCESS | 28527 | Values: 1344.6 1480.8 1506.7 1635.8 1807.9 8498.2 8792.5 8844.2 9108.1 9119.4 8779.1 8968.5 8981.2 9007.2 9012.6 2030.4 2079.9 2268.5 2334.9 2362.2 2293.7 2314.3 2319.7 2319.8 2324.3 2316.0 2332.5 2370.4 2371.4 2372.1 1931.5 2179.4 2230.7 2241.5 2255.1 2231.6 2237.8 2251.0 2257.3 2257.7 8903.3 8997.0 8999.8 9004.8 9022.2 5128.6 5296.6 5297.8 5300.7 5302.8 3181.0 3255.0 3282.2 3320.8 3321.8 1065.3 1086.8 1090.0 1092.6 1111.5 12285.6 12339.3 12347.6 12362.2 12380.9 4462.6 4542.8 4571.2 4650.9 4655.2 10528.0 10540.7 10546.6 10550.5 10563.5 5237.9 5295.3 5295.4 5296.0 5303.0 4267.6 4663.0 4769.4 4780.0 4838.7 4040.7 4050.6 4121.7 4145.8 4181.5 1220.7 1232.4 1248.9 1249.4 1266.8 925.0 1018.7 1019.9 1022.5 1030.1 6108.5 6132.1 6199.8 6231.7 6260.8 450.2 461.0 462.5 464.5 466.9 4157.5 4219.1 4221.3 4223.6 4245.3 10614.8 10828.4 10894.6 10975.7 11094.3 10766.7 10837.9 10872.1 10887.3 10907.3 7533.5 7743.7 7759.9 7857.4 8000.9 5915.4 5939.6 6013.5 6084.8 6166.8 10036.5 10130.7 10220.6 10229.7 10241.3 10149.0 10406.9 10443.2 10567.6 10602.4 7227.9 7538.8 7686.5 7707.1 7819.1 8684.2 8684.5 8721.6 8742.9 8776.0 7521.5 7674.9 7749.6 7753.9 8025.4 7741.1 7771.7 7813.5 7922.3 7954.7 6796.7 6831.8 6851.6 6858.8 6869.1 5249.8 5271.6 5389.6 5458.6 5520.4 5120.8 5174.6 5233.3 5376.1 5402.4 17:28:32 INFO - PROCESS | 28527 | 17:28:32 INFO - PROCESS | 28527 | [#4] prototype.html Cycles:180 Average:4363.78 Median:4834.46 stddev:1218.05 (25.2%) stddev-sans-first:1182.98 17:28:32 INFO - PROCESS | 28527 | Values: 316.8 329.8 332.4 334.8 335.7 5310.4 5366.4 5371.7 5382.9 5386.4 4981.0 5123.8 5135.2 5142.6 5277.6 3994.5 4074.6 4111.2 4146.8 4165.4 4072.9 4125.4 4132.7 4133.8 4153.5 3879.8 4055.4 4098.4 4130.9 4137.4 4039.6 4052.4 4077.6 4082.8 4105.2 3573.3 3583.3 3586.8 3591.1 3598.4 4818.0 5079.1 5082.3 5139.8 5161.7 4678.7 4685.9 4706.8 4712.1 4720.5 5458.0 5473.6 5479.8 5485.4 5502.7 3951.3 3998.2 4024.7 4049.7 4064.0 5639.2 5652.2 5658.9 5661.4 5677.5 4058.1 4066.3 4082.3 4086.7 4105.2 4144.9 4149.2 4162.4 4163.4 4163.5 4512.1 4626.3 4655.2 4688.0 4699.6 5505.5 5533.6 5537.7 5542.8 5551.8 1377.6 1396.4 1427.5 1435.9 1440.7 923.0 939.3 943.8 950.6 967.5 4711.4 4719.9 4726.5 4781.2 4820.8 4890.4 5002.7 5011.4 5035.1 5047.1 4592.3 4696.2 4729.6 4742.5 4772.7 2652.8 2657.9 2666.6 2666.6 2668.8 5144.9 5170.6 5189.4 5189.7 5215.7 4905.8 5068.4 5071.0 5124.4 5133.2 5103.2 5121.9 5153.8 5164.0 5176.0 4953.6 4962.3 4994.5 4997.0 5007.0 4769.3 4777.6 4867.9 4913.9 4964.4 5035.8 5105.8 5165.3 5168.8 5198.6 3733.5 3741.4 3779.9 3808.7 3816.9 4784.5 5001.8 5067.9 5094.7 5097.5 4926.8 4949.9 4955.4 4960.6 4962.0 4778.2 4826.6 4829.6 4846.8 4892.6 4533.0 4809.5 4839.3 4901.0 4915.6 4940.9 4948.6 4964.9 4970.8 4974.7 4758.5 4813.4 4854.1 4869.7 4894.8 17:28:32 INFO - PROCESS | 28527 | 17:28:32 INFO - PROCESS | 28527 | [#5] yui.html Cycles:180 Average:19739.64 Median:4497.47 stddev:28150.77 (625.9%) stddev-sans-first:28193.40 17:28:32 INFO - PROCESS | 28527 | Values: 688.6 694.5 723.2 725.5 754.9 14443.1 15560.7 15570.2 15623.6 15646.3 13997.4 14063.6 14105.1 14114.4 14116.2 664.9 765.8 780.1 788.3 791.0 776.8 781.7 781.7 782.1 783.0 824.2 825.7 825.7 826.8 827.7 692.2 812.4 822.9 832.0 835.1 585.8 585.9 586.3 586.3 588.5 13812.6 13845.4 13858.5 13908.0 14025.0 13065.9 13566.2 13916.4 13980.3 14021.5 10150.3 10548.3 10621.5 11878.7 11945.7 3744.5 3865.9 4391.7 4402.4 4504.7 70514.6 71836.3 72084.6 74718.6 75060.6 9685.4 10298.1 10347.3 10439.6 10640.6 19645.6 19805.5 19808.1 19853.8 19893.2 8198.0 8365.0 8423.6 8501.3 8563.5 4419.2 4422.8 4452.9 4528.2 4558.1 3409.0 3502.4 3502.6 3504.1 3505.5 596.1 597.6 600.8 607.6 630.2 642.0 680.4 740.0 747.8 774.0 9409.5 9483.3 9542.0 9622.0 9753.9 660.7 663.3 709.2 729.8 758.7 4115.4 4438.6 4440.1 4445.4 4490.3 105433.0 105534.0 106755.5 109542.5 112450.4 81672.6 89395.3 90398.0 97010.5 98227.5 65744.7 66154.0 82898.6 87833.6 91018.5 9583.8 9659.1 9677.9 9718.2 9741.8 47016.8 51398.0 51837.2 52473.7 53425.0 62314.7 70769.3 74688.0 76456.6 76713.0 12400.3 12681.5 12726.0 13008.9 13666.1 12900.8 13049.5 13240.7 13302.3 13355.6 13092.5 13154.2 13326.4 13397.8 13413.9 12539.7 12823.4 13164.5 13189.6 13647.7 12767.3 13208.2 13433.9 13440.0 13568.3 10553.4 10865.2 11110.0 11353.2 11502.5 10389.4 10666.8 10707.3 10925.7 11019.8 17:28:32 INFO - PROCESS | 28527 | -------- Summary: end -------- 17:28:32 INFO - PROCESS | 28527 | 17:28:32 INFO - TEST-INFO | 28527: exit 0 17:28:32 INFO - TEST-OK | dromaeo_css | took 1112767ms 17:28:32 INFO - TEST-START | kraken 17:28:32 INFO - operating with platform_type : linux_ 17:28:32 INFO - Initialising browser for kraken test... 17:28:33 INFO - TEST-INFO | started process 28709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBC1ubm/profile http://localhost:33411/getInfo.html) 17:28:37 INFO - PROCESS | 28709 | __metrics Screen width/height:1600/1200 17:28:37 INFO - PROCESS | 28709 | colorDepth:24 17:28:37 INFO - PROCESS | 28709 | Browser inner width/height: 1024/697 17:28:37 INFO - PROCESS | 28709 | __metrics 17:28:37 ERROR - PROCESS | 28709 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:28:38 INFO - PROCESS | 28709 | console.error: PushService: 17:28:38 INFO - PROCESS | 28709 | stateChangeProcessEnqueue: Error transitioning state 17:28:38 INFO - PROCESS | 28709 | UnknownError 17:28:38 INFO - TEST-INFO | 28709: exit 0 17:28:38 INFO - Browser initialized. 17:28:38 INFO - Running cycle 1/1 for kraken test... 17:28:38 INFO - TEST-INFO | started process 28791 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBC1ubm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:28:50 INFO - PROCESS | 28791 | RSS: Main: 156749824 17:28:50 INFO - PROCESS | 28791 | 17:28:53 INFO - PROCESS | 28791 | Cycle 1(1): loaded http://localhost:33411/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33411/tests/kraken/driver.html?testName=audio-beat-detection) 17:28:54 INFO - PROCESS | 28791 | RSS: Main: 214794240 17:28:54 INFO - PROCESS | 28791 | 17:28:56 INFO - PROCESS | 28791 | Cycle 1(1): loaded http://localhost:33411/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33411/tests/kraken/driver.html?testName=audio-dft) 17:28:57 INFO - PROCESS | 28791 | RSS: Main: 201740288 17:28:57 INFO - PROCESS | 28791 | 17:29:00 INFO - PROCESS | 28791 | Cycle 1(1): loaded http://localhost:33411/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33411/tests/kraken/driver.html?testName=audio-fft) 17:29:01 INFO - PROCESS | 28791 | RSS: Main: 268443648 17:29:01 INFO - PROCESS | 28791 | 17:29:03 INFO - PROCESS | 28791 | Cycle 1(1): loaded http://localhost:33411/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33411/tests/kraken/driver.html?testName=audio-oscillator) 17:29:03 INFO - PROCESS | 28791 | RSS: Main: 179679232 17:29:03 INFO - PROCESS | 28791 | 17:29:05 INFO - PROCESS | 28791 | Cycle 1(1): loaded http://localhost:33411/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33411/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:29:06 INFO - PROCESS | 28791 | RSS: Main: 183930880 17:29:06 INFO - PROCESS | 28791 | 17:29:09 INFO - PROCESS | 28791 | Cycle 1(1): loaded http://localhost:33411/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33411/tests/kraken/driver.html?testName=imaging-darkroom) 17:29:10 INFO - PROCESS | 28791 | RSS: Main: 220512256 17:29:10 INFO - PROCESS | 28791 | 17:29:13 INFO - PROCESS | 28791 | Cycle 1(1): loaded http://localhost:33411/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33411/tests/kraken/driver.html?testName=imaging-desaturate) 17:29:14 INFO - PROCESS | 28791 | RSS: Main: 221372416 17:29:14 INFO - PROCESS | 28791 | 17:29:16 INFO - PROCESS | 28791 | Cycle 1(1): loaded http://localhost:33411/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33411/tests/kraken/driver.html?testName=json-parse-financial) 17:29:17 INFO - PROCESS | 28791 | RSS: Main: 221020160 17:29:17 INFO - PROCESS | 28791 | 17:29:18 INFO - PROCESS | 28791 | Cycle 1(1): loaded http://localhost:33411/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33411/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:29:19 INFO - PROCESS | 28791 | RSS: Main: 207253504 17:29:19 INFO - PROCESS | 28791 | 17:29:21 INFO - PROCESS | 28791 | Cycle 1(1): loaded http://localhost:33411/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33411/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:29:21 INFO - PROCESS | 28791 | RSS: Main: 210690048 17:29:21 INFO - PROCESS | 28791 | 17:29:24 INFO - PROCESS | 28791 | Cycle 1(1): loaded http://localhost:33411/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33411/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:29:24 INFO - PROCESS | 28791 | RSS: Main: 215662592 17:29:24 INFO - PROCESS | 28791 | 17:29:27 INFO - PROCESS | 28791 | Cycle 1(1): loaded http://localhost:33411/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33411/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:29:27 INFO - PROCESS | 28791 | RSS: Main: 222842880 17:29:27 INFO - PROCESS | 28791 | 17:29:30 INFO - PROCESS | 28791 | Cycle 1(1): loaded http://localhost:33411/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33411/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:29:31 INFO - PROCESS | 28791 | RSS: Main: 222621696 17:29:31 INFO - PROCESS | 28791 | 17:29:32 INFO - PROCESS | 28791 | Cycle 1(1): loaded http://localhost:33411/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33411/tests/kraken/driver.html?testName=ai-astar) 17:29:33 INFO - PROCESS | 28791 | RSS: Main: 265203712 17:29:33 INFO - PROCESS | 28791 | 17:29:33 INFO - PROCESS | 28791 | __start_tp_report 17:29:33 INFO - PROCESS | 28791 | _x_x_mozilla_page_load 17:29:33 INFO - PROCESS | 28791 | _x_x_mozilla_page_load_details 17:29:33 INFO - PROCESS | 28791 | |i|pagename|runs| 17:29:33 INFO - PROCESS | 28791 | |0;ai-astar;109;105;110;108;109;110;109;109;110;110 17:29:33 INFO - PROCESS | 28791 | |1;audio-beat-detection;157;125;127;174;125;126;157;126;170;125 17:29:33 INFO - PROCESS | 28791 | |2;audio-dft;160;162;161;160;160;160;160;160;162;159 17:29:33 INFO - PROCESS | 28791 | |3;audio-fft;75;73;74;115;76;76;75;74;109;74 17:29:33 INFO - PROCESS | 28791 | |4;audio-oscillator;85;85;109;86;84;85;125;86;85;132 17:29:33 INFO - PROCESS | 28791 | |5;imaging-gaussian-blur;117;116;117;116;117;117;118;117;117;117 17:29:33 INFO - PROCESS | 28791 | |6;imaging-darkroom;146;147;147;146;146;146;148;147;146;146 17:29:33 INFO - PROCESS | 28791 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;95;95 17:29:33 INFO - PROCESS | 28791 | |8;json-parse-financial;53;54;54;53;54;52;53;54;52;53 17:29:33 INFO - PROCESS | 28791 | |9;json-stringify-tinderbox;61;61;61;61;61;61;61;61;61;61 17:29:33 INFO - PROCESS | 28791 | |10;stanford-crypto-aes;82;86;79;79;81;81;81;79;115;80 17:29:33 INFO - PROCESS | 28791 | |11;stanford-crypto-ccm;142;128;122;119;119;124;120;121;135;121 17:29:33 INFO - PROCESS | 28791 | |12;stanford-crypto-pbkdf2;167;160;162;163;163;163;162;161;164;158 17:29:33 INFO - PROCESS | 28791 | |13;stanford-crypto-sha256-iterative;63;65;63;63;64;64;65;62;64;66 17:29:33 INFO - PROCESS | 28791 | __end_tp_report 17:29:33 INFO - PROCESS | 28791 | __start_cc_report 17:29:33 INFO - PROCESS | 28791 | _x_x_mozilla_cycle_collect,1594 17:29:33 INFO - PROCESS | 28791 | __end_cc_report 17:29:33 INFO - PROCESS | 28791 | __startTimestamp1465432173043__endTimestamp 17:29:33 INFO - PROCESS | 28791 | 17:29:33 INFO - PROCESS | 28791 | ------- Summary: start ------- 17:29:33 INFO - PROCESS | 28791 | Number of tests: 14 17:29:33 INFO - PROCESS | 28791 | 17:29:33 INFO - PROCESS | 28791 | [#0] ai-astar Cycles:10 Average:108.90 Median:109.50 stddev:1.52 (1.4%) stddev-sans-first:1.62 17:29:33 INFO - PROCESS | 28791 | Values: 109.0 105.0 110.0 108.0 109.0 110.0 109.0 109.0 110.0 110.0 17:29:33 INFO - PROCESS | 28791 | 17:29:33 INFO - PROCESS | 28791 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:142.00 stddev:20.70 (14.6%) stddev-sans-first:21.15 17:29:33 INFO - PROCESS | 28791 | Values: 157.0 125.0 127.0 174.0 125.0 126.0 157.0 126.0 170.0 125.0 17:29:33 INFO - PROCESS | 28791 | 17:29:33 INFO - PROCESS | 28791 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 17:29:33 INFO - PROCESS | 28791 | Values: 160.0 162.0 161.0 160.0 160.0 160.0 160.0 160.0 162.0 159.0 17:29:33 INFO - PROCESS | 28791 | 17:29:33 INFO - PROCESS | 28791 | [#3] audio-fft Cycles:10 Average:82.10 Median:74.50 stddev:15.85 (21.3%) stddev-sans-first:16.60 17:29:33 INFO - PROCESS | 28791 | Values: 75.0 73.0 74.0 115.0 76.0 76.0 75.0 74.0 109.0 74.0 17:29:33 INFO - PROCESS | 28791 | 17:29:33 INFO - PROCESS | 28791 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:85.00 stddev:18.66 (22.0%) stddev-sans-first:19.35 17:29:33 INFO - PROCESS | 28791 | Values: 85.0 85.0 109.0 86.0 84.0 85.0 125.0 86.0 85.0 132.0 17:29:33 INFO - PROCESS | 28791 | 17:29:33 INFO - PROCESS | 28791 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:29:33 INFO - PROCESS | 28791 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 17:29:33 INFO - PROCESS | 28791 | 17:29:33 INFO - PROCESS | 28791 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 17:29:33 INFO - PROCESS | 28791 | Values: 146.0 147.0 147.0 146.0 146.0 146.0 148.0 147.0 146.0 146.0 17:29:33 INFO - PROCESS | 28791 | 17:29:33 INFO - PROCESS | 28791 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:29:33 INFO - PROCESS | 28791 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 17:29:33 INFO - PROCESS | 28791 | 17:29:33 INFO - PROCESS | 28791 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.50 stddev:0.79 (1.5%) stddev-sans-first:0.83 17:29:33 INFO - PROCESS | 28791 | Values: 53.0 54.0 54.0 53.0 54.0 52.0 53.0 54.0 52.0 53.0 17:29:33 INFO - PROCESS | 28791 | 17:29:33 INFO - PROCESS | 28791 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:29:33 INFO - PROCESS | 28791 | Values: 61.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 17:29:33 INFO - PROCESS | 28791 | 17:29:33 INFO - PROCESS | 28791 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:81.00 stddev:10.99 (13.6%) stddev-sans-first:11.62 17:29:33 INFO - PROCESS | 28791 | Values: 82.0 86.0 79.0 79.0 81.0 81.0 81.0 79.0 115.0 80.0 17:29:33 INFO - PROCESS | 28791 | 17:29:33 INFO - PROCESS | 28791 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:123.00 stddev:7.72 (6.3%) stddev-sans-first:5.24 17:29:33 INFO - PROCESS | 28791 | Values: 142.0 128.0 122.0 119.0 119.0 124.0 120.0 121.0 135.0 121.0 17:29:33 INFO - PROCESS | 28791 | 17:29:33 INFO - PROCESS | 28791 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:163.00 stddev:2.41 (1.5%) stddev-sans-first:1.86 17:29:33 INFO - PROCESS | 28791 | Values: 167.0 160.0 162.0 163.0 163.0 163.0 162.0 161.0 164.0 158.0 17:29:33 INFO - PROCESS | 28791 | 17:29:33 INFO - PROCESS | 28791 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.20 (1.9%) stddev-sans-first:1.22 17:29:33 INFO - PROCESS | 28791 | Values: 63.0 65.0 63.0 63.0 64.0 64.0 65.0 62.0 64.0 66.0 17:29:33 INFO - PROCESS | 28791 | -------- Summary: end -------- 17:29:33 INFO - PROCESS | 28791 | 17:29:33 INFO - TEST-INFO | 28791: exit 0 17:29:33 INFO - TEST-OK | kraken | took 60982ms 17:29:33 INFO - SUITE-END | took 1173s 17:29:34 INFO - Completed test suite (00:19:33) 17:29:34 INFO - javascript benchmark 17:29:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3142.481490554059, 3158.368326334732, 3169.9366012679748, 3179.650238473769, 3215.9839200803995, 5128.640995130342, 5160.458151894053, 5272.710000949946, 5334.919976200355, 5362.410134885165, 5241.973790131054, 5266.183741520061, 5302.045631786277, 5312.521873031426, 5330.413654498002, 4784.234522476413, 4813.253945638432, 4871.12319782439, 4876.707397556158, 4997.375328083989, 4908.582770464497, 4928.162212423878, 4930.728809915453, 4981.5018498150075, 4995.0, 4701.388819453467, 4702.247640377524, 4779.928301075487, 4782.856514304576, 4813.3983252093485, 4800.447948485934, 4812.254100614376, 4866.902661946777, 4888.169011268093, 4923.876903077416, 4708.152532544141, 4824.300476430933, 4840.6127509799135, 4861.659683822134, 4889.584385327252, 5225.0, 5295.443978382292, 5304.6286759926825, 5384.380796208447, 5405.621606487547, 5790.305163380422, 5795.304563452412, 5808.041673123929, 5835.679037652927, 5835.854103647401, 5462.781488740446, 5587.106063029895, 5754.1944127822135, 5765.625234359753, 5807.5644326675665, 5266.368035835686, 5358.91961620576, 5363.758630861621, 5365.248865158881, 5365.865853353658, 5839.0, 5857.794977175864, 5858.736356863951, 5860.8534786629825, 5863.882722345615, 5322.36131664195, 5520.447955204448, 5593.692346920877, 5614.326280846324, 5627.268455100892, 5701.486866182064, 5732.627379220421, 5750.453706897838, 5756.683382414008, 5761.3950535194035, 5675.347335056521, 5692.089265717548, 5693.345265294462, 5696.686682232434, 5696.857578560569, 5442.4829641184815, 5533.22534845122, 5615.494605485526, 5644.491995720405, 5673.06394444912, 4352.107817897323, 4371.934420983688, 4374.431323927869, 4374.606285434326, 4410.404595379647, 3893.824777885002, 3901.882943511699, 3904.863329783501, 3926.784026878492, 3930.606939306104, 5135.820246291437, 5260.763265653055, 5335.226392173113, 5429.538489228381, 5443.727813609304, 5783.94216057834, 5793.913091303634, 5807.070868660994, 5809.7966571170655, 5836.766529338864, 5444.782208711607, 5481.917771233435, 5483.479069488392, 5484.204790305464, 5484.396716361197, 4761.619070474354, 4851.975740121276, 4890.828820991248, 4903.681260718042, 4909.091818013679, 5867.911981320283, 5876.471117599436, 5876.970615146897, 5878.382769809194, 5878.617889837147, 5472.972635136799, 5670.432956704379, 5685.090385538294, 5694.06048002075, 5701.629394089371, 5775.047117225611, 5869.031609784338, 5894.852628684145, 5918.911216331672, 5946.13781001761, 5607.859803504945, 5620.578456615852, 5634.408387119293, 5638.041532939492, 5640.689762063126, 5416.970775552632, 5560.7219639018695, 5706.058500347563, 5708.543316534584, 5737.483626473638, 5468.699221542854, 5510.641808282448, 5526.447355264441, 5564.860878477908, 5573.665580065209, 5452.291202143696, 5477.780888764405, 5486.451354864482, 5506.64206826555, 5511.173324001432, 5220.0, 5342.973285133549, 5348.465153484621, 5367.651102678314, 5441.7551210196425, 5549.1676248563035, 5614.354349249726, 5618.915716264178, 5625.015622266005, 5625.071863142535, 5450.645708029124, 5459.099248624091, 5462.644928079662, 5463.508284254277, 5509.586780991362], "value": 5246.065115139323, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.633070661543, 624.4068135271492, 627.792828366639, 639.4117411980978, 649.194998202229, 31379.372412551736, 34388.484172737364, 34407.827960860195, 34473.31053378937, 40923.386149207785, 42022.57977420225, 42528.0, 42731.35902961458, 42775.57224427755, 42950.78524607381, 8626.999999999984, 8739.60671769772, 8821.51481668508, 8829.117088291183, 8832.072632373605, 8600.096989816073, 8757.562121893912, 8770.12298770121, 8772.736817895473, 8773.166549177819, 8711.085336039689, 8729.650813967433, 8731.781705457382, 8733.214010739031, 8773.210411063003, 8610.182032706884, 8652.134786521361, 8656.8701469478, 8704.56477176145, 8720.171583699539, 8629.870551941725, 8693.652253909837, 8754.518501482416, 8756.693515726918, 8759.649614015432, 40183.0, 40471.0, 40565.59434405677, 40625.79687101545, 40631.18737625261, 3219.8551065201887, 3224.774265801395, 3244.6593107723584, 3465.1683595936793, 3558.448440491728, 28303.0, 30426.0, 30950.0, 31161.688383116107, 31903.202419939455, 4003.6997225208224, 4022.1352409232154, 4142.46148000758, 4221.113566151112, 4221.80307823305, 318924.0, 320769.0, 321685.0, 321968.39015805005, 322415.0, 33549.32901341959, 34250.0, 56770.71614641983, 57490.0, 57653.135202971986, 35469.29061418809, 35641.1089722759, 35694.28611427809, 35705.642943570754, 35748.642513575054, 14476.059056161315, 14665.853341466662, 14678.0, 14682.0, 14686.632834179018, 12934.288614126126, 12989.675258118434, 13017.674558136123, 13017.869821301856, 13018.674533136558, 8136.430449868452, 8169.428140030141, 8193.672253109928, 8260.793480163044, 8269.751907442786, 3157.826319552401, 3179.856906439216, 3241.8865339712997, 3245.6429792722784, 3245.7666086886834, 961.4711908450324, 1032.2877214721818, 1033.478093562746, 1037.7872536130076, 1069.0752499088233, 30821.383572328876, 31370.37259254802, 31567.84216078905, 31607.84196079051, 32226.83886580552, 1070.2936062198912, 1083.6369816111533, 1099.2686518733028, 1181.6986668399675, 1227.2513766602365, 16701.164941752864, 16907.323707051826, 16933.576660583585, 16959.915200424166, 16984.23570939286, 483643.0, 488536.0, 488645.0, 489485.0, 489486.0, 54977.72511137419, 56368.718156408955, 56373.0, 56399.43600564024, 56502.0, 1244.4835393311855, 1302.4139137388213, 1313.678148853518, 1315.7763180259378, 1347.5755137131773, 25190.874045629655, 31512.32145267678, 32880.34239315153, 34095.82952085224, 34176.65823341834, 46831.29753053639, 46895.29657055215, 47288.0, 47299.290510643055, 47403.762981184875, 411587.0, 422713.0, 423103.0, 423654.0, 424044.0, 23095.769042309363, 23895.40261493407, 26776.0, 27014.1895743128, 27442.0, 45996.0, 46445.303320449544, 46651.30023049589, 46951.0, 47021.0, 37174.6282537182, 39615.603843961195, 43046.0, 43316.35025474684, 43996.0, 38911.41632875452, 39378.80310598543, 40239.597604023584, 40242.798786005886, 40519.3922091163, 34334.31331373309, 38989.2202155961, 40456.0, 40555.1888962225, 40868.386974194815, 32831.83584082064, 35940.82029589835, 36122.277554448236, 36165.45751813777, 36472.27055458929, 26516.337091572866, 27012.59481107824, 27567.0, 27969.580456292766, 28994.0], "value": 18208.952100062084, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.6028290860415, 395.97624142551433, 397.53488418550313, 399.958004409537, 413.6504653567736, 14303.284835758222, 17677.82322176778, 18495.722564161548, 18971.52571185721, 19034.428967130993, 18314.175862086206, 18334.633307333846, 18388.816111838878, 18796.624067518642, 18800.43598692038, 5535.612507124503, 5668.518175955028, 5736.0, 5739.339975902762, 5740.253767010283, 4064.9390259146135, 4277.059047009653, 5534.059209934321, 5692.829215123553, 5704.11586204139, 4286.892827679318, 5920.141579470974, 6290.905636415458, 6291.0, 6414.390632889868, 6312.084747711579, 6375.0, 6384.808455746335, 6407.135036770046, 6422.165118534607, 5535.114381698949, 5651.943480565183, 5658.519025882805, 5662.292213473316, 5682.51698605619, 21194.78805211959, 21479.570408591742, 22242.666360004452, 22318.21886233974, 22350.888245558668, 2198.351486311542, 2243.741969673492, 2308.6190778521523, 2410.9873852981614, 2720.5239083160563, 12992.545260915822, 13398.799018014737, 13531.932340338235, 14180.22008789516, 14187.219702916336, 1927.4699457649258, 1929.807019298073, 1933.2846846666823, 1953.2772874036698, 1999.8700084494462, 76585.0, 76937.23062769357, 77343.6132819338, 79117.60441197814, 80039.19960800375, 9934.254930880068, 10314.638987635397, 10354.53404596795, 10640.627578034731, 10731.624393146358, 12729.745405091846, 13390.665233369244, 14740.852591473948, 14742.11547307165, 14766.48317308889, 7695.6921723130445, 7877.0, 8106.47307924983, 8283.461574997606, 8326.084130745614, 7892.210778922062, 7894.21057894206, 7921.207879212148, 8029.156938521488, 8058.476199047043, 6459.321771214049, 6540.803775886731, 6585.440237579764, 6638.499104590738, 6675.4325882300545, 1876.6581893945895, 1900.249401486405, 1917.7179156803359, 1949.6003319319504, 1957.9804201957797, 930.5254320296698, 960.8991055939166, 962.711186644004, 1032.1123833503182, 1060.7189094889861, 18336.358227461973, 18587.44237672872, 18722.531936701693, 18765.906170469334, 19201.135948882053, 993.4486360070231, 998.3510718033336, 1009.0716540782352, 1042.8696412948382, 1043.5408420295198, 9742.512874356396, 10539.578416863393, 10702.678919632424, 10775.191860610486, 10816.351018938889, 485120.0, 487103.0, 489122.0, 497198.0, 498102.0, 81584.59207704042, 94899.0, 99390.50304748575, 100475.49762251142, 101164.0, 1022.2639699416409, 1043.2280112716687, 1062.617457715222, 1068.3589846092439, 1072.2976450424985, 16714.0, 16753.552384640476, 16784.58038549046, 16918.32326706918, 17453.040082795567, 40726.0, 40973.59026409817, 41153.0, 41433.79283103565, 41502.584974149875, 54577.45422545724, 54957.72521137369, 56355.34719256368, 56530.43469565416, 57380.0, 7148.428125749823, 7418.888716669362, 8359.164083591591, 8371.539565323965, 8583.18459746323, 12126.454309556268, 12186.939065304618, 12197.573084941985, 12319.63041108768, 12818.871811281768, 5498.697571633598, 11172.262795615126, 11184.161187910777, 11206.159538034517, 11209.103271738404, 11019.72450688707, 11309.491072901903, 11313.490892909675, 11319.943400282946, 11360.431978401211, 10982.682078150672, 11136.16478764112, 11327.943360283145, 11530.711732206426, 11662.76674466489, 7519.586422746802, 7541.396688265036, 7597.392208623407, 7600.619969001638, 7653.268976750085, 10644.787104258026, 11218.270812397168, 11383.260088094248, 11428.2000259981, 11535.596254131066], "value": 9155.748219909849, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.636948024033, 1480.7556753135734, 1506.6986602679463, 1635.8445947634978, 1807.9367222147227, 8498.192671696186, 8792.472451652897, 8844.248238899701, 9108.134727200922, 9119.407238529491, 8779.122087791233, 8968.46189228645, 8981.236594889442, 9007.189352958232, 9012.594433250502, 2030.4213299209728, 2079.875207487548, 2268.4669102760836, 2334.87158206299, 2362.196853069956, 2293.655951607264, 2314.259436980167, 2319.6868422762964, 2319.7912187903084, 2324.3491822289784, 2316.0, 2332.54515369503, 2370.3718514593647, 2371.3952941999764, 2372.086746602562, 1931.507465596278, 2179.400664817172, 2230.732312122556, 2241.4732537853592, 2255.086689890597, 2231.642937130068, 2237.8097861681777, 2250.9549809003893, 2257.2663884237522, 2257.7064981552294, 8903.287736981027, 8997.0, 8999.820003599956, 9004.77488062797, 9022.18800307969, 5128.615353848476, 5296.576273898079, 5297.841064768063, 5300.681959082467, 5302.814401495929, 3181.0, 3254.9511757323658, 3282.2286762610765, 3320.7841490303053, 3321.8173000484962, 1065.3047789093605, 1086.7935092332432, 1089.9891001089966, 1092.6230450494568, 1111.4831603304422, 12285.631431057083, 12339.321337326444, 12347.567835125728, 12362.196457230251, 12380.938095309555, 4462.642988560908, 4542.772861356919, 4571.22289210835, 4650.883727906762, 4655.23188673865, 10528.0, 10540.736481587868, 10546.630867919586, 10550.525226364833, 10563.524641391155, 5237.9476205238225, 5295.285136506599, 5295.391030031518, 5295.967286379119, 5303.0454518186325, 4267.551907049778, 4663.0, 4769.379980602499, 4780.020095880336, 4838.7338696372035, 4040.711967745131, 4050.6151915567975, 4121.732087414309, 4145.771982540929, 4181.540030596632, 1220.7192345760525, 1232.3653318540958, 1248.9000879929765, 1249.3628249592591, 1266.8416447944007, 924.9537523123817, 1018.6791160784329, 1019.9490025498695, 1022.4632068164274, 1030.057497389895, 6108.450239478469, 6132.08018797184, 6199.814005579839, 6231.660193058514, 6260.812175634738, 450.1626973828676, 460.9815607375667, 462.53977292594084, 464.4867421499262, 466.89494863655403, 4157.5010998679745, 4219.135077309144, 4221.282381995068, 4223.598758117974, 4245.341971994346, 10614.840777388345, 10828.404437755842, 10894.61868834587, 10975.725606859893, 11094.278871873465, 10766.73083172927, 10837.891621083845, 10872.075873550837, 10887.346759194315, 10907.29102608328, 7533.54798712079, 7743.651535680908, 7759.922400776033, 7857.449978501564, 8000.8799868002025, 5915.37888521699, 5939.643621382731, 6013.518918486423, 6084.847878803065, 6166.784162554289, 10036.548355323883, 10130.696079117639, 10220.59117635316, 10229.693109206735, 10241.283110182514, 10149.0, 10406.895931040895, 10443.216758742972, 10567.577296908037, 10602.363858168535, 7227.891581626174, 7538.811529711582, 7686.500377475446, 7707.113681926426, 7819.0617125945255, 8684.2184203422, 8684.522351270742, 8721.607527661397, 8742.912570874465, 8775.956120219358, 7521.4734968551675, 7674.884876726966, 7749.612519373896, 7753.883691744515, 8025.438219324591, 7741.109772376249, 7771.72798952034, 7813.492123011986, 7922.326602238874, 7954.681812727426, 6796.728130874907, 6831.795046148623, 6851.588904665736, 6858.794236172923, 6869.141357330333, 5249.816256431007, 5271.551918086852, 5389.622726409114, 5458.645188062763, 5520.420355862577, 5120.769565369493, 5174.586033117266, 5233.319668443078, 5376.112941364631, 5402.432744561765], "value": 4555.110117558354, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.81308028263305, 329.80047071521733, 332.3983589702638, 334.79744754423564, 335.67271909887876, 5310.3893052299, 5366.356037275523, 5371.677699338043, 5382.946170538298, 5386.380566234884, 4981.0, 5123.820666276681, 5135.22971554267, 5142.640015198928, 5277.604179686529, 3994.460747799039, 4074.592540745924, 4111.198316328318, 4146.771927543984, 4165.354684899463, 4072.902455235556, 4125.422440858282, 4132.73137246078, 4133.813978370966, 4153.525498448038, 3879.767213967171, 4055.4322394864744, 4098.364753463203, 4130.876073717794, 4137.379393091045, 4039.6063358141396, 4052.3921411788174, 4077.571854955246, 4082.83668653252, 4105.199486100211, 3573.3032058748554, 3583.33708263972, 3586.8385922633283, 3591.1381268495634, 3598.4242521196743, 4818.02460990992, 5079.136546787018, 5082.313887625197, 5139.820106296262, 5161.74191290434, 4678.695884767513, 4685.859424217245, 4706.835260765857, 4712.128256272601, 4720.504347043579, 5458.0, 5473.644213126134, 5479.807817166577, 5485.424030476783, 5502.669839809624, 3951.3480275754464, 3998.2203470323298, 4024.7182697211206, 4049.7165198436123, 4064.0, 5639.210510528529, 5652.208690783294, 5658.886822263532, 5661.433856614388, 5677.460641239076, 4058.066644671742, 4066.3290557057753, 4082.3468245080644, 4086.652634526039, 4105.199486100182, 4144.854930077493, 4149.232392007428, 4162.439085342997, 4163.417121602978, 4163.5420103789165, 4512.142692888341, 4626.282926146453, 4655.185342565038, 4687.9765601171775, 4699.553542413533, 5505.485501888493, 5533.612647114664, 5537.667739935617, 5542.806001789918, 5551.833444996657, 1377.6418131285939, 1396.3995481942861, 1427.5431861804332, 1435.8635929586674, 1440.6974535347485, 923.0031565908803, 939.3049143633798, 943.8112377524523, 950.5627411390699, 967.4678926590348, 4711.3639658646325, 4719.9292010619865, 4726.527347265246, 4781.2111001685025, 4820.807167713322, 4890.388701412324, 5002.699838009658, 5011.3986321640905, 5035.1188542005, 5047.116754567936, 4592.288195329729, 4696.2486002239475, 4729.597984171384, 4742.5020372861045, 4772.737499437564, 2652.8010399220134, 2657.8803953822126, 2666.5733482642686, 2666.586679064748, 2668.799840011968, 5144.871378215575, 5170.560502357342, 5189.417227745574, 5189.7405129743365, 5215.6609820361555, 4905.828296009622, 5068.366454193226, 5071.036503064406, 5124.385073791094, 5133.178691409356, 5103.21387514367, 5121.92317115251, 5153.793848246103, 5164.0, 5175.974120129451, 4953.603711702983, 4962.3052772611145, 4994.525520075587, 4997.026769072396, 5006.974965125151, 4769.332293478985, 4777.570018698334, 4867.926981095357, 4913.9017219656125, 4964.361760619059, 5035.798568057383, 5105.795768169231, 5165.302684137593, 5168.819091331936, 5198.556678361164, 3733.5146430964887, 3741.401375779862, 3779.9244015118993, 3808.714346423974, 3816.904577385588, 4784.545468180518, 5001.7749201285305, 5067.923981140212, 5094.694318340911, 5097.515736005073, 4926.802927882844, 4949.861531847767, 4955.389498412958, 4960.6031517477795, 4961.950380496149, 4778.187708089564, 4826.565609095058, 4829.623557286157, 4846.80612775485, 4892.584130348961, 4533.0, 4809.470958194526, 4839.2983017462975, 4901.0, 4915.574483399774, 4940.925886111783, 4948.599929034487, 4964.900701985868, 4970.7514624267915, 4974.726390048582, 4758.524147585353, 4813.374261346003, 4854.077725232195, 4869.683470574401, 4894.800773810439], "value": 3984.1258885140196, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.6006116452456, 694.4583225084433, 723.2442098007582, 725.5030304241595, 754.9393102690722, 14443.133411995288, 15560.68878622427, 15570.221488925537, 15623.609409764762, 15646.295916683763, 13997.440102395893, 14063.648408789786, 14105.083169593969, 14114.364853581588, 14116.223607701573, 664.9102371179902, 765.8468306338726, 780.1457404142483, 788.3259812860008, 790.9841803163933, 776.8290975985302, 781.679511400326, 781.7263957614817, 782.12402109637, 782.9960850195741, 824.1758241758242, 825.6697321071559, 825.7357645553425, 826.8222332198576, 827.735124760077, 692.190137539078, 812.427238796647, 822.8683410654296, 831.9708810191614, 835.1106072033326, 585.8242527241811, 585.9355470898198, 586.2730214533947, 586.2818047891299, 588.485075558886, 13812.585622431343, 13845.446182152702, 13858.475567687547, 13908.0, 14025.018248722594, 13065.934670326682, 13566.186028838301, 13916.443342266297, 13980.300984950814, 14021.5092471763, 10150.28947973642, 10548.261621686484, 10621.522031508523, 11878.703032424171, 11945.701357466047, 3744.513213282256, 3865.9226815463535, 4391.736495810262, 4402.449693788277, 4504.662150338705, 70514.64742676305, 71836.28163718348, 72084.6395768023, 74718.62640686816, 75060.62469687617, 9685.41887486753, 10298.124659403884, 10347.327423717585, 10439.582416703399, 10640.627578034731, 19645.607087858163, 19805.504862378268, 19808.108635111166, 19853.801461985197, 19893.204271828963, 8197.959010204911, 8365.0, 8423.620937057847, 8501.277391421674, 8563.529005904611, 4419.226635338803, 4422.823087076546, 4452.864051049417, 4528.207563676344, 4558.133954548625, 3409.0, 3502.404591219499, 3502.562179727534, 3504.0714210734177, 3505.5267538882435, 596.0641792385912, 597.6234971967633, 600.8317671052113, 607.6354187487473, 630.2468550082699, 642.0305338938143, 680.3808534233823, 740.0305599664457, 747.8130467383154, 773.9729109481141, 9409.48247846375, 9483.28875334339, 9541.952290238505, 9622.0, 9753.9024609753, 660.7026837922858, 663.2836536540525, 709.1525626875937, 729.7956572159803, 758.7154816943646, 4115.403266526397, 4438.622717069021, 4440.089781594766, 4445.422095127613, 4490.281554951192, 105433.0, 105534.0, 106755.46622266839, 109542.45228773805, 112450.43774781073, 81672.59163704143, 89395.2953528488, 90398.0, 97010.51494742623, 98227.50886245666, 65744.6712766433, 66154.00768988469, 82898.58550707207, 87833.5608321967, 91018.54490727503, 9583.808323833346, 9659.093747969953, 9677.903220967983, 9718.222542196467, 9741.805163896825, 47016.7649161752, 51398.0, 51837.22244166416, 52473.7376313116, 53425.0, 62314.68842655758, 70769.29230707628, 74688.0, 76456.61771691329, 76713.0, 12400.317982510687, 12681.492740290285, 12726.0, 13008.869911300766, 13666.11170273929, 12900.8064879025, 13049.543265985645, 13240.701281454358, 13302.268375239455, 13355.599332020054, 13092.541761038317, 13154.183797096512, 13326.405384006412, 13397.799033014318, 13413.932930335677, 12539.686507837378, 12823.358832058546, 13164.47342106305, 13189.604311870658, 13647.658808529866, 12767.297798621164, 13208.207507549578, 13433.932830335785, 13440.0, 13568.321583920962, 10553.419561924167, 10865.185111116856, 11110.0, 11353.205275630626, 11502.53989840397, 10389.37663740178, 10666.8399974002, 10707.250492465453, 10925.672229833117, 11019.779604408028], "value": 7267.056705626509, "unit": "score"}], "name": "dromaeo_css", "value": 6977.094539958457, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 110.0, 108.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 127.0, 174.0, 125.0, 126.0, 157.0, 126.0, 170.0, 125.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 160.0, 160.0, 160.0, 160.0, 160.0, 162.0, 159.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 115.0, 76.0, 76.0, 75.0, 74.0, 109.0, 74.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 109.0, 86.0, 84.0, 85.0, 125.0, 86.0, 85.0, 132.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 148.0, 147.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 53.0, 54.0, 52.0, 53.0, 54.0, 52.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 79.0, 79.0, 81.0, 81.0, 81.0, 79.0, 115.0, 80.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 128.0, 122.0, 119.0, 119.0, 124.0, 120.0, 121.0, 135.0, 121.0], "value": 125.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 160.0, 162.0, 163.0, 163.0, 163.0, 162.0, 161.0, 164.0, 158.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 63.0, 63.0, 64.0, 64.0, 65.0, 62.0, 64.0, 66.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1497.1, "alertThreshold": 2.0}]} 17:29:34 INFO - Return code: 0 17:29:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:29:34 ERROR - # TBPL SUCCESS # 17:29:34 INFO - Running post-action listener: _resource_record_post_action 17:29:34 INFO - ##### 17:29:34 INFO - ##### Finished run-tests step (success) 17:29:34 INFO - ##### 17:29:34 INFO - Running post-run listener: _resource_record_post_run 17:29:34 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542408704; Read time: 220; Write time: 538448 17:29:34 INFO - TinderboxPrint: CPU usage
13.3% 17:29:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 220 17:29:34 INFO - TinderboxPrint: I/O write bytes / time
542,408,704 / 538,448 17:29:34 INFO - TinderboxPrint: CPU idle
8,248.8 (86.7%) 17:29:34 INFO - TinderboxPrint: CPU user
1,220.0 (12.8%) 17:29:34 INFO - TinderboxPrint: Swap in / out
0 / 0 17:29:34 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248434688; Read time: 0; Write time: 304524 17:29:34 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293974016; Read time: 220; Write time: 233924 17:29:34 INFO - Running post-run listener: _upload_blobber_files 17:29:34 INFO - Blob upload gear active. 17:29:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:29:34 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 17:29:34 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:29:34 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:29:35 INFO - (blobuploader) - INFO - Open directory for files ... 17:29:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:29:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:29:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:38 INFO - (blobuploader) - INFO - Done attempting. 17:29:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:29:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:29:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:39 INFO - (blobuploader) - INFO - Done attempting. 17:29:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:29:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:29:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:40 INFO - (blobuploader) - INFO - Done attempting. 17:29:40 INFO - (blobuploader) - INFO - Iteration through files over. 17:29:40 INFO - Return code: 0 17:29:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:29:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:29:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a1d5014f5dd79244119407dc70041ac9ad103dab4a348509e4d2c468d4a21b621190e43a09b60f28cbed25c0f12a642afaa8df6ce73b7d5fc8d2ef7eca28b98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97eb32d4cf5ddf88decceeb17dc3595c60fdcd5094c1addca82bdbf8bcf7b87231ae1789534b85155083d5f838438969d71f1429accaa96c54e7f6b677cb4597", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9348d074dd4af5e92395cf449e0c932735b4760024fa2d6fbc9e283bc120f26ba87e7520c04f42cafca92aef107a5ae063e67538bb1d309c3abb8d6c1c43b16"} 17:29:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:29:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:29:40 INFO - Contents: 17:29:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a1d5014f5dd79244119407dc70041ac9ad103dab4a348509e4d2c468d4a21b621190e43a09b60f28cbed25c0f12a642afaa8df6ce73b7d5fc8d2ef7eca28b98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97eb32d4cf5ddf88decceeb17dc3595c60fdcd5094c1addca82bdbf8bcf7b87231ae1789534b85155083d5f838438969d71f1429accaa96c54e7f6b677cb4597", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9348d074dd4af5e92395cf449e0c932735b4760024fa2d6fbc9e283bc120f26ba87e7520c04f42cafca92aef107a5ae063e67538bb1d309c3abb8d6c1c43b16"} 17:29:40 INFO - Running post-run listener: copy_logs_to_upload_dir 17:29:40 INFO - Copying logs to upload dir... 17:29:40 INFO - mkdir: /builds/slave/test/build/upload/logs 17:29:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.070041 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-08 17:29:40.163572) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 17:29:40.166925) ========= 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=5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643 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/sha512/1a1d5014f5dd79244119407dc70041ac9ad103dab4a348509e4d2c468d4a21b621190e43a09b60f28cbed25c0f12a642afaa8df6ce73b7d5fc8d2ef7eca28b98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97eb32d4cf5ddf88decceeb17dc3595c60fdcd5094c1addca82bdbf8bcf7b87231ae1789534b85155083d5f838438969d71f1429accaa96c54e7f6b677cb4597", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9348d074dd4af5e92395cf449e0c932735b4760024fa2d6fbc9e283bc120f26ba87e7520c04f42cafca92aef107a5ae063e67538bb1d309c3abb8d6c1c43b16"} build_url:https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011368 build_url: 'https://queue.taskcluster.net/v1/task/bJEfQ-NhQuCzc0N3W4tp8Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a1d5014f5dd79244119407dc70041ac9ad103dab4a348509e4d2c468d4a21b621190e43a09b60f28cbed25c0f12a642afaa8df6ce73b7d5fc8d2ef7eca28b98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/97eb32d4cf5ddf88decceeb17dc3595c60fdcd5094c1addca82bdbf8bcf7b87231ae1789534b85155083d5f838438969d71f1429accaa96c54e7f6b677cb4597", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9348d074dd4af5e92395cf449e0c932735b4760024fa2d6fbc9e283bc120f26ba87e7520c04f42cafca92aef107a5ae063e67538bb1d309c3abb8d6c1c43b16"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 17:29:40.195967) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:29:40.196529) ========= 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=5bd038846534b2fdfa68eeae000001e2-1465430944.108073-758975643 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:29:40.279347) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 17:29:40.279669) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 17:29:40.279979) ========= ========= Total master_lag: 0.18 =========