builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1465744155.98 results: success (0) buildid: 20160612053002 builduid: 83b7ddd59e9740c7b30a32cc1f4b2b96 revision: 016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-12 08:09:15.977989) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-12 08:09:15.979033) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-12 08:09:15.979762) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-12 08:09:16.040021) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 08:09:16.040432) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-12 08:09:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-06-12 08:09:16 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075640 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 08:09:16.133627) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 08:09:16.133947) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018767 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 08:09:16.186481) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 08:09:16.186855) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d --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 016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d --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=337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-12 08:09:16,380 truncating revision to first 12 chars 2016-06-12 08:09:16,380 Setting DEBUG logging. 2016-06-12 08:09:16,380 attempt 1/10 2016-06-12 08:09:16,380 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/016e0f47e8ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-12 08:09:16,900 unpacking tar archive at: fx-team-016e0f47e8ad/testing/mozharness/ program finished with exit code 0 elapsedTime=0.850366 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 08:09:17.056421) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-12 08:09:17.057400) ========= script_repo_revision: 016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-12 08:09:17.058550) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-12 08:09:17.059351) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-12 08:09:17.071464) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-12 08:09:17.071894) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:09:17 INFO - MultiFileLogger online at 20160612 08:09:17 in /builds/slave/test 08:09:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:09:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:09:17 INFO - {'append_to_log': False, 08:09:17 INFO - 'base_work_dir': '/builds/slave/test', 08:09:17 INFO - 'blob_upload_branch': 'Fx-Team', 08:09:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:09:17 INFO - 'branch': 'Fx-Team', 08:09:17 INFO - 'buildbot_json_path': 'buildprops.json', 08:09:17 INFO - 'config_files': ('talos/linux_config.py',), 08:09:17 INFO - 'default_actions': ('clobber', 08:09:17 INFO - 'read-buildbot-config', 08:09:17 INFO - 'download-and-extract', 08:09:17 INFO - 'populate-webroot', 08:09:17 INFO - 'create-virtualenv', 08:09:17 INFO - 'install', 08:09:17 INFO - 'run-tests'), 08:09:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:09:17 INFO - 'download_minidump_stackwalk': True, 08:09:17 INFO - 'download_symbols': 'ondemand', 08:09:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:09:17 INFO - 'tooltool.py': '/tools/tooltool.py', 08:09:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:09:17 INFO - '/tools/misc-python/virtualenv.py')}, 08:09:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:09:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:09:17 INFO - 'installer_path': 'installer.exe', 08:09:17 INFO - 'log_level': 'info', 08:09:17 INFO - 'log_name': 'talos', 08:09:17 INFO - 'log_to_console': True, 08:09:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:09:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:09:17 INFO - 'opt_config_files': (), 08:09:17 INFO - 'pip_index': False, 08:09:17 INFO - 'sps_profile': False, 08:09:17 INFO - 'sps_profile_interval': 0, 08:09:17 INFO - 'suite': 'dromaeojs-e10s', 08:09:17 INFO - 'system_bits': '32', 08:09:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:09:17 INFO - 'title': 'talos-linux64-ix-060', 08:09:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:09:17 INFO - 'use_talos_json': True, 08:09:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:09:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:09:17 INFO - 'work_dir': 'build'} 08:09:17 INFO - ##### 08:09:17 INFO - ##### Running clobber step. 08:09:17 INFO - ##### 08:09:17 INFO - Running pre-action listener: _resource_record_pre_action 08:09:17 INFO - Running main action method: clobber 08:09:17 INFO - rmtree: /builds/slave/test/build 08:09:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:09:17 INFO - Running post-action listener: _resource_record_post_action 08:09:17 INFO - ##### 08:09:17 INFO - ##### Finished clobber step (success) 08:09:17 INFO - ##### 08:09:17 INFO - ##### 08:09:17 INFO - ##### Running read-buildbot-config step. 08:09:17 INFO - ##### 08:09:17 INFO - Running pre-action listener: _resource_record_pre_action 08:09:17 INFO - Running main action method: read_buildbot_config 08:09:17 INFO - Using buildbot properties: 08:09:17 INFO - { 08:09:17 INFO - "project": "", 08:09:17 INFO - "product": "firefox", 08:09:17 INFO - "script_repo_revision": "production", 08:09:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:09:17 INFO - "repository": "", 08:09:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:09:17 INFO - "buildid": "20160612053002", 08:09:17 INFO - "pgo_build": "True", 08:09:17 INFO - "basedir": "/builds/slave/test", 08:09:17 INFO - "buildnumber": 464, 08:09:17 INFO - "slavename": "talos-linux64-ix-060", 08:09:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:09:17 INFO - "platform": "ubuntu64_hw", 08:09:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:09:17 INFO - "branch": "fx-team", 08:09:17 INFO - "repo_path": "integration/fx-team", 08:09:17 INFO - "revision": "016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d", 08:09:17 INFO - "stage_platform": "linux64-pgo", 08:09:17 INFO - "builduid": "83b7ddd59e9740c7b30a32cc1f4b2b96", 08:09:17 INFO - "slavebuilddir": "test" 08:09:17 INFO - } 08:09:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:09:17 INFO - Running post-action listener: _resource_record_post_action 08:09:17 INFO - ##### 08:09:17 INFO - ##### Finished read-buildbot-config step (success) 08:09:17 INFO - ##### 08:09:17 INFO - ##### 08:09:17 INFO - ##### Running download-and-extract step. 08:09:17 INFO - ##### 08:09:17 INFO - Running pre-action listener: _resource_record_pre_action 08:09:17 INFO - Running main action method: download_and_extract 08:09:17 INFO - mkdir: /builds/slave/test/build/tests 08:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:17 INFO - https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:09:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:09:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:09:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/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 08:09:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/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 08:09:20 INFO - Downloaded 1361 bytes. 08:09:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:09:20 INFO - Using the following test package requirements: 08:09:20 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:09:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:09:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:09:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:21 INFO - u'jsshell-linux-x86_64.zip'], 08:09:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:09:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:09:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:09:21 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:09:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:09:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:09:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:09:21 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')]} 08:09:21 INFO - https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:09:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:09:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:09:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/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 08:09:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/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 08:09:23 INFO - Downloaded 24465105 bytes. 08:09:23 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'] 08:09:23 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 08:09:24 INFO - Return code: 0 08:09:24 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 08:09:24 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')]} 08:09:24 INFO - https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:09:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:09:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:09:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/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 08:09:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/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 08:09:28 INFO - Downloaded 24465105 bytes. 08:09:28 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'] 08:09:28 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 08:09:30 INFO - Return code: 0 08:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:30 INFO - https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:09:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:09:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:09:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/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 08:09:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/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 08:09:31 INFO - Downloaded 10833377 bytes. 08:09:31 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'] 08:09:31 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 08:09:31 INFO - Return code: 0 08: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')]} 08:09:31 INFO - https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:09:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:09:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:09:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/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 08:09:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7wOczqIRq-_QmxEE9ZVcA/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 08:09:33 INFO - Downloaded 59338985 bytes. 08:09:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:09:33 INFO - mkdir: /builds/slave/test/properties 08:09:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:09:33 INFO - Writing to file /builds/slave/test/properties/build_url 08:09:33 INFO - Contents: 08:09:33 INFO - build_url:https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:09:34 INFO - Running post-action listener: _resource_record_post_action 08:09:34 INFO - Running post-action listener: set_extra_try_arguments 08:09:34 INFO - ##### 08:09:34 INFO - ##### Finished download-and-extract step (success) 08:09:34 INFO - ##### 08:09:34 INFO - ##### 08:09:34 INFO - ##### Running populate-webroot step. 08:09:34 INFO - ##### 08:09:34 INFO - Running pre-action listener: _resource_record_pre_action 08:09:34 INFO - Running main action method: populate_webroot 08:09:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:09:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:09:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:09:34 INFO - '--tppagecycles', 08:09:34 INFO - '7'], 08:09:34 INFO - 'tests': ['tsvgm']}}, 08:09:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:09:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:09:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:09:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:09:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:09:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:09:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:34 INFO - 'talos_options': ['--disable-e10s'], 08:09:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:34 INFO - 'talos_options': ['--disable-e10s'], 08:09:34 INFO - 'tests': ['damp', 'tps']}, 08:09:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:34 INFO - 'tests': ['damp', 'tps']}, 08:09:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:09:34 INFO - 'tests': ['dromaeo_dom']}, 08:09:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:09:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:09:34 INFO - 'tests': ['a11yr', 08:09:34 INFO - 'ts_paint', 08:09:34 INFO - 'tpaint', 08:09:34 INFO - 'sessionrestore', 08:09:34 INFO - 'sessionrestore_no_auto_restore', 08:09:34 INFO - 'tabpaint']}, 08:09:34 INFO - 'other-e10s': {'tests': ['a11yr', 08:09:34 INFO - 'ts_paint', 08:09:34 INFO - 'tpaint', 08:09:34 INFO - 'sessionrestore', 08:09:34 INFO - 'sessionrestore_no_auto_restore', 08:09:34 INFO - 'tabpaint']}, 08:09:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:09:34 INFO - 'ts_paint', 08:09:34 INFO - 'tpaint', 08:09:34 INFO - 'sessionrestore', 08:09:34 INFO - 'sessionrestore_no_auto_restore', 08:09:34 INFO - 'tabpaint']}, 08:09:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:09:34 INFO - 'ts_paint', 08:09:34 INFO - 'tpaint', 08:09:34 INFO - 'sessionrestore', 08:09:34 INFO - 'sessionrestore_no_auto_restore', 08:09:34 INFO - 'tabpaint']}, 08:09:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:09:34 INFO - 'tests': ['a11yr', 08:09:34 INFO - 'ts_paint', 08:09:34 INFO - 'tpaint', 08:09:34 INFO - 'sessionrestore', 08:09:34 INFO - 'sessionrestore_no_auto_restore', 08:09:34 INFO - 'tabpaint']}, 08:09:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:09:34 INFO - 'tests': ['a11yr', 08:09:34 INFO - 'ts_paint', 08:09:34 INFO - 'tpaint', 08:09:34 INFO - 'sessionrestore', 08:09:34 INFO - 'sessionrestore_no_auto_restore', 08:09:34 INFO - 'tabpaint']}, 08:09:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:09:34 INFO - 'tests': ['tsvgx', 08:09:34 INFO - 'tsvgr_opacity', 08:09:34 INFO - 'tart', 08:09:34 INFO - 'tscrollx', 08:09:34 INFO - 'cart']}, 08:09:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:09:34 INFO - 'tsvgr_opacity', 08:09:34 INFO - 'tart', 08:09:34 INFO - 'tscrollx', 08:09:34 INFO - 'cart']}, 08:09:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:34 INFO - 'talos_options': ['--disable-e10s'], 08:09:34 INFO - 'tests': ['tp5o']}, 08:09:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:34 INFO - 'tests': ['tp5o']}, 08:09:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:34 INFO - 'talos_options': ['--disable-e10s', 08:09:34 INFO - '--xperf_path', 08:09:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:34 INFO - 'tests': ['tp5n']}, 08:09:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:34 INFO - 'talos_options': ['--xperf_path', 08:09:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:34 INFO - 'tests': ['tp5n']}}, 08:09:34 INFO - 'talos.zip': {'path': '', 08:09:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:09:34 INFO - Running post-action listener: _resource_record_post_action 08:09:34 INFO - ##### 08:09:34 INFO - ##### Finished populate-webroot step (success) 08:09:34 INFO - ##### 08:09:34 INFO - ##### 08:09:34 INFO - ##### Running create-virtualenv step. 08:09:34 INFO - ##### 08:09:34 INFO - Running pre-action listener: _resource_record_pre_action 08:09:34 INFO - Running main action method: create_virtualenv 08:09:34 INFO - Creating virtualenv /builds/slave/test/build/venv 08:09:34 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 08:09:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:09:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:09:34 INFO - Using real prefix '/usr' 08:09:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:09:34 INFO - Installing distribute.............................................................................................................................................................................................done. 08:09:36 INFO - Installing pip.................done. 08:09:36 INFO - Return code: 0 08:09:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98849f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b29350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb81c0>, '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 0x1bb90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', '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 08:09:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:09:36 INFO - Using env: {'DISPLAY': ':0', 08:09:36 INFO - 'HOME': '/home/cltbld', 08:09:36 INFO - 'LANG': 'en_US.UTF-8', 08:09:36 INFO - 'LANGUAGE': 'en_US:en', 08:09:36 INFO - 'LOGNAME': 'cltbld', 08:09:36 INFO - 'MAIL': '/var/mail/cltbld', 08:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:36 INFO - 'MOZ_NO_REMOTE': '1', 08:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:36 INFO - 'NO_EM_RESTART': '1', 08:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:36 INFO - 'PWD': '/builds/slave/test', 08:09:36 INFO - 'SHELL': '/bin/bash', 08:09:36 INFO - 'SHLVL': '1', 08:09:36 INFO - 'TERM': 'linux', 08:09:36 INFO - 'TMOUT': '86400', 08:09:36 INFO - 'USER': 'cltbld', 08:09:36 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', 08:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:36 INFO - '_': '/tools/buildbot/bin/python'} 08:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:09:36 INFO - Cleaning up... 08:09:36 INFO - Return code: 0 08:09:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98849f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b29350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb81c0>, '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 0x1bb90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', '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 08:09:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:09:36 INFO - Using env: {'DISPLAY': ':0', 08:09:36 INFO - 'HOME': '/home/cltbld', 08:09:36 INFO - 'LANG': 'en_US.UTF-8', 08:09:36 INFO - 'LANGUAGE': 'en_US:en', 08:09:36 INFO - 'LOGNAME': 'cltbld', 08:09:36 INFO - 'MAIL': '/var/mail/cltbld', 08:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:36 INFO - 'MOZ_NO_REMOTE': '1', 08:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:36 INFO - 'NO_EM_RESTART': '1', 08:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:36 INFO - 'PWD': '/builds/slave/test', 08:09:36 INFO - 'SHELL': '/bin/bash', 08:09:36 INFO - 'SHLVL': '1', 08:09:36 INFO - 'TERM': 'linux', 08:09:36 INFO - 'TMOUT': '86400', 08:09:36 INFO - 'USER': 'cltbld', 08:09:36 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', 08:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:36 INFO - '_': '/tools/buildbot/bin/python'} 08:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:37 INFO - Downloading/unpacking psutil>=3.1.1 08:09:37 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 08:09:37 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 08:09:37 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 08:09:37 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 08:09:37 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 08:09:37 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 08:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:09:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:39 INFO - Installing collected packages: psutil 08:09:39 INFO - Running setup.py install for psutil 08:09:39 INFO - building 'psutil._psutil_linux' extension 08:09:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:09:39 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 08:09:39 INFO - building 'psutil._psutil_posix' extension 08:09:39 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 08:09:39 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 08:09:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:39 INFO - Successfully installed psutil 08:09:39 INFO - Cleaning up... 08:09:39 INFO - Return code: 0 08:09:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98849f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b29350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb81c0>, '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 0x1bb90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', '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 08:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:09:39 INFO - Using env: {'DISPLAY': ':0', 08:09:39 INFO - 'HOME': '/home/cltbld', 08:09:39 INFO - 'LANG': 'en_US.UTF-8', 08:09:39 INFO - 'LANGUAGE': 'en_US:en', 08:09:39 INFO - 'LOGNAME': 'cltbld', 08:09:39 INFO - 'MAIL': '/var/mail/cltbld', 08:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:39 INFO - 'MOZ_NO_REMOTE': '1', 08:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:39 INFO - 'NO_EM_RESTART': '1', 08:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:39 INFO - 'PWD': '/builds/slave/test', 08:09:39 INFO - 'SHELL': '/bin/bash', 08:09:39 INFO - 'SHLVL': '1', 08:09:39 INFO - 'TERM': 'linux', 08:09:39 INFO - 'TMOUT': '86400', 08:09:39 INFO - 'USER': 'cltbld', 08:09:39 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', 08:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:39 INFO - '_': '/tools/buildbot/bin/python'} 08:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 08: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 08: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 08: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 08: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 08: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 08: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 08:09:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:09:41 INFO - Installing collected packages: mozsystemmonitor 08:09:41 INFO - Running setup.py install for mozsystemmonitor 08:09:41 INFO - Successfully installed mozsystemmonitor 08:09:41 INFO - Cleaning up... 08:09:41 INFO - Return code: 0 08:09:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f98849f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b29350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb81c0>, '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 0x1bb90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', '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 08:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:09:41 INFO - Using env: {'DISPLAY': ':0', 08:09:41 INFO - 'HOME': '/home/cltbld', 08:09:41 INFO - 'LANG': 'en_US.UTF-8', 08:09:41 INFO - 'LANGUAGE': 'en_US:en', 08:09:41 INFO - 'LOGNAME': 'cltbld', 08:09:41 INFO - 'MAIL': '/var/mail/cltbld', 08:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:41 INFO - 'MOZ_NO_REMOTE': '1', 08:09:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:41 INFO - 'NO_EM_RESTART': '1', 08:09:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:41 INFO - 'PWD': '/builds/slave/test', 08:09:41 INFO - 'SHELL': '/bin/bash', 08:09:41 INFO - 'SHLVL': '1', 08:09:41 INFO - 'TERM': 'linux', 08:09:41 INFO - 'TMOUT': '86400', 08:09:41 INFO - 'USER': 'cltbld', 08:09:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', 08:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:41 INFO - '_': '/tools/buildbot/bin/python'} 08:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:42 INFO - Downloading/unpacking jsonschema==2.5.1 08:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:09:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:44 INFO - Downloading functools32-3.2.3-2.tar.gz 08:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:09:44 INFO - warning: no files found matching '*.txt' 08:09:44 INFO - no previously-included directories found matching 'build' 08:09:44 INFO - no previously-included directories found matching 'dist' 08:09:44 INFO - no previously-included directories found matching '.git*' 08:09:44 INFO - Installing collected packages: jsonschema, functools32 08:09:44 INFO - Running setup.py install for functools32 08:09:44 INFO - warning: no files found matching '*.txt' 08:09:44 INFO - no previously-included directories found matching 'build' 08:09:44 INFO - no previously-included directories found matching 'dist' 08:09:44 INFO - no previously-included directories found matching '.git*' 08:09:44 INFO - Successfully installed jsonschema functools32 08:09:44 INFO - Cleaning up... 08:09:44 INFO - Return code: 0 08:09:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98849f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b29350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb81c0>, '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 0x1bb90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', '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 08:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:09:44 INFO - Using env: {'DISPLAY': ':0', 08:09:44 INFO - 'HOME': '/home/cltbld', 08:09:44 INFO - 'LANG': 'en_US.UTF-8', 08:09:44 INFO - 'LANGUAGE': 'en_US:en', 08:09:44 INFO - 'LOGNAME': 'cltbld', 08:09:44 INFO - 'MAIL': '/var/mail/cltbld', 08:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:44 INFO - 'MOZ_NO_REMOTE': '1', 08:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:44 INFO - 'NO_EM_RESTART': '1', 08:09:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:44 INFO - 'PWD': '/builds/slave/test', 08:09:44 INFO - 'SHELL': '/bin/bash', 08:09:44 INFO - 'SHLVL': '1', 08:09:44 INFO - 'TERM': 'linux', 08:09:44 INFO - 'TMOUT': '86400', 08:09:44 INFO - 'USER': 'cltbld', 08:09:44 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', 08:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:44 INFO - '_': '/tools/buildbot/bin/python'} 08:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:44 INFO - Downloading/unpacking blobuploader==1.2.4 08:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:46 INFO - Downloading blobuploader-1.2.4.tar.gz 08:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:09:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:09:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:47 INFO - Downloading docopt-0.6.1.tar.gz 08:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:09:47 INFO - Installing collected packages: blobuploader, requests, docopt 08:09:47 INFO - Running setup.py install for blobuploader 08:09:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:09:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:09:47 INFO - Running setup.py install for requests 08:09:47 INFO - Running setup.py install for docopt 08:09:47 INFO - Successfully installed blobuploader requests docopt 08:09:47 INFO - Cleaning up... 08:09:47 INFO - Return code: 0 08:09:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98849f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b29350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb81c0>, '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 0x1bb90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', '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 08:09:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:47 INFO - Using env: {'DISPLAY': ':0', 08:09:47 INFO - 'HOME': '/home/cltbld', 08:09:47 INFO - 'LANG': 'en_US.UTF-8', 08:09:47 INFO - 'LANGUAGE': 'en_US:en', 08:09:47 INFO - 'LOGNAME': 'cltbld', 08:09:47 INFO - 'MAIL': '/var/mail/cltbld', 08:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:47 INFO - 'MOZ_NO_REMOTE': '1', 08:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:47 INFO - 'NO_EM_RESTART': '1', 08:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:47 INFO - 'PWD': '/builds/slave/test', 08:09:47 INFO - 'SHELL': '/bin/bash', 08:09:47 INFO - 'SHLVL': '1', 08:09:47 INFO - 'TERM': 'linux', 08:09:47 INFO - 'TMOUT': '86400', 08:09:47 INFO - 'USER': 'cltbld', 08:09:47 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', 08:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:47 INFO - '_': '/tools/buildbot/bin/python'} 08:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:48 INFO - Running setup.py (path:/tmp/pip-bc7rrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:48 INFO - Running setup.py (path:/tmp/pip-jRROgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:48 INFO - Running setup.py (path:/tmp/pip-f608yJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:48 INFO - Running setup.py (path:/tmp/pip-55zC3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:48 INFO - Running setup.py (path:/tmp/pip-YrfqEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:48 INFO - Running setup.py (path:/tmp/pip-2l_hBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:48 INFO - Running setup.py (path:/tmp/pip-hutUjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:48 INFO - Running setup.py (path:/tmp/pip-hy_rKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:48 INFO - Running setup.py (path:/tmp/pip-lPaN0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:48 INFO - Running setup.py (path:/tmp/pip-Crhyi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:48 INFO - Running setup.py (path:/tmp/pip-MhiT4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:48 INFO - Running setup.py (path:/tmp/pip-3TmS4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:48 INFO - Running setup.py (path:/tmp/pip-rvKse3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:49 INFO - Running setup.py (path:/tmp/pip-ix0bLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:49 INFO - Running setup.py (path:/tmp/pip-jr45HG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:49 INFO - Running setup.py (path:/tmp/pip-ZT5zTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:49 INFO - Running setup.py (path:/tmp/pip-fCTIRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:09:49 INFO - Running setup.py install for manifestparser 08:09:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:09:49 INFO - Running setup.py install for mozcrash 08:09:49 INFO - Running setup.py install for mozdebug 08:09:49 INFO - Running setup.py install for mozdevice 08:09:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:09:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:09:49 INFO - Running setup.py install for mozfile 08:09:49 INFO - Running setup.py install for mozhttpd 08:09:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:09:49 INFO - Running setup.py install for mozinfo 08:09:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:09:50 INFO - Running setup.py install for mozInstall 08:09:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:09:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:09:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:09:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:09:50 INFO - Running setup.py install for mozleak 08:09:50 INFO - Running setup.py install for mozlog 08:09:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:09:50 INFO - Running setup.py install for moznetwork 08:09:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:09:50 INFO - Running setup.py install for mozprocess 08:09:50 INFO - Running setup.py install for mozprofile 08:09:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:09:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:09:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:09:50 INFO - Running setup.py install for mozrunner 08:09:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:09:50 INFO - Running setup.py install for mozscreenshot 08:09:50 INFO - Running setup.py install for moztest 08:09:50 INFO - Running setup.py install for mozversion 08:09:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:09:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:09:51 INFO - Cleaning up... 08:09:51 INFO - Return code: 0 08:09:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98849f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b29350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb81c0>, '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 0x1bb90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', '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 08:09:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:51 INFO - Using env: {'DISPLAY': ':0', 08:09:51 INFO - 'HOME': '/home/cltbld', 08:09:51 INFO - 'LANG': 'en_US.UTF-8', 08:09:51 INFO - 'LANGUAGE': 'en_US:en', 08:09:51 INFO - 'LOGNAME': 'cltbld', 08:09:51 INFO - 'MAIL': '/var/mail/cltbld', 08:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:51 INFO - 'MOZ_NO_REMOTE': '1', 08:09:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:51 INFO - 'NO_EM_RESTART': '1', 08:09:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:51 INFO - 'PWD': '/builds/slave/test', 08:09:51 INFO - 'SHELL': '/bin/bash', 08:09:51 INFO - 'SHLVL': '1', 08:09:51 INFO - 'TERM': 'linux', 08:09:51 INFO - 'TMOUT': '86400', 08:09:51 INFO - 'USER': 'cltbld', 08:09:51 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', 08:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:51 INFO - '_': '/tools/buildbot/bin/python'} 08:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:51 INFO - Running setup.py (path:/tmp/pip-N7ULv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:51 INFO - Running setup.py (path:/tmp/pip-a6v6Q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:51 INFO - Running setup.py (path:/tmp/pip-1efWQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:51 INFO - Running setup.py (path:/tmp/pip-pPC4Vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:51 INFO - Running setup.py (path:/tmp/pip-HINGyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:51 INFO - Running setup.py (path:/tmp/pip-bbNVaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:51 INFO - Running setup.py (path:/tmp/pip-XKCZN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:51 INFO - Running setup.py (path:/tmp/pip-L4mfZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:51 INFO - Running setup.py (path:/tmp/pip-2bugOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:51 INFO - Running setup.py (path:/tmp/pip-Uzjicr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:52 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)) 08:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:52 INFO - Running setup.py (path:/tmp/pip-MpuJ5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:52 INFO - Running setup.py (path:/tmp/pip-S1U58D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:52 INFO - Running setup.py (path:/tmp/pip-qxqgfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:52 INFO - Running setup.py (path:/tmp/pip-UYFxkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:52 INFO - Running setup.py (path:/tmp/pip-L1Dqb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:52 INFO - Running setup.py (path:/tmp/pip-7BAreu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:52 INFO - Running setup.py (path:/tmp/pip-uSvKmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:54 INFO - Downloading blessings-1.6.tar.gz 08:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:09:54 INFO - Installing collected packages: blessings 08:09:54 INFO - Running setup.py install for blessings 08:09:54 INFO - Successfully installed blessings 08:09:54 INFO - Cleaning up... 08:09:54 INFO - Return code: 0 08:09:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:09:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:54 INFO - Reading from file tmpfile_stdout 08:09:54 INFO - Current package versions: 08:09:54 INFO - argparse == 1.2.1 08:09:54 INFO - blessings == 1.6 08:09:54 INFO - blobuploader == 1.2.4 08:09:54 INFO - docopt == 0.6.1 08:09:54 INFO - functools32 == 3.2.3-2 08:09:54 INFO - jsonschema == 2.5.1 08:09:54 INFO - manifestparser == 1.1 08:09:54 INFO - mozInstall == 1.12 08:09:54 INFO - mozcrash == 0.17 08:09:54 INFO - mozdebug == 0.1 08:09:54 INFO - mozdevice == 0.48 08:09:54 INFO - mozfile == 1.2 08:09:54 INFO - mozhttpd == 0.7 08:09:54 INFO - mozinfo == 0.9 08:09:54 INFO - mozleak == 0.1 08:09:54 INFO - mozlog == 3.2 08:09:54 INFO - moznetwork == 0.27 08:09:54 INFO - mozprocess == 0.22 08:09:54 INFO - mozprofile == 0.28 08:09:54 INFO - mozrunner == 6.11 08:09:54 INFO - mozscreenshot == 0.1 08:09:54 INFO - mozsystemmonitor == 0.3 08:09:54 INFO - moztest == 0.7 08:09:54 INFO - mozversion == 1.4 08:09:54 INFO - psutil == 3.1.1 08:09:54 INFO - requests == 1.2.3 08:09:54 INFO - wsgiref == 0.1.2 08:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98849f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b29350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb81c0>, '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 0x1bb90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', '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 08:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:54 INFO - Using env: {'DISPLAY': ':0', 08:09:54 INFO - 'HOME': '/home/cltbld', 08:09:54 INFO - 'LANG': 'en_US.UTF-8', 08:09:54 INFO - 'LANGUAGE': 'en_US:en', 08:09:54 INFO - 'LOGNAME': 'cltbld', 08:09:54 INFO - 'MAIL': '/var/mail/cltbld', 08:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:54 INFO - 'MOZ_NO_REMOTE': '1', 08:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:54 INFO - 'NO_EM_RESTART': '1', 08:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:54 INFO - 'PWD': '/builds/slave/test', 08:09:54 INFO - 'SHELL': '/bin/bash', 08:09:54 INFO - 'SHLVL': '1', 08:09:54 INFO - 'TERM': 'linux', 08:09:54 INFO - 'TMOUT': '86400', 08:09:54 INFO - 'USER': 'cltbld', 08:09:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', 08:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:54 INFO - '_': '/tools/buildbot/bin/python'} 08:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:09:55 INFO - Cleaning up... 08:09:55 INFO - Return code: 0 08:09:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98849f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b29350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb81c0>, '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 0x1bb90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', '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 08:09:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:09:55 INFO - Using env: {'DISPLAY': ':0', 08:09:55 INFO - 'HOME': '/home/cltbld', 08:09:55 INFO - 'LANG': 'en_US.UTF-8', 08:09:55 INFO - 'LANGUAGE': 'en_US:en', 08:09:55 INFO - 'LOGNAME': 'cltbld', 08:09:55 INFO - 'MAIL': '/var/mail/cltbld', 08:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:55 INFO - 'MOZ_NO_REMOTE': '1', 08:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:55 INFO - 'NO_EM_RESTART': '1', 08:09:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:55 INFO - 'PWD': '/builds/slave/test', 08:09:55 INFO - 'SHELL': '/bin/bash', 08:09:55 INFO - 'SHLVL': '1', 08:09:55 INFO - 'TERM': 'linux', 08:09:55 INFO - 'TMOUT': '86400', 08:09:55 INFO - 'USER': 'cltbld', 08:09:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', 08:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:55 INFO - '_': '/tools/buildbot/bin/python'} 08:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:09:55 INFO - Cleaning up... 08:09:55 INFO - Return code: 0 08:09:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98849f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b29350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb81c0>, '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 0x1bb90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', '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 08:09:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:09:55 INFO - Using env: {'DISPLAY': ':0', 08:09:55 INFO - 'HOME': '/home/cltbld', 08:09:55 INFO - 'LANG': 'en_US.UTF-8', 08:09:55 INFO - 'LANGUAGE': 'en_US:en', 08:09:55 INFO - 'LOGNAME': 'cltbld', 08:09:55 INFO - 'MAIL': '/var/mail/cltbld', 08:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:55 INFO - 'MOZ_NO_REMOTE': '1', 08:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:55 INFO - 'NO_EM_RESTART': '1', 08:09:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:55 INFO - 'PWD': '/builds/slave/test', 08:09:55 INFO - 'SHELL': '/bin/bash', 08:09:55 INFO - 'SHLVL': '1', 08:09:55 INFO - 'TERM': 'linux', 08:09:55 INFO - 'TMOUT': '86400', 08:09:55 INFO - 'USER': 'cltbld', 08:09:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', 08:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:55 INFO - '_': '/tools/buildbot/bin/python'} 08:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:55 INFO - Downloading/unpacking flake8 08:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:09:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:09:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:09:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:09:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:09:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:09:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:09:58 INFO - no previously-included directories found matching 'docs/_build' 08:09:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:09:58 INFO - Running setup.py install for pep8 08:09:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:09:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:09:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:09:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:09:58 INFO - no previously-included directories found matching 'docs/_build' 08:09:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:09:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:09:58 INFO - Cleaning up... 08:09:58 INFO - Return code: 0 08:09:58 INFO - Running post-action listener: _resource_record_post_action 08:09:58 INFO - Running post-action listener: _start_resource_monitoring 08:09:58 INFO - Starting resource monitoring. 08:09:58 INFO - ##### 08:09:58 INFO - ##### Finished create-virtualenv step (success) 08:09:58 INFO - ##### 08:09:58 INFO - ##### 08:09:58 INFO - ##### Running install step. 08:09:58 INFO - ##### 08:09:58 INFO - Running pre-action listener: _resource_record_pre_action 08:09:58 INFO - Running main action method: install 08:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:58 INFO - Reading from file tmpfile_stdout 08:09:58 INFO - Detecting whether we're running mozinstall >=1.0... 08:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:09:58 INFO - Reading from file tmpfile_stdout 08:09:58 INFO - Output received: 08:09:58 INFO - Usage: mozinstall [options] installer 08:09:58 INFO - Options: 08:09:58 INFO - -h, --help show this help message and exit 08:09:58 INFO - -d DEST, --destination=DEST 08:09:58 INFO - Directory to install application into. [default: 08:09:58 INFO - "/builds/slave/test"] 08:09:58 INFO - --app=APP Application being installed. [default: firefox] 08:09:58 INFO - mkdir: /builds/slave/test/build/application 08:09:58 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'] 08:09:58 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 08:10:15 INFO - Reading from file tmpfile_stdout 08:10:15 INFO - Output received: 08:10:15 INFO - /builds/slave/test/build/application/firefox/firefox 08:10:15 INFO - Running post-action listener: _resource_record_post_action 08:10:15 INFO - ##### 08:10:15 INFO - ##### Finished install step (success) 08:10:15 INFO - ##### 08:10:15 INFO - ##### 08:10:15 INFO - ##### Running run-tests step. 08:10:15 INFO - ##### 08:10:15 INFO - Running pre-action listener: _resource_record_pre_action 08:10:15 INFO - Running main action method: run_tests 08:10:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:10:15 INFO - Python 2.7.3 08:10:15 INFO - Return code: 0 08:10:15 INFO - grabbing minidump binary from tooltool 08:10: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')]} 08:10:15 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 0x1bb81c0>, '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 0x1bb90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb9550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:10:15 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 08:10:15 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 08:10:15 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 08:10:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:10:15 INFO - Return code: 0 08:10:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:10:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:10:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:10:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:10:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:10:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:10:16 INFO - Return code: 0 08:10:16 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:10:16 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:10:16 INFO - Using env: {'DISPLAY': ':0', 08:10:16 INFO - 'HOME': '/home/cltbld', 08:10:16 INFO - 'LANG': 'en_US.UTF-8', 08:10:16 INFO - 'LANGUAGE': 'en_US:en', 08:10:16 INFO - 'LOGNAME': 'cltbld', 08:10:16 INFO - 'MAIL': '/var/mail/cltbld', 08:10:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:10:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:10:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:16 INFO - 'MOZ_NO_REMOTE': '1', 08:10:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:10:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:16 INFO - 'NO_EM_RESTART': '1', 08:10:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:16 INFO - 'PWD': '/builds/slave/test', 08:10:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:10:16 INFO - 'SHELL': '/bin/bash', 08:10:16 INFO - 'SHLVL': '1', 08:10:16 INFO - 'TERM': 'linux', 08:10:16 INFO - 'TMOUT': '86400', 08:10:16 INFO - 'USER': 'cltbld', 08:10:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265', 08:10:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:16 INFO - '_': '/tools/buildbot/bin/python'} 08:10:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:10:16 INFO - mozversion application_buildid: 20160612053002 08:10:16 INFO - mozversion application_changeset: 016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d 08:10:16 INFO - mozversion application_display_name: Nightly 08:10:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:10:16 INFO - mozversion application_name: Firefox 08:10:16 INFO - mozversion application_remotingname: firefox 08:10:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:10:16 INFO - mozversion application_vendor: Mozilla 08:10:16 INFO - mozversion application_version: 50.0a1 08:10:16 INFO - mozversion platform_buildid: 20160612053002 08:10:16 INFO - mozversion platform_changeset: 016e0f47e8ad66ba6eb11fe28958e3a69ef9e53d 08:10:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:10:16 INFO - mozversion platform_version: 50.0a1 08:10:16 INFO - using testdate: 1465744216 08:10:16 INFO - actual date: 1465744216 08:10:16 INFO - starting webserver on 'localhost:35701' 08:10:16 INFO - SUITE-START | Running 2 tests 08:10:16 INFO - TEST-START | dromaeo_css 08:10:16 INFO - operating with platform_type : linux_ 08:10:16 INFO - Initialising browser for dromaeo_css test... 08:10:16 INFO - TEST-INFO | started process 12099 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvVBC4v/profile http://localhost:35701/getInfo.html) 08:10:21 INFO - PROCESS | 12099 | __metrics Screen width/height:1600/1200 08:10:21 INFO - PROCESS | 12099 | colorDepth:24 08:10:21 INFO - PROCESS | 12099 | Browser inner width/height: 1024/697 08:10:21 INFO - PROCESS | 12099 | __metrics 08:10:22 ERROR - PROCESS | 12099 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:10:23 INFO - TEST-INFO | 12099: exit 0 08:10:23 INFO - Browser initialized. 08:10:23 INFO - Running cycle 1/1 for dromaeo_css test... 08:10:23 INFO - TEST-INFO | started process 12216 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvVBC4v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:10:35 INFO - PROCESS | 12216 | RSS: Main: 184852480 08:10:35 INFO - PROCESS | 12216 | 08:11:24 INFO - PROCESS | 12216 | 1465744284804 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] 08:13:32 INFO - PROCESS | 12216 | Cycle 1(1): loaded http://localhost:35701/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35701/tests/dromaeo/cssquery-ext.html) 08:13:33 INFO - PROCESS | 12216 | RSS: Main: 189329408 08:13:33 INFO - PROCESS | 12216 | 08:16:35 INFO - PROCESS | 12216 | Cycle 1(1): loaded http://localhost:35701/tests/dromaeo/cssquery-ext.html (next: http://localhost:35701/tests/dromaeo/cssquery-jquery.html) 08:16:36 INFO - PROCESS | 12216 | RSS: Main: 187916288 08:16:36 INFO - PROCESS | 12216 | 08:19:38 INFO - PROCESS | 12216 | Cycle 1(1): loaded http://localhost:35701/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35701/tests/dromaeo/cssquery-mootools.html) 08:19:38 INFO - PROCESS | 12216 | RSS: Main: 189534208 08:19:38 INFO - PROCESS | 12216 | 08:22:40 INFO - PROCESS | 12216 | Cycle 1(1): loaded http://localhost:35701/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35701/tests/dromaeo/cssquery-prototype.html) 08:22:41 INFO - PROCESS | 12216 | RSS: Main: 186650624 08:22:41 INFO - PROCESS | 12216 | 08:25:43 INFO - PROCESS | 12216 | Cycle 1(1): loaded http://localhost:35701/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35701/tests/dromaeo/cssquery-yui.html) 08:25:44 INFO - PROCESS | 12216 | RSS: Main: 188469248 08:25:44 INFO - PROCESS | 12216 | 08:28:46 INFO - PROCESS | 12216 | Cycle 1(1): loaded http://localhost:35701/tests/dromaeo/cssquery-yui.html (next: http://localhost:35701/tests/dromaeo/cssquery-dojo.html) 08:28:47 INFO - PROCESS | 12216 | RSS: Main: 189272064 08:28:47 INFO - PROCESS | 12216 | 08:28:47 INFO - PROCESS | 12216 | __start_tp_report 08:28:47 INFO - PROCESS | 12216 | _x_x_mozilla_page_load 08:28:47 INFO - PROCESS | 12216 | _x_x_mozilla_page_load_details 08:28:47 INFO - PROCESS | 12216 | |i|pagename|runs| 08:28:47 INFO - PROCESS | 12216 | |0;dojo.html;3025.576419301298;3056.4192803367346;3083.5220540816167;3088.768342374321;3096.9535456968133;5130.230465430187;5138.177891537355;5203.869903252421;5290.153575427932;5297.125974214259;5075;5218.791248350061;5248.370195576526;5253.0544501989725;5284.735763211843;4738.857834264978;4773.785179666923;4844.830430934918;4911.189653707152;4949.950500494985;686.5820577963076;4874.073925954058;4902.901941961159;4910.386201724785;4960.801567937278;4741.108551942806;4763.333133361332;4769.4515130760055;4771.522847715235;4803.279508073782;4745.122152401782;4755.144074066667;4760.285957106462;4776.9761151194025;4820.783064762094;4733.952660473386;4744.976275118603;4748.548887855648;4758.524147585248;4760.857174284777;5186.066508028591;5232.633715639907;5244.292020577212;5255.474452554752;5303.284056652341;5531.612787104904;5584.6090773645865;5597.048501754712;5605.299337582802;5611.494965453088;5596.244506991545;5629.099344104923;5685.118806584945;5689.6586204827845;5732.22614946981;5209.374875014984;5258;5260.184671375943;5301;5347.224652425415;5562.415946325658;5696.3164420269;5734.397888221677;5771.769129234784;5774.364819869811;5523.143912693539;5544.417836127229;5550.500454959073;5562.527185189223;5564.554835613141;5575.860603484945;5589.133684278943;5615.803446879339;5620.297462817148;5624.0439125348785;5473.343198816167;5495.395506494282;5507.366652834895;5555.861103472445;5593.272874526286;5519.420460851553;5619.466150715675;5626.943730562642;5638.295213098363;5674.26234589509;4436.024074703624;4436.467623885154;4439.356293337512;4450.35469856869;4487.798049087799;3812.7799104286364;3862.9034274143373;3890.8054597270025;3912.315344814646;3912.960870391317;5342.786288548415;5360.383555891122;5367.651102678314;5380.623356365017;5418.864528386743;5537.972310138504;5628.493435590816;5644.407337229614;5667.914981275284;5671.829845104653;5310.840674779763;5350.946490535122;5369.785208591691;5385.946140538623;5388.407275199725;4705.482396936334;4719.528047195253;4738.502457242009;4762.52374762521;4767.070421267819;5723.570732195102;5793.8841223175305;5987.251593550806;5988.221531201003;5993.0710739835395;5556.083246264402;5616.494515493625;5625.493705566519;5630.465105814941;5678.829635110953;5869.266341707286;5882.088276317178;5885;5902.940970590239;5905.350411454822;5387.488188622075;5491.917621235605;5508.834734957958;5528.640638358494;5532.917006244829;5711.685857277889;5712.200291959046;5720.170575266647;5724.284464441945;5743.770249189985;5531.695756733418;5549.805756798654;5551.167324901297;5554.916791225673;5554.944450555443;5351.03681337363;5456.508914197741;5464.91802622953;5540.085885828793;5545.279113715191;5306.283651707125;5351.812686556108;5353.491418315254;5379.784808607612;5452.509274165344;5475.069238229431;5478.8904221914545;5508.91736623943;5525.143602741581;5547.916781248366;5235.554977826928;5380.408155103014;5383.7308134593895;5437.972810135924;5449.338877960077 08:28:47 INFO - PROCESS | 12216 | |1;ext.html;577.968211748354;604.4559896093515;616.7224748863011;618.7339444039061;634.1945728924263;43325.566744332544;44885;44895.32657010143;44916.77541612295;48089.27866082011;45694.54305456945;46237;46310.7684461578;46319.53680463194;46419.76790116045;8876.378653494241;8901.287896968228;8948.552572371387;8974.147455991702;8985.730428087169;8858.15847494487;8923.910760892406;8925.285977121846;8928.062553431893;8957;8961.910380896205;9008.324375671818;9040.09599040094;9046.411983221102;9102.908970910305;9008.324375671818;9057.501837398973;9073.863892041625;9085.500297483635;9089.727308180765;8863.335249856287;8926.955365223197;8943.910560894437;8948.105189481064;8948.8657670135;43365.56634433647;43591.34612980808;43595.56404435947;43649.563504364865;43771;3487.4071407860724;3882.437046628251;4027.436158937751;4169.937450938239;4321.611055005064;32258.516122258185;32874;32946;33269.16827079342;33674.6632533674;4199.2441360555085;4276.5295817460055;4336.631386332166;4344.283193273106;4517.07399983006;244962;246936;247261;248600;249625.7518712413;56682.716586416806;56836.43163568394;57503;57542.42457575454;57643;37216.44175337372;38019.23961520754;38056.238875222894;40590.59409405868;40707.796461017504;17546.912265438845;17639.82360176382;17720.91139544294;17889.910550447163;17911.910440447715;13656.112352697242;13686.110402823984;13769.554196809391;13803.309834508435;13868.930655346861;19397.740281718125;19465.4160375189;19547.804521954884;19676.90161549183;19743.506412339808;7012.684429200698;7059.647017649097;7064.1876184238445;7200.927990720131;7438.107427108782;964.5129209749172;995.770972676274;1021.7292417509366;1052.9891304347912;1130.4121856634504;32316.030519084467;32349.838250808596;32517;33129.67481300769;33385.666143338254;1134.2967360236541;1149.9770004599861;1154.4285578638628;1159.1654009113424;1186.1756079524648;16779.91610041942;16966.159170238425;17218.913905430643;17283.74074388885;17362.13189340528;532009;534153;537530;538026;541417;59818.700906495185;60168.699156503935;60421;60684.696576516835;60735.69632151811;1313.3302015971733;1371.136184203965;1372.0464277327162;1374.5326588960002;1374.9862501375057;31066.68933310638;31291.374172516877;31781;32239.516407253443;32662.34675306528;46483.767581161876;47202.76398617985;47220.29169562528;47239.29141062956;47493.76253118712;407838;413457;415000;418302;418324;29033.419331613673;29326;29818.403631927675;29891.850540747157;29984.85007574948;48612.51387486221;48837.75581122072;49477;50039.749801250764;50419;40332.39501407422;41560.376594350506;42129.36805947852;43109.56890431055;43288.78355608202;41980;42263.15473690571;42422.787886060374;42505;42794.14411711686;35070.82464587661;40185.39721904115;40547.39178912378;41012.38481422721;41665.58334416738;34250;37035.62964370322;37602.43596346112;37651.246975060894;37685.434718479795;28158.577621335287;28444.43111137807;28561.143165705063;28575.714242857306;28585.571216431355 08:28:47 INFO - PROCESS | 12216 | |2;jquery.html;393.3941729736205;400.6834600665474;401.7509144330514;407.5415157947309;411.67889046543706;12762.744745105092;17759.46721598351;17916.731249031276;19643;19752.604947901033;18317.81682183181;18741.250349986018;18981.62036759264;19149.138288777005;19177.712334314998;5570.498655121029;5683.175939488771;5706.457886500796;5756.971215143939;5812.186293918855;5462.672239665632;5757.222774925394;5757.596968212227;5797.478226959573;5837.387074357195;5740.0815869460685;5740.196372507852;5767.798127065554;5788.421157884199;5808.4481974212595;5382.838514844541;5643.068893632546;5725.770969161229;5752.6836024019085;5763.452472015152;5500.477454641803;5548.77804887804;5549.750261238254;5579.330480342344;5589.636673616202;13458.52895148665;13682.384292706853;17040.573985650335;22265.554688906293;22369.664455033024;2266.1841736974675;2272.5114100468313;2291.175176936302;2343.7304709958403;2351.8118550516087;10160.745981350525;10176.185905127646;10276.794464110752;10395.428251446167;10480.58077676892;1817.25492548056;1877.915493802782;1881.8734829642553;1914.0716752375088;1935.2742721479444;84769.57615211884;86697.13302866953;90813;90816;91750;10924.508397122148;10951.87871456647;11351.716207094889;11474.48364823585;11804.17370784037;16213.675726485404;16229.675406491804;16237.67524649524;16376.590585235464;16388.508344749676;7984.800379990546;8333.374996875258;8468.645016797283;8475.449095808754;8632.827343453097;7966.601669916481;8107.3108785753875;8118.837623247502;8195.098539160688;8250.092489826115;4794.496577859344;4956.083124621957;4968.453470118284;5097.08252514551;5103.923441148386;2005.4585261979184;2026.4427282497431;2043.3563427520282;2057.85595008348;2059.5160137367707;904.4302089683457;934.2759361494896;1035.5184839049878;1043.7390652336917;1047.5024363427463;17112.74330885038;18273.543161420806;18774;18977.146028428753;19101.61796764057;961.5576834655997;980.2843923935567;984.6602921991902;1013.2350075692952;1056.9207309451667;8441.70454034106;10745.194110441747;10750.462476876124;10750.838737418944;10783.08343790771;412941;417043;419668;420202;420742;81449.59275203705;90917.54541227252;93126;93731;95376.52311738535;965.9613615455303;985.0494273026563;990.2721499697716;999.2755252441922;1016.5323950982483;16776.66446671084;16812.831871681126;16865.409710660068;16896.23966921516;17317.393891213746;40933.38599921063;43136.78431607947;43138.13723725445;44663.330050049924;44730;60053.39946600478;60128;60740.69629651823;60914.390856090875;61861.38138618556;8691;8783.692570759993;8861.778455538662;8863.069377715246;8965.865512017195;9766.658166964122;13235.536756213487;13358.332083395597;13553.322333883068;13621.863781362059;5817.272840894888;8540.91459085426;11409.885901140882;11459.31244125355;11737.119716021161;10952.671419857417;11441.599544015919;11452.770944581229;11513.194076414571;11586.131040171853;11472.910073543;11679.474423650787;11707.414629268673;12014.159008869296;12176.817347739969;8655.30757539408;8786.769852220566;8871.822563548822;8989.865152022856;9023.323250756088;8970.37828339802;11509.13681473876;11544;11808.055355571361;12087 08:28:47 INFO - PROCESS | 12216 | |3;mootools.html;1441.9711605767884;1457.9489717859874;1563.9034711271681;1673.8995660260393;1702.906340151292;7736.883946740803;8571.957140214297;8651.653933842654;9087.99999999999;9115.316351273656;8702.869456958135;8967.10328967103;9050.1854833065;9077.09229077092;9086.454812711241;2353.5528249632557;2389.151851092863;2390.916317928873;2391.282615215437;2395.1138078910826;2367.4318163640687;2379.0721618568773;2408.7470815564375;2415.830891837572;2430.3195105370523;2335.252719129879;2347.835651504395;2372.667826504282;2422.236995346469;2424.5878200705833;2303.585354636165;2306.123673004264;2326.3835083702834;2328.9301320960312;2345.3315804995664;2277.87471689057;2278.3734473019886;2287.885605719707;2294.5755035318352;2316.316686577447;8957.059508751618;9097.818043639156;9098.545072746336;9117.863232051524;9136.634534618608;5238.188080847437;5386.326709161355;5394.838154855322;5398.325209348832;5419.485148910847;3415.7096646785053;3449.379111759882;3513.718902487795;3520.049586611626;3533.1343820764077;1155.8324043013715;1163.2438914705508;1164.7554013657057;1184.023180875781;2134.8292136629034;12238.265704057696;12793.61619151427;12829.61511154667;12830.422630981628;12861.099723019299;4496.842610508616;4517.34498497716;4525.434320709911;4598.333241679938;4605.240135377692;9870.851937220947;9933;9938;9964.750881227883;10009.299349045497;5114.462981386975;5135.306733590917;5162.74186290684;5168.715720635326;5178.741062946838;4324.935125973113;4751.548602882721;4914.655974081851;4948.05986862495;4952.133376659071;3788.583255841855;3861.864834730827;3914.451976723261;3958.762474251554;3991.2815693174925;1113.7804104505553;1114.1894421564957;1116.9273997190319;1124.7131981344705;1157.7742340243572;872.5855218771032;965.0879918476971;975.3221511049894;1009.5204777730667;1018.1345856022322;6116.877662446726;6159.5072394208355;6196.938030619636;6358.332375100548;6393.073004414334;436.75541696649975;437.7789216445738;451.22614715762626;451.69059194451904;453.5124740903542;4206.663466922639;4347.695691292663;4423.4912985006495;4453.19842428366;4481.7983190756495;10905.127589792955;11232.775344493064;11460.312381257152;11470.88529114715;11475;11217.831732524019;11306.886931130583;11320.264182828254;11335.319880807014;11340.829887551694;8060.8387832243025;8319.625616847256;8341.624626891804;8347.123552027071;8386.287165590871;5770.942290577041;5973.55198360116;6129.938700612936;6151.3541078186145;6301.306856245901;9801.607935682492;9978.251631127549;10163;10238.18094552449;10246;10292.279540432099;10358.792824143626;10403.84394234072;10624.36253824773;10628.681139565826;7429.257074292527;8269.793255168668;8515.318774497902;8623.094575069777;8767.21095101444;8586.141385861614;8604;8655.6970506032;8714.782130446789;8750.124987501198;7635.770926872203;7685.961570192113;7913.366930645419;8003.279704826594;8118.309943654619;7688.192739762245;7800.921990780246;7818.882716759139;7833.1775163607;7898.881516777138;7085.574865508086;7106.822329441805;7168.784936451706;7205.495615306878;7212.386947109554;5207.609429292743;5277.340332458442;5280.6303558750515;5340.732963351895;5384;5351.518363347317;5404.86497835459;5417.891642167214;5421.945780542144;5589.301337332833 08:28:47 INFO - PROCESS | 12216 | |4;prototype.html;301.1777846479112;315.50780781980114;318.48405582955616;322.9709326160645;323.7604172912044;5347.41178470368;5544.417836127209;5552.2232885476615;5603.1595260710865;5644.435556444359;5519.862003449915;5570.025245582017;5621.971890140544;5631.929933312678;5642.153676948449;4324.308110702288;4329.502107257658;4348.260795664744;4350.6301964332915;4380.299152135659;4061.6141466560775;4272.786360681969;4278.122984788127;4337.371081193225;4365.519792822787;4197.887559796656;4237.322028475444;4244.257254980382;4253.064325848324;4272.722273052257;4289.378040184171;4294.720843145185;4332.328489084197;4336.891577710582;4343.109662519176;3485.6862882340456;3744.925101497982;3754.648326602421;3769.981150094232;3779.5464544254864;5388.46115388458;5390.840969191603;5438.933205381969;5439.156930675712;5485.917711234335;4817.217629477116;4915.901681966377;4917.582005529534;4926.926096108561;4942.406911170647;5503.889922201533;5796.362400135981;5803.578123359804;5819.330776960662;5836.620619659751;4036.5156181258435;4049.4128351388886;4055.6958228133008;4062.857799976987;4082.448869402622;6068.968275393194;6084.330723620398;6118.479929205978;6133.85315139702;6137.78517751881;4090.2433049885867;4161.8335266589;4172.228137794517;4178.143480586473;4214.515330736943;4176.519700234512;4180.536812115796;4204.222218889454;4214.367844823301;4228.513720922072;4840.6127509799135;4876.292937524039;4879.829205977845;4894.898647804215;4902.803887844446;5308;5801.361850196475;5881.206037184926;5914.792982245601;5918.112283157561;1427.864352886474;1435.612384656137;1440.8833154305287;1449.4564538298139;1452.201289290907;898.4474548152839;910.3172620534599;918.4856480371013;927.1979737526991;932.1331162019387;4953.281774142802;4990.754160627732;4999.725015124131;5000.774965126578;5033.345665063518;5267.683938963674;5276.973615131899;5331.813386531453;5410.269613602192;5415.458454154632;5070.645054846125;5071.290019397287;5072.949270507322;5263.894722105537;5710.65736055838;3172.2386627209303;3177.205698575356;3202.743780497601;3206.2625596113025;3222.3555288942307;6085.634861908211;6193.411625895533;6247.96876015617;6255.40573645503;6259.7496100156395;6135.877282454415;6152.261728592597;6157.7229024694;6163.630182189083;6172.537059720539;6248.875022499525;6262.467690246289;6265.310815810257;6295.685215739195;6301.369863013753;5825.213596164633;6056.333803281724;6061.545384096122;6078.696065196811;6080.209572755513;5905.940940590539;5924.31870334917;5925.318588362394;6006;6041.24484439445;6034.431047927483;6225.346338634378;6290.465310448663;6309.242890853127;6380.94714372142;4150.252954468104;4166.375043743463;4196.559361267023;4202.789860507023;4213.873583792491;5768.826935191951;5835.854103647443;6024.307204671519;6070.605410648293;6097.7865774697675;5809.709514524341;5846.853828654148;5877.324107727495;5881.941180588139;5915.940840591539;5848.210491583582;5854.297484301911;5860.388393191906;5874.823755287348;5877.177195192591;5478.835634930959;5725.19847221381;5729.799457018984;5737.426257374396;5758.884822303614;5876.911846322394;5925.318588362394;5942.524598032233;5946.494547963472;5960.821175364746;5460.836174914759;5717.571182161438;5746.913796292975;5786.537077033743;5849.853753656193 08:28:47 INFO - PROCESS | 12216 | |5;yui.html;691.4917535611324;702.0978043214469;719.3921136639538;744.155383639569;758.7609902880592;15441.768373474408;16064.51806445807;16428.096454695;16470.588235294123;16526.752098718527;15135.318910649019;15299.15854627995;15341.923290383533;15368.308426120824;15427.768583471257;668.5387082912799;781.8749000159976;785.0579304834222;801.0667572278289;803.7347675267177;802.6628815897308;805.9435839491238;807.5598798654747;810.1412502747078;813.0893399392688;846.4286606540592;849.1041950741965;851.586980314547;855.0978717453085;856.3320609924269;841.9999999999969;843.0641987393988;843.3000609494105;843.5529169540154;852.526847599582;612.1093808508609;616.1866336435907;619.0219453263877;622.2408661433044;623.5728525959732;14650.267486625733;14767.778483322758;14805.407783688639;14805.629859253604;14833.184174870377;15221.31504082308;15319;15353.385864565404;15425.15161666108;15583.376664933388;11927.94036029823;12163;12182.634520964297;12671.936640316739;12819.102662813606;3849.8075096245075;3884.3008258513455;3891.591382904811;3893.980530097331;4037.354023356278;73035;73134.63432682856;73711;73983.63008185032;74032.62983685046;11394.866605153198;11630;11661.88338116625;11666.300021998708;11671.299722016705;22863.31410057701;22863.657045144337;23049.539009220058;23196.3041108767;23254.139668826454;8192.18078192188;8303.128171542023;8353.916460835435;8392.916070839336;9031.909680903107;4826.469088400273;4992.825251116194;5075.086484432837;5092.643514953992;5113.769880355393;3445.0698311456267;3577.248777756648;3591.048372181374;3591.066322756102;3591.694705949971;549.3023859698161;557.7852526777139;567.2823877794593;569.6297406685687;578.5256090006238;613.5091926458815;643.7618081309852;653.7483069018367;658.539022684123;674.130371820356;9019.909800901907;9422.528873556295;9474.489260346014;9760.804783904283;10080.69757907264;557.5901712241499;611.7338957553478;646.2051676438008;668.5754545863315;672.7477196051481;4500.549945005473;4671.462781780071;4716.268978308368;4722.574968252874;4851.660383773102;95162.52418738001;98235.50882245543;99141;114668.42665786618;118213.4089329565;108346;111234;112346.43826780813;112762;115549;56225;57142.142867857016;57333.14000289999;57481;57569.13646295309;9327.766805829908;9859.457729824928;9951.850722239316;9983.15143212835;10098.798024039625;53617.7319113402;54243.45756542384;54596.540345965084;55087;56316.43683563112;82914.58542707248;86861.69707454267;87321;87768.92808751919;88566.55716721374;11584.247023943417;11649.650510484698;11993.460294286953;12086.697832554257;12592.559260425842;11351.14866385008;13570.796438053634;13805.585832425044;13839.723205536035;14001.439942402598;11146.777064458827;11176.608818691308;13183.40674669623;13643.181409115485;13748;13039.82641562264;13434.462621495031;13854.792178117135;13868.791968120688;13987.020908536711;12526.49894004266;12987.35063246815;13058.804117938049;13260.801087983495;13292;10686.625968091079;11036.337819730841;11280.539426112779;11329.943350283196;11530.59642912494;10609.840852387066;11070.889291107307;11327.943360283145;11442;11446.198766086294 08:28:47 INFO - PROCESS | 12216 | __end_tp_report 08:28:47 INFO - PROCESS | 12216 | __start_cc_report 08:28:47 INFO - PROCESS | 12216 | _x_x_mozilla_cycle_collect,354 08:28:47 INFO - PROCESS | 12216 | __end_cc_report 08:28:47 INFO - PROCESS | 12216 | __startTimestamp1465745327041__endTimestamp 08:28:47 INFO - PROCESS | 12216 | 08:28:47 INFO - PROCESS | 12216 | ------- Summary: start ------- 08:28:47 INFO - PROCESS | 12216 | Number of tests: 6 08:28:47 INFO - PROCESS | 12216 | 08:28:47 INFO - PROCESS | 12216 | [#0] dojo.html Cycles:165 Average:5206.06 Median:5418.86 stddev:681.96 (12.6%) stddev-sans-first:662.26 08:28:47 INFO - PROCESS | 12216 | Values: 3025.6 3056.4 3083.5 3088.8 3097.0 5130.2 5138.2 5203.9 5290.2 5297.1 5075.0 5218.8 5248.4 5253.1 5284.7 4738.9 4773.8 4844.8 4911.2 4950.0 686.6 4874.1 4902.9 4910.4 4960.8 4741.1 4763.3 4769.5 4771.5 4803.3 4745.1 4755.1 4760.3 4777.0 4820.8 4734.0 4745.0 4748.5 4758.5 4760.9 5186.1 5232.6 5244.3 5255.5 5303.3 5531.6 5584.6 5597.0 5605.3 5611.5 5596.2 5629.1 5685.1 5689.7 5732.2 5209.4 5258.0 5260.2 5301.0 5347.2 5562.4 5696.3 5734.4 5771.8 5774.4 5523.1 5544.4 5550.5 5562.5 5564.6 5575.9 5589.1 5615.8 5620.3 5624.0 5473.3 5495.4 5507.4 5555.9 5593.3 5519.4 5619.5 5626.9 5638.3 5674.3 4436.0 4436.5 4439.4 4450.4 4487.8 3812.8 3862.9 3890.8 3912.3 3913.0 5342.8 5360.4 5367.7 5380.6 5418.9 5538.0 5628.5 5644.4 5667.9 5671.8 5310.8 5350.9 5369.8 5385.9 5388.4 4705.5 4719.5 4738.5 4762.5 4767.1 5723.6 5793.9 5987.3 5988.2 5993.1 5556.1 5616.5 5625.5 5630.5 5678.8 5869.3 5882.1 5885.0 5902.9 5905.4 5387.5 5491.9 5508.8 5528.6 5532.9 5711.7 5712.2 5720.2 5724.3 5743.8 5531.7 5549.8 5551.2 5554.9 5554.9 5351.0 5456.5 5464.9 5540.1 5545.3 5306.3 5351.8 5353.5 5379.8 5452.5 5475.1 5478.9 5508.9 5525.1 5547.9 5235.6 5380.4 5383.7 5438.0 5449.3 08:28:47 INFO - PROCESS | 12216 | 08:28:47 INFO - PROCESS | 12216 | [#1] ext.html Cycles:180 Average:56560.33 Median:23164.31 stddev:110634.15 (477.6%) stddev-sans-first:110864.66 08:28:47 INFO - PROCESS | 12216 | Values: 578.0 604.5 616.7 618.7 634.2 43325.6 44885.0 44895.3 44916.8 48089.3 45694.5 46237.0 46310.8 46319.5 46419.8 8876.4 8901.3 8948.6 8974.1 8985.7 8858.2 8923.9 8925.3 8928.1 8957.0 8961.9 9008.3 9040.1 9046.4 9102.9 9008.3 9057.5 9073.9 9085.5 9089.7 8863.3 8927.0 8943.9 8948.1 8948.9 43365.6 43591.3 43595.6 43649.6 43771.0 3487.4 3882.4 4027.4 4169.9 4321.6 32258.5 32874.0 32946.0 33269.2 33674.7 4199.2 4276.5 4336.6 4344.3 4517.1 244962.0 246936.0 247261.0 248600.0 249625.8 56682.7 56836.4 57503.0 57542.4 57643.0 37216.4 38019.2 38056.2 40590.6 40707.8 17546.9 17639.8 17720.9 17889.9 17911.9 13656.1 13686.1 13769.6 13803.3 13868.9 19397.7 19465.4 19547.8 19676.9 19743.5 7012.7 7059.6 7064.2 7200.9 7438.1 964.5 995.8 1021.7 1053.0 1130.4 32316.0 32349.8 32517.0 33129.7 33385.7 1134.3 1150.0 1154.4 1159.2 1186.2 16779.9 16966.2 17218.9 17283.7 17362.1 532009.0 534153.0 537530.0 538026.0 541417.0 59818.7 60168.7 60421.0 60684.7 60735.7 1313.3 1371.1 1372.0 1374.5 1375.0 31066.7 31291.4 31781.0 32239.5 32662.3 46483.8 47202.8 47220.3 47239.3 47493.8 407838.0 413457.0 415000.0 418302.0 418324.0 29033.4 29326.0 29818.4 29891.9 29984.9 48612.5 48837.8 49477.0 50039.7 50419.0 40332.4 41560.4 42129.4 43109.6 43288.8 41980.0 42263.2 42422.8 42505.0 42794.1 35070.8 40185.4 40547.4 41012.4 41665.6 34250.0 37035.6 37602.4 37651.2 37685.4 28158.6 28444.4 28561.1 28575.7 28585.6 08:28:47 INFO - PROCESS | 12216 | 08:28:47 INFO - PROCESS | 12216 | [#2] jquery.html Cycles:180 Average:27053.58 Median:20672.53 stddev:69647.54 (336.9%) stddev-sans-first:69814.15 08:28:47 INFO - PROCESS | 12216 | Values: 393.4 400.7 401.8 407.5 411.7 12762.7 17759.5 17916.7 19643.0 19752.6 18317.8 18741.3 18981.6 19149.1 19177.7 5570.5 5683.2 5706.5 5757.0 5812.2 5462.7 5757.2 5757.6 5797.5 5837.4 5740.1 5740.2 5767.8 5788.4 5808.4 5382.8 5643.1 5725.8 5752.7 5763.5 5500.5 5548.8 5549.8 5579.3 5589.6 13458.5 13682.4 17040.6 22265.6 22369.7 2266.2 2272.5 2291.2 2343.7 2351.8 10160.7 10176.2 10276.8 10395.4 10480.6 1817.3 1877.9 1881.9 1914.1 1935.3 84769.6 86697.1 90813.0 90816.0 91750.0 10924.5 10951.9 11351.7 11474.5 11804.2 16213.7 16229.7 16237.7 16376.6 16388.5 7984.8 8333.4 8468.6 8475.4 8632.8 7966.6 8107.3 8118.8 8195.1 8250.1 4794.5 4956.1 4968.5 5097.1 5103.9 2005.5 2026.4 2043.4 2057.9 2059.5 904.4 934.3 1035.5 1043.7 1047.5 17112.7 18273.5 18774.0 18977.1 19101.6 961.6 980.3 984.7 1013.2 1056.9 8441.7 10745.2 10750.5 10750.8 10783.1 412941.0 417043.0 419668.0 420202.0 420742.0 81449.6 90917.5 93126.0 93731.0 95376.5 966.0 985.0 990.3 999.3 1016.5 16776.7 16812.8 16865.4 16896.2 17317.4 40933.4 43136.8 43138.1 44663.3 44730.0 60053.4 60128.0 60740.7 60914.4 61861.4 8691.0 8783.7 8861.8 8863.1 8965.9 9766.7 13235.5 13358.3 13553.3 13621.9 5817.3 8540.9 11409.9 11459.3 11737.1 10952.7 11441.6 11452.8 11513.2 11586.1 11472.9 11679.5 11707.4 12014.2 12176.8 8655.3 8786.8 8871.8 8989.9 9023.3 8970.4 11509.1 11544.0 11808.1 12087.0 08:28:47 INFO - PROCESS | 12216 | 08:28:47 INFO - PROCESS | 12216 | [#3] mootools.html Cycles:180 Average:5903.46 Median:4601.79 stddev:3391.29 (73.7%) stddev-sans-first:3384.23 08:28:47 INFO - PROCESS | 12216 | Values: 1442.0 1457.9 1563.9 1673.9 1702.9 7736.9 8572.0 8651.7 9088.0 9115.3 8702.9 8967.1 9050.2 9077.1 9086.5 2353.6 2389.2 2390.9 2391.3 2395.1 2367.4 2379.1 2408.7 2415.8 2430.3 2335.3 2347.8 2372.7 2422.2 2424.6 2303.6 2306.1 2326.4 2328.9 2345.3 2277.9 2278.4 2287.9 2294.6 2316.3 8957.1 9097.8 9098.5 9117.9 9136.6 5238.2 5386.3 5394.8 5398.3 5419.5 3415.7 3449.4 3513.7 3520.0 3533.1 1155.8 1163.2 1164.8 1184.0 2134.8 12238.3 12793.6 12829.6 12830.4 12861.1 4496.8 4517.3 4525.4 4598.3 4605.2 9870.9 9933.0 9938.0 9964.8 10009.3 5114.5 5135.3 5162.7 5168.7 5178.7 4324.9 4751.5 4914.7 4948.1 4952.1 3788.6 3861.9 3914.5 3958.8 3991.3 1113.8 1114.2 1116.9 1124.7 1157.8 872.6 965.1 975.3 1009.5 1018.1 6116.9 6159.5 6196.9 6358.3 6393.1 436.8 437.8 451.2 451.7 453.5 4206.7 4347.7 4423.5 4453.2 4481.8 10905.1 11232.8 11460.3 11470.9 11475.0 11217.8 11306.9 11320.3 11335.3 11340.8 8060.8 8319.6 8341.6 8347.1 8386.3 5770.9 5973.6 6129.9 6151.4 6301.3 9801.6 9978.3 10163.0 10238.2 10246.0 10292.3 10358.8 10403.8 10624.4 10628.7 7429.3 8269.8 8515.3 8623.1 8767.2 8586.1 8604.0 8655.7 8714.8 8750.1 7635.8 7686.0 7913.4 8003.3 8118.3 7688.2 7800.9 7818.9 7833.2 7898.9 7085.6 7106.8 7168.8 7205.5 7212.4 5207.6 5277.3 5280.6 5340.7 5384.0 5351.5 5404.9 5417.9 5421.9 5589.3 08:28:47 INFO - PROCESS | 12216 | 08:28:47 INFO - PROCESS | 12216 | [#4] prototype.html Cycles:180 Average:4855.23 Median:5469.84 stddev:1459.04 (26.7%) stddev-sans-first:1422.53 08:28:47 INFO - PROCESS | 12216 | Values: 301.2 315.5 318.5 323.0 323.8 5347.4 5544.4 5552.2 5603.2 5644.4 5519.9 5570.0 5622.0 5631.9 5642.2 4324.3 4329.5 4348.3 4350.6 4380.3 4061.6 4272.8 4278.1 4337.4 4365.5 4197.9 4237.3 4244.3 4253.1 4272.7 4289.4 4294.7 4332.3 4336.9 4343.1 3485.7 3744.9 3754.6 3770.0 3779.5 5388.5 5390.8 5438.9 5439.2 5485.9 4817.2 4915.9 4917.6 4926.9 4942.4 5503.9 5796.4 5803.6 5819.3 5836.6 4036.5 4049.4 4055.7 4062.9 4082.4 6069.0 6084.3 6118.5 6133.9 6137.8 4090.2 4161.8 4172.2 4178.1 4214.5 4176.5 4180.5 4204.2 4214.4 4228.5 4840.6 4876.3 4879.8 4894.9 4902.8 5308.0 5801.4 5881.2 5914.8 5918.1 1427.9 1435.6 1440.9 1449.5 1452.2 898.4 910.3 918.5 927.2 932.1 4953.3 4990.8 4999.7 5000.8 5033.3 5267.7 5277.0 5331.8 5410.3 5415.5 5070.6 5071.3 5072.9 5263.9 5710.7 3172.2 3177.2 3202.7 3206.3 3222.4 6085.6 6193.4 6248.0 6255.4 6259.7 6135.9 6152.3 6157.7 6163.6 6172.5 6248.9 6262.5 6265.3 6295.7 6301.4 5825.2 6056.3 6061.5 6078.7 6080.2 5905.9 5924.3 5925.3 6006.0 6041.2 6034.4 6225.3 6290.5 6309.2 6380.9 4150.3 4166.4 4196.6 4202.8 4213.9 5768.8 5835.9 6024.3 6070.6 6097.8 5809.7 5846.9 5877.3 5881.9 5915.9 5848.2 5854.3 5860.4 5874.8 5877.2 5478.8 5725.2 5729.8 5737.4 5758.9 5876.9 5925.3 5942.5 5946.5 5960.8 5460.8 5717.6 5746.9 5786.5 5849.9 08:28:47 INFO - PROCESS | 12216 | 08:28:47 INFO - PROCESS | 12216 | [#5] yui.html Cycles:180 Average:20454.41 Median:4693.87 stddev:29439.33 (627.2%) stddev-sans-first:29484.51 08:28:47 INFO - PROCESS | 12216 | Values: 691.5 702.1 719.4 744.2 758.8 15441.8 16064.5 16428.1 16470.6 16526.8 15135.3 15299.2 15341.9 15368.3 15427.8 668.5 781.9 785.1 801.1 803.7 802.7 805.9 807.6 810.1 813.1 846.4 849.1 851.6 855.1 856.3 842.0 843.1 843.3 843.6 852.5 612.1 616.2 619.0 622.2 623.6 14650.3 14767.8 14805.4 14805.6 14833.2 15221.3 15319.0 15353.4 15425.2 15583.4 11927.9 12163.0 12182.6 12671.9 12819.1 3849.8 3884.3 3891.6 3894.0 4037.4 73035.0 73134.6 73711.0 73983.6 74032.6 11394.9 11630.0 11661.9 11666.3 11671.3 22863.3 22863.7 23049.5 23196.3 23254.1 8192.2 8303.1 8353.9 8392.9 9031.9 4826.5 4992.8 5075.1 5092.6 5113.8 3445.1 3577.2 3591.0 3591.1 3591.7 549.3 557.8 567.3 569.6 578.5 613.5 643.8 653.7 658.5 674.1 9019.9 9422.5 9474.5 9760.8 10080.7 557.6 611.7 646.2 668.6 672.7 4500.5 4671.5 4716.3 4722.6 4851.7 95162.5 98235.5 99141.0 114668.4 118213.4 108346.0 111234.0 112346.4 112762.0 115549.0 56225.0 57142.1 57333.1 57481.0 57569.1 9327.8 9859.5 9951.9 9983.2 10098.8 53617.7 54243.5 54596.5 55087.0 56316.4 82914.6 86861.7 87321.0 87768.9 88566.6 11584.2 11649.7 11993.5 12086.7 12592.6 11351.1 13570.8 13805.6 13839.7 14001.4 11146.8 11176.6 13183.4 13643.2 13748.0 13039.8 13434.5 13854.8 13868.8 13987.0 12526.5 12987.4 13058.8 13260.8 13292.0 10686.6 11036.3 11280.5 11329.9 11530.6 10609.8 11070.9 11327.9 11442.0 11446.2 08:28:47 INFO - PROCESS | 12216 | -------- Summary: end -------- 08:28:47 INFO - PROCESS | 12216 | 08:28:47 INFO - TEST-INFO | 12216: exit 0 08:28:47 INFO - TEST-OK | dromaeo_css | took 1110995ms 08:28:47 INFO - TEST-START | kraken 08:28:47 INFO - operating with platform_type : linux_ 08:28:47 INFO - Initialising browser for kraken test... 08:28:47 INFO - TEST-INFO | started process 12453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqpBslV/profile http://localhost:35701/getInfo.html) 08:28:52 INFO - PROCESS | 12453 | __metrics Screen width/height:1600/1200 08:28:52 INFO - PROCESS | 12453 | colorDepth:24 08:28:52 INFO - PROCESS | 12453 | Browser inner width/height: 1024/697 08:28:52 INFO - PROCESS | 12453 | __metrics 08:28:53 ERROR - PROCESS | 12453 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:28:54 INFO - TEST-INFO | 12453: exit 0 08:28:54 INFO - Browser initialized. 08:28:54 INFO - Running cycle 1/1 for kraken test... 08:28:54 INFO - TEST-INFO | started process 12573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqpBslV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:06 INFO - PROCESS | 12573 | RSS: Main: 184582144 08:29:06 INFO - PROCESS | 12573 | 08:29:08 INFO - PROCESS | 12573 | Cycle 1(1): loaded http://localhost:35701/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35701/tests/kraken/driver.html?testName=audio-beat-detection) 08:29:09 INFO - PROCESS | 12573 | RSS: Main: 190681088 08:29:09 INFO - PROCESS | 12573 | 08:29:12 INFO - PROCESS | 12573 | Cycle 1(1): loaded http://localhost:35701/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35701/tests/kraken/driver.html?testName=audio-dft) 08:29:12 INFO - PROCESS | 12573 | RSS: Main: 190050304 08:29:12 INFO - PROCESS | 12573 | 08:29:15 INFO - PROCESS | 12573 | Cycle 1(1): loaded http://localhost:35701/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35701/tests/kraken/driver.html?testName=audio-fft) 08:29:16 INFO - PROCESS | 12573 | RSS: Main: 185073664 08:29:16 INFO - PROCESS | 12573 | 08:29:18 INFO - PROCESS | 12573 | Cycle 1(1): loaded http://localhost:35701/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35701/tests/kraken/driver.html?testName=audio-oscillator) 08:29:19 INFO - PROCESS | 12573 | RSS: Main: 185962496 08:29:19 INFO - PROCESS | 12573 | 08:29:21 INFO - PROCESS | 12573 | Cycle 1(1): loaded http://localhost:35701/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35701/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:29:21 INFO - PROCESS | 12573 | RSS: Main: 186368000 08:29:21 INFO - PROCESS | 12573 | 08:29:25 INFO - PROCESS | 12573 | Cycle 1(1): loaded http://localhost:35701/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35701/tests/kraken/driver.html?testName=imaging-darkroom) 08:29:25 INFO - PROCESS | 12573 | RSS: Main: 186605568 08:29:25 INFO - PROCESS | 12573 | 08:29:29 INFO - PROCESS | 12573 | Cycle 1(1): loaded http://localhost:35701/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35701/tests/kraken/driver.html?testName=imaging-desaturate) 08:29:29 INFO - PROCESS | 12573 | RSS: Main: 183529472 08:29:29 INFO - PROCESS | 12573 | 08:29:32 INFO - PROCESS | 12573 | Cycle 1(1): loaded http://localhost:35701/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35701/tests/kraken/driver.html?testName=json-parse-financial) 08:29:33 INFO - PROCESS | 12573 | RSS: Main: 184668160 08:29:33 INFO - PROCESS | 12573 | 08:29:34 INFO - PROCESS | 12573 | Cycle 1(1): loaded http://localhost:35701/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35701/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:29:35 INFO - PROCESS | 12573 | RSS: Main: 185524224 08:29:35 INFO - PROCESS | 12573 | 08:29:37 INFO - PROCESS | 12573 | Cycle 1(1): loaded http://localhost:35701/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35701/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:29:37 INFO - PROCESS | 12573 | RSS: Main: 185540608 08:29:37 INFO - PROCESS | 12573 | 08:29:39 INFO - PROCESS | 12573 | Cycle 1(1): loaded http://localhost:35701/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35701/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:29:40 INFO - PROCESS | 12573 | RSS: Main: 186105856 08:29:40 INFO - PROCESS | 12573 | 08:29:43 INFO - PROCESS | 12573 | Cycle 1(1): loaded http://localhost:35701/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35701/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:29:43 INFO - PROCESS | 12573 | RSS: Main: 186662912 08:29:43 INFO - PROCESS | 12573 | 08:29:46 INFO - PROCESS | 12573 | Cycle 1(1): loaded http://localhost:35701/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35701/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:29:47 INFO - PROCESS | 12573 | RSS: Main: 186347520 08:29:47 INFO - PROCESS | 12573 | 08:29:48 INFO - PROCESS | 12573 | Cycle 1(1): loaded http://localhost:35701/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35701/tests/kraken/driver.html?testName=ai-astar) 08:29:49 INFO - PROCESS | 12573 | RSS: Main: 187289600 08:29:49 INFO - PROCESS | 12573 | 08:29:49 INFO - PROCESS | 12573 | __start_tp_report 08:29:49 INFO - PROCESS | 12573 | _x_x_mozilla_page_load 08:29:49 INFO - PROCESS | 12573 | _x_x_mozilla_page_load_details 08:29:49 INFO - PROCESS | 12573 | |i|pagename|runs| 08:29:49 INFO - PROCESS | 12573 | |0;ai-astar;113;107;113;112;113;113;112;111;111;113 08:29:49 INFO - PROCESS | 12573 | |1;audio-beat-detection;148;124;155;175;127;157;161;128;197;131 08:29:49 INFO - PROCESS | 12573 | |2;audio-dft;163;163;163;161;164;174;164;163;162;161 08:29:49 INFO - PROCESS | 12573 | |3;audio-fft;76;77;75;159;77;74;75;77;165;76 08:29:49 INFO - PROCESS | 12573 | |4;audio-oscillator;85;85;146;86;85;86;149;88;85;142 08:29:49 INFO - PROCESS | 12573 | |5;imaging-gaussian-blur;118;117;119;118;117;119;117;117;117;118 08:29:49 INFO - PROCESS | 12573 | |6;imaging-darkroom;148;147;146;148;146;147;148;147;148;148 08:29:49 INFO - PROCESS | 12573 | |7;imaging-desaturate;96;96;95;100;97;96;97;97;96;95 08:29:49 INFO - PROCESS | 12573 | |8;json-parse-financial;53;52;57;53;55;55;53;53;53;53 08:29:49 INFO - PROCESS | 12573 | |9;json-stringify-tinderbox;63;60;62;61;61;61;61;62;61;62 08:29:49 INFO - PROCESS | 12573 | |10;stanford-crypto-aes;84;79;82;79;82;81;81;83;103;80 08:29:49 INFO - PROCESS | 12573 | |11;stanford-crypto-ccm;126;122;126;124;123;140;131;132;126;136 08:29:49 INFO - PROCESS | 12573 | |12;stanford-crypto-pbkdf2;165;158;162;158;163;163;165;162;156;157 08:29:49 INFO - PROCESS | 12573 | |13;stanford-crypto-sha256-iterative;72;65;62;62;67;63;63;63;63;62 08:29:49 INFO - PROCESS | 12573 | __end_tp_report 08:29:49 INFO - PROCESS | 12573 | __start_cc_report 08:29:49 INFO - PROCESS | 12573 | _x_x_mozilla_cycle_collect,892 08:29:49 INFO - PROCESS | 12573 | __end_cc_report 08:29:49 INFO - PROCESS | 12573 | __startTimestamp1465745389134__endTimestamp 08:29:49 INFO - PROCESS | 12573 | 08:29:49 INFO - PROCESS | 12573 | ------- Summary: start ------- 08:29:49 INFO - PROCESS | 12573 | Number of tests: 14 08:29:49 INFO - PROCESS | 12573 | 08:29:49 INFO - PROCESS | 12573 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:1.87 (1.7%) stddev-sans-first:1.94 08:29:49 INFO - PROCESS | 12573 | Values: 113.0 107.0 113.0 112.0 113.0 113.0 112.0 111.0 111.0 113.0 08:29:49 INFO - PROCESS | 12573 | 08:29:49 INFO - PROCESS | 12573 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:156.00 stddev:23.76 (15.2%) stddev-sans-first:25.19 08:29:49 INFO - PROCESS | 12573 | Values: 148.0 124.0 155.0 175.0 127.0 157.0 161.0 128.0 197.0 131.0 08:29:49 INFO - PROCESS | 12573 | 08:29:49 INFO - PROCESS | 12573 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:3.74 (2.3%) stddev-sans-first:3.95 08:29:49 INFO - PROCESS | 12573 | Values: 163.0 163.0 163.0 161.0 164.0 174.0 164.0 163.0 162.0 161.0 08:29:49 INFO - PROCESS | 12573 | 08:29:49 INFO - PROCESS | 12573 | [#3] audio-fft Cycles:10 Average:93.10 Median:76.00 stddev:36.35 (47.8%) stddev-sans-first:38.03 08:29:49 INFO - PROCESS | 12573 | Values: 76.0 77.0 75.0 159.0 77.0 74.0 75.0 77.0 165.0 76.0 08:29:49 INFO - PROCESS | 12573 | 08:29:49 INFO - PROCESS | 12573 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:85.00 stddev:29.02 (34.1%) stddev-sans-first:29.98 08:29:49 INFO - PROCESS | 12573 | Values: 85.0 85.0 146.0 86.0 85.0 86.0 149.0 88.0 85.0 142.0 08:29:49 INFO - PROCESS | 12573 | 08:29:49 INFO - PROCESS | 12573 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 08:29:49 INFO - PROCESS | 12573 | Values: 118.0 117.0 119.0 118.0 117.0 119.0 117.0 117.0 117.0 118.0 08:29:49 INFO - PROCESS | 12573 | 08:29:49 INFO - PROCESS | 12573 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 08:29:49 INFO - PROCESS | 12573 | Values: 148.0 147.0 146.0 148.0 146.0 147.0 148.0 147.0 148.0 148.0 08:29:49 INFO - PROCESS | 12573 | 08:29:49 INFO - PROCESS | 12573 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.43 (1.5%) stddev-sans-first:1.51 08:29:49 INFO - PROCESS | 12573 | Values: 96.0 96.0 95.0 100.0 97.0 96.0 97.0 97.0 96.0 95.0 08:29:49 INFO - PROCESS | 12573 | 08:29:49 INFO - PROCESS | 12573 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.00 stddev:1.49 (2.8%) stddev-sans-first:1.56 08:29:49 INFO - PROCESS | 12573 | Values: 53.0 52.0 57.0 53.0 55.0 55.0 53.0 53.0 53.0 53.0 08:29:49 INFO - PROCESS | 12573 | 08:29:49 INFO - PROCESS | 12573 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.84 (1.4%) stddev-sans-first:0.67 08:29:49 INFO - PROCESS | 12573 | Values: 63.0 60.0 62.0 61.0 61.0 61.0 61.0 62.0 61.0 62.0 08:29:49 INFO - PROCESS | 12573 | 08:29:49 INFO - PROCESS | 12573 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:81.50 stddev:7.07 (8.7%) stddev-sans-first:7.50 08:29:49 INFO - PROCESS | 12573 | Values: 84.0 79.0 82.0 79.0 82.0 81.0 81.0 83.0 103.0 80.0 08:29:49 INFO - PROCESS | 12573 | 08:29:49 INFO - PROCESS | 12573 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:128.50 stddev:5.95 (4.6%) stddev-sans-first:6.23 08:29:49 INFO - PROCESS | 12573 | Values: 126.0 122.0 126.0 124.0 123.0 140.0 131.0 132.0 126.0 136.0 08:29:49 INFO - PROCESS | 12573 | 08:29:49 INFO - PROCESS | 12573 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:162.50 stddev:3.35 (2.1%) stddev-sans-first:3.21 08:29:49 INFO - PROCESS | 12573 | Values: 165.0 158.0 162.0 158.0 163.0 163.0 165.0 162.0 156.0 157.0 08:29:49 INFO - PROCESS | 12573 | 08:29:49 INFO - PROCESS | 12573 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:63.00 stddev:3.16 (5.0%) stddev-sans-first:1.66 08:29:49 INFO - PROCESS | 12573 | Values: 72.0 65.0 62.0 62.0 67.0 63.0 63.0 63.0 63.0 62.0 08:29:49 INFO - PROCESS | 12573 | -------- Summary: end -------- 08:29:49 INFO - PROCESS | 12573 | 08:29:50 INFO - TEST-INFO | 12573: exit 0 08:29:50 INFO - TEST-OK | kraken | took 62358ms 08:29:50 INFO - SUITE-END | took 1173s 08:29:50 INFO - Completed test suite (00:19:33) 08:29:50 INFO - javascript benchmark 08:29:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7221.151806223229, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3025.576419301298, 3056.4192803367346, 3083.5220540816167, 3088.768342374321, 3096.9535456968133, 5130.230465430187, 5138.177891537355, 5203.869903252421, 5290.153575427932, 5297.125974214259, 5075.0, 5218.791248350061, 5248.370195576526, 5253.0544501989725, 5284.735763211843, 4738.857834264978, 4773.785179666923, 4844.830430934918, 4911.189653707152, 4949.950500494985, 686.5820577963076, 4874.073925954058, 4902.901941961159, 4910.386201724785, 4960.801567937278, 4741.108551942806, 4763.333133361332, 4769.4515130760055, 4771.522847715235, 4803.279508073782, 4745.122152401782, 4755.144074066667, 4760.285957106462, 4776.9761151194025, 4820.783064762094, 4733.952660473386, 4744.976275118603, 4748.548887855648, 4758.524147585248, 4760.857174284777, 5186.066508028591, 5232.633715639907, 5244.292020577212, 5255.474452554752, 5303.284056652341, 5531.612787104904, 5584.6090773645865, 5597.048501754712, 5605.299337582802, 5611.494965453088, 5596.244506991545, 5629.099344104923, 5685.118806584945, 5689.6586204827845, 5732.22614946981, 5209.374875014984, 5258.0, 5260.184671375943, 5301.0, 5347.224652425415, 5562.415946325658, 5696.3164420269, 5734.397888221677, 5771.769129234784, 5774.364819869811, 5523.143912693539, 5544.417836127229, 5550.500454959073, 5562.527185189223, 5564.554835613141, 5575.860603484945, 5589.133684278943, 5615.803446879339, 5620.297462817148, 5624.0439125348785, 5473.343198816167, 5495.395506494282, 5507.366652834895, 5555.861103472445, 5593.272874526286, 5519.420460851553, 5619.466150715675, 5626.943730562642, 5638.295213098363, 5674.26234589509, 4436.024074703624, 4436.467623885154, 4439.356293337512, 4450.35469856869, 4487.798049087799, 3812.7799104286364, 3862.9034274143373, 3890.8054597270025, 3912.315344814646, 3912.960870391317, 5342.786288548415, 5360.383555891122, 5367.651102678314, 5380.623356365017, 5418.864528386743, 5537.972310138504, 5628.493435590816, 5644.407337229614, 5667.914981275284, 5671.829845104653, 5310.840674779763, 5350.946490535122, 5369.785208591691, 5385.946140538623, 5388.407275199725, 4705.482396936334, 4719.528047195253, 4738.502457242009, 4762.52374762521, 4767.070421267819, 5723.570732195102, 5793.8841223175305, 5987.251593550806, 5988.221531201003, 5993.0710739835395, 5556.083246264402, 5616.494515493625, 5625.493705566519, 5630.465105814941, 5678.829635110953, 5869.266341707286, 5882.088276317178, 5885.0, 5902.940970590239, 5905.350411454822, 5387.488188622075, 5491.917621235605, 5508.834734957958, 5528.640638358494, 5532.917006244829, 5711.685857277889, 5712.200291959046, 5720.170575266647, 5724.284464441945, 5743.770249189985, 5531.695756733418, 5549.805756798654, 5551.167324901297, 5554.916791225673, 5554.944450555443, 5351.03681337363, 5456.508914197741, 5464.91802622953, 5540.085885828793, 5545.279113715191, 5306.283651707125, 5351.812686556108, 5353.491418315254, 5379.784808607612, 5452.509274165344, 5475.069238229431, 5478.8904221914545, 5508.91736623943, 5525.143602741581, 5547.916781248366, 5235.554977826928, 5380.408155103014, 5383.7308134593895, 5437.972810135924, 5449.338877960077], "value": 5163.521694856943, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.968211748354, 604.4559896093515, 616.7224748863011, 618.7339444039061, 634.1945728924263, 43325.566744332544, 44885.0, 44895.32657010143, 44916.77541612295, 48089.27866082011, 45694.54305456945, 46237.0, 46310.7684461578, 46319.53680463194, 46419.76790116045, 8876.378653494241, 8901.287896968228, 8948.552572371387, 8974.147455991702, 8985.730428087169, 8858.15847494487, 8923.910760892406, 8925.285977121846, 8928.062553431893, 8957.0, 8961.910380896205, 9008.324375671818, 9040.09599040094, 9046.411983221102, 9102.908970910305, 9008.324375671818, 9057.501837398973, 9073.863892041625, 9085.500297483635, 9089.727308180765, 8863.335249856287, 8926.955365223197, 8943.910560894437, 8948.105189481064, 8948.8657670135, 43365.56634433647, 43591.34612980808, 43595.56404435947, 43649.563504364865, 43771.0, 3487.4071407860724, 3882.437046628251, 4027.436158937751, 4169.937450938239, 4321.611055005064, 32258.516122258185, 32874.0, 32946.0, 33269.16827079342, 33674.6632533674, 4199.2441360555085, 4276.5295817460055, 4336.631386332166, 4344.283193273106, 4517.07399983006, 244962.0, 246936.0, 247261.0, 248600.0, 249625.7518712413, 56682.716586416806, 56836.43163568394, 57503.0, 57542.42457575454, 57643.0, 37216.44175337372, 38019.23961520754, 38056.238875222894, 40590.59409405868, 40707.796461017504, 17546.912265438845, 17639.82360176382, 17720.91139544294, 17889.910550447163, 17911.910440447715, 13656.112352697242, 13686.110402823984, 13769.554196809391, 13803.309834508435, 13868.930655346861, 19397.740281718125, 19465.4160375189, 19547.804521954884, 19676.90161549183, 19743.506412339808, 7012.684429200698, 7059.647017649097, 7064.1876184238445, 7200.927990720131, 7438.107427108782, 964.5129209749172, 995.770972676274, 1021.7292417509366, 1052.9891304347912, 1130.4121856634504, 32316.030519084467, 32349.838250808596, 32517.0, 33129.67481300769, 33385.666143338254, 1134.2967360236541, 1149.9770004599861, 1154.4285578638628, 1159.1654009113424, 1186.1756079524648, 16779.91610041942, 16966.159170238425, 17218.913905430643, 17283.74074388885, 17362.13189340528, 532009.0, 534153.0, 537530.0, 538026.0, 541417.0, 59818.700906495185, 60168.699156503935, 60421.0, 60684.696576516835, 60735.69632151811, 1313.3302015971733, 1371.136184203965, 1372.0464277327162, 1374.5326588960002, 1374.9862501375057, 31066.68933310638, 31291.374172516877, 31781.0, 32239.516407253443, 32662.34675306528, 46483.767581161876, 47202.76398617985, 47220.29169562528, 47239.29141062956, 47493.76253118712, 407838.0, 413457.0, 415000.0, 418302.0, 418324.0, 29033.419331613673, 29326.0, 29818.403631927675, 29891.850540747157, 29984.85007574948, 48612.51387486221, 48837.75581122072, 49477.0, 50039.749801250764, 50419.0, 40332.39501407422, 41560.376594350506, 42129.36805947852, 43109.56890431055, 43288.78355608202, 41980.0, 42263.15473690571, 42422.787886060374, 42505.0, 42794.14411711686, 35070.82464587661, 40185.39721904115, 40547.39178912378, 41012.38481422721, 41665.58334416738, 34250.0, 37035.62964370322, 37602.43596346112, 37651.246975060894, 37685.434718479795, 28158.577621335287, 28444.43111137807, 28561.143165705063, 28575.714242857306, 28585.571216431355], "value": 20007.387650214565, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.3941729736205, 400.6834600665474, 401.7509144330514, 407.5415157947309, 411.67889046543706, 12762.744745105092, 17759.46721598351, 17916.731249031276, 19643.0, 19752.604947901033, 18317.81682183181, 18741.250349986018, 18981.62036759264, 19149.138288777005, 19177.712334314998, 5570.498655121029, 5683.175939488771, 5706.457886500796, 5756.971215143939, 5812.186293918855, 5462.672239665632, 5757.222774925394, 5757.596968212227, 5797.478226959573, 5837.387074357195, 5740.0815869460685, 5740.196372507852, 5767.798127065554, 5788.421157884199, 5808.4481974212595, 5382.838514844541, 5643.068893632546, 5725.770969161229, 5752.6836024019085, 5763.452472015152, 5500.477454641803, 5548.77804887804, 5549.750261238254, 5579.330480342344, 5589.636673616202, 13458.52895148665, 13682.384292706853, 17040.573985650335, 22265.554688906293, 22369.664455033024, 2266.1841736974675, 2272.5114100468313, 2291.175176936302, 2343.7304709958403, 2351.8118550516087, 10160.745981350525, 10176.185905127646, 10276.794464110752, 10395.428251446167, 10480.58077676892, 1817.25492548056, 1877.915493802782, 1881.8734829642553, 1914.0716752375088, 1935.2742721479444, 84769.57615211884, 86697.13302866953, 90813.0, 90816.0, 91750.0, 10924.508397122148, 10951.87871456647, 11351.716207094889, 11474.48364823585, 11804.17370784037, 16213.675726485404, 16229.675406491804, 16237.67524649524, 16376.590585235464, 16388.508344749676, 7984.800379990546, 8333.374996875258, 8468.645016797283, 8475.449095808754, 8632.827343453097, 7966.601669916481, 8107.3108785753875, 8118.837623247502, 8195.098539160688, 8250.092489826115, 4794.496577859344, 4956.083124621957, 4968.453470118284, 5097.08252514551, 5103.923441148386, 2005.4585261979184, 2026.4427282497431, 2043.3563427520282, 2057.85595008348, 2059.5160137367707, 904.4302089683457, 934.2759361494896, 1035.5184839049878, 1043.7390652336917, 1047.5024363427463, 17112.74330885038, 18273.543161420806, 18774.0, 18977.146028428753, 19101.61796764057, 961.5576834655997, 980.2843923935567, 984.6602921991902, 1013.2350075692952, 1056.9207309451667, 8441.70454034106, 10745.194110441747, 10750.462476876124, 10750.838737418944, 10783.08343790771, 412941.0, 417043.0, 419668.0, 420202.0, 420742.0, 81449.59275203705, 90917.54541227252, 93126.0, 93731.0, 95376.52311738535, 965.9613615455303, 985.0494273026563, 990.2721499697716, 999.2755252441922, 1016.5323950982483, 16776.66446671084, 16812.831871681126, 16865.409710660068, 16896.23966921516, 17317.393891213746, 40933.38599921063, 43136.78431607947, 43138.13723725445, 44663.330050049924, 44730.0, 60053.39946600478, 60128.0, 60740.69629651823, 60914.390856090875, 61861.38138618556, 8691.0, 8783.692570759993, 8861.778455538662, 8863.069377715246, 8965.865512017195, 9766.658166964122, 13235.536756213487, 13358.332083395597, 13553.322333883068, 13621.863781362059, 5817.272840894888, 8540.91459085426, 11409.885901140882, 11459.31244125355, 11737.119716021161, 10952.671419857417, 11441.599544015919, 11452.770944581229, 11513.194076414571, 11586.131040171853, 11472.910073543, 11679.474423650787, 11707.414629268673, 12014.159008869296, 12176.817347739969, 8655.30757539408, 8786.769852220566, 8871.822563548822, 8989.865152022856, 9023.323250756088, 8970.37828339802, 11509.13681473876, 11544.0, 11808.055355571361, 12087.0], "value": 9097.599046946727, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.9711605767884, 1457.9489717859874, 1563.9034711271681, 1673.8995660260393, 1702.906340151292, 7736.883946740803, 8571.957140214297, 8651.653933842654, 9087.99999999999, 9115.316351273656, 8702.869456958135, 8967.10328967103, 9050.1854833065, 9077.09229077092, 9086.454812711241, 2353.5528249632557, 2389.151851092863, 2390.916317928873, 2391.282615215437, 2395.1138078910826, 2367.4318163640687, 2379.0721618568773, 2408.7470815564375, 2415.830891837572, 2430.3195105370523, 2335.252719129879, 2347.835651504395, 2372.667826504282, 2422.236995346469, 2424.5878200705833, 2303.585354636165, 2306.123673004264, 2326.3835083702834, 2328.9301320960312, 2345.3315804995664, 2277.87471689057, 2278.3734473019886, 2287.885605719707, 2294.5755035318352, 2316.316686577447, 8957.059508751618, 9097.818043639156, 9098.545072746336, 9117.863232051524, 9136.634534618608, 5238.188080847437, 5386.326709161355, 5394.838154855322, 5398.325209348832, 5419.485148910847, 3415.7096646785053, 3449.379111759882, 3513.718902487795, 3520.049586611626, 3533.1343820764077, 1155.8324043013715, 1163.2438914705508, 1164.7554013657057, 1184.023180875781, 2134.8292136629034, 12238.265704057696, 12793.61619151427, 12829.61511154667, 12830.422630981628, 12861.099723019299, 4496.842610508616, 4517.34498497716, 4525.434320709911, 4598.333241679938, 4605.240135377692, 9870.851937220947, 9933.0, 9938.0, 9964.750881227883, 10009.299349045497, 5114.462981386975, 5135.306733590917, 5162.74186290684, 5168.715720635326, 5178.741062946838, 4324.935125973113, 4751.548602882721, 4914.655974081851, 4948.05986862495, 4952.133376659071, 3788.583255841855, 3861.864834730827, 3914.451976723261, 3958.762474251554, 3991.2815693174925, 1113.7804104505553, 1114.1894421564957, 1116.9273997190319, 1124.7131981344705, 1157.7742340243572, 872.5855218771032, 965.0879918476971, 975.3221511049894, 1009.5204777730667, 1018.1345856022322, 6116.877662446726, 6159.5072394208355, 6196.938030619636, 6358.332375100548, 6393.073004414334, 436.75541696649975, 437.7789216445738, 451.22614715762626, 451.69059194451904, 453.5124740903542, 4206.663466922639, 4347.695691292663, 4423.4912985006495, 4453.19842428366, 4481.7983190756495, 10905.127589792955, 11232.775344493064, 11460.312381257152, 11470.88529114715, 11475.0, 11217.831732524019, 11306.886931130583, 11320.264182828254, 11335.319880807014, 11340.829887551694, 8060.8387832243025, 8319.625616847256, 8341.624626891804, 8347.123552027071, 8386.287165590871, 5770.942290577041, 5973.55198360116, 6129.938700612936, 6151.3541078186145, 6301.306856245901, 9801.607935682492, 9978.251631127549, 10163.0, 10238.18094552449, 10246.0, 10292.279540432099, 10358.792824143626, 10403.84394234072, 10624.36253824773, 10628.681139565826, 7429.257074292527, 8269.793255168668, 8515.318774497902, 8623.094575069777, 8767.21095101444, 8586.141385861614, 8604.0, 8655.6970506032, 8714.782130446789, 8750.124987501198, 7635.770926872203, 7685.961570192113, 7913.366930645419, 8003.279704826594, 8118.309943654619, 7688.192739762245, 7800.921990780246, 7818.882716759139, 7833.1775163607, 7898.881516777138, 7085.574865508086, 7106.822329441805, 7168.784936451706, 7205.495615306878, 7212.386947109554, 5207.609429292743, 5277.340332458442, 5280.6303558750515, 5340.732963351895, 5384.0, 5351.518363347317, 5404.86497835459, 5417.891642167214, 5421.945780542144, 5589.301337332833], "value": 4632.298792546413, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.1777846479112, 315.50780781980114, 318.48405582955616, 322.9709326160645, 323.7604172912044, 5347.41178470368, 5544.417836127209, 5552.2232885476615, 5603.1595260710865, 5644.435556444359, 5519.862003449915, 5570.025245582017, 5621.971890140544, 5631.929933312678, 5642.153676948449, 4324.308110702288, 4329.502107257658, 4348.260795664744, 4350.6301964332915, 4380.299152135659, 4061.6141466560775, 4272.786360681969, 4278.122984788127, 4337.371081193225, 4365.519792822787, 4197.887559796656, 4237.322028475444, 4244.257254980382, 4253.064325848324, 4272.722273052257, 4289.378040184171, 4294.720843145185, 4332.328489084197, 4336.891577710582, 4343.109662519176, 3485.6862882340456, 3744.925101497982, 3754.648326602421, 3769.981150094232, 3779.5464544254864, 5388.46115388458, 5390.840969191603, 5438.933205381969, 5439.156930675712, 5485.917711234335, 4817.217629477116, 4915.901681966377, 4917.582005529534, 4926.926096108561, 4942.406911170647, 5503.889922201533, 5796.362400135981, 5803.578123359804, 5819.330776960662, 5836.620619659751, 4036.5156181258435, 4049.4128351388886, 4055.6958228133008, 4062.857799976987, 4082.448869402622, 6068.968275393194, 6084.330723620398, 6118.479929205978, 6133.85315139702, 6137.78517751881, 4090.2433049885867, 4161.8335266589, 4172.228137794517, 4178.143480586473, 4214.515330736943, 4176.519700234512, 4180.536812115796, 4204.222218889454, 4214.367844823301, 4228.513720922072, 4840.6127509799135, 4876.292937524039, 4879.829205977845, 4894.898647804215, 4902.803887844446, 5308.0, 5801.361850196475, 5881.206037184926, 5914.792982245601, 5918.112283157561, 1427.864352886474, 1435.612384656137, 1440.8833154305287, 1449.4564538298139, 1452.201289290907, 898.4474548152839, 910.3172620534599, 918.4856480371013, 927.1979737526991, 932.1331162019387, 4953.281774142802, 4990.754160627732, 4999.725015124131, 5000.774965126578, 5033.345665063518, 5267.683938963674, 5276.973615131899, 5331.813386531453, 5410.269613602192, 5415.458454154632, 5070.645054846125, 5071.290019397287, 5072.949270507322, 5263.894722105537, 5710.65736055838, 3172.2386627209303, 3177.205698575356, 3202.743780497601, 3206.2625596113025, 3222.3555288942307, 6085.634861908211, 6193.411625895533, 6247.96876015617, 6255.40573645503, 6259.7496100156395, 6135.877282454415, 6152.261728592597, 6157.7229024694, 6163.630182189083, 6172.537059720539, 6248.875022499525, 6262.467690246289, 6265.310815810257, 6295.685215739195, 6301.369863013753, 5825.213596164633, 6056.333803281724, 6061.545384096122, 6078.696065196811, 6080.209572755513, 5905.940940590539, 5924.31870334917, 5925.318588362394, 6006.0, 6041.24484439445, 6034.431047927483, 6225.346338634378, 6290.465310448663, 6309.242890853127, 6380.94714372142, 4150.252954468104, 4166.375043743463, 4196.559361267023, 4202.789860507023, 4213.873583792491, 5768.826935191951, 5835.854103647443, 6024.307204671519, 6070.605410648293, 6097.7865774697675, 5809.709514524341, 5846.853828654148, 5877.324107727495, 5881.941180588139, 5915.940840591539, 5848.210491583582, 5854.297484301911, 5860.388393191906, 5874.823755287348, 5877.177195192591, 5478.835634930959, 5725.19847221381, 5729.799457018984, 5737.426257374396, 5758.884822303614, 5876.911846322394, 5925.318588362394, 5942.524598032233, 5946.494547963472, 5960.821175364746, 5460.836174914759, 5717.571182161438, 5746.913796292975, 5786.537077033743, 5849.853753656193], "value": 4377.413015988811, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.4917535611324, 702.0978043214469, 719.3921136639538, 744.155383639569, 758.7609902880592, 15441.768373474408, 16064.51806445807, 16428.096454695, 16470.588235294123, 16526.752098718527, 15135.318910649019, 15299.15854627995, 15341.923290383533, 15368.308426120824, 15427.768583471257, 668.5387082912799, 781.8749000159976, 785.0579304834222, 801.0667572278289, 803.7347675267177, 802.6628815897308, 805.9435839491238, 807.5598798654747, 810.1412502747078, 813.0893399392688, 846.4286606540592, 849.1041950741965, 851.586980314547, 855.0978717453085, 856.3320609924269, 841.9999999999969, 843.0641987393988, 843.3000609494105, 843.5529169540154, 852.526847599582, 612.1093808508609, 616.1866336435907, 619.0219453263877, 622.2408661433044, 623.5728525959732, 14650.267486625733, 14767.778483322758, 14805.407783688639, 14805.629859253604, 14833.184174870377, 15221.31504082308, 15319.0, 15353.385864565404, 15425.15161666108, 15583.376664933388, 11927.94036029823, 12163.0, 12182.634520964297, 12671.936640316739, 12819.102662813606, 3849.8075096245075, 3884.3008258513455, 3891.591382904811, 3893.980530097331, 4037.354023356278, 73035.0, 73134.63432682856, 73711.0, 73983.63008185032, 74032.62983685046, 11394.866605153198, 11630.0, 11661.88338116625, 11666.300021998708, 11671.299722016705, 22863.31410057701, 22863.657045144337, 23049.539009220058, 23196.3041108767, 23254.139668826454, 8192.18078192188, 8303.128171542023, 8353.916460835435, 8392.916070839336, 9031.909680903107, 4826.469088400273, 4992.825251116194, 5075.086484432837, 5092.643514953992, 5113.769880355393, 3445.0698311456267, 3577.248777756648, 3591.048372181374, 3591.066322756102, 3591.694705949971, 549.3023859698161, 557.7852526777139, 567.2823877794593, 569.6297406685687, 578.5256090006238, 613.5091926458815, 643.7618081309852, 653.7483069018367, 658.539022684123, 674.130371820356, 9019.909800901907, 9422.528873556295, 9474.489260346014, 9760.804783904283, 10080.69757907264, 557.5901712241499, 611.7338957553478, 646.2051676438008, 668.5754545863315, 672.7477196051481, 4500.549945005473, 4671.462781780071, 4716.268978308368, 4722.574968252874, 4851.660383773102, 95162.52418738001, 98235.50882245543, 99141.0, 114668.42665786618, 118213.4089329565, 108346.0, 111234.0, 112346.43826780813, 112762.0, 115549.0, 56225.0, 57142.142867857016, 57333.14000289999, 57481.0, 57569.13646295309, 9327.766805829908, 9859.457729824928, 9951.850722239316, 9983.15143212835, 10098.798024039625, 53617.7319113402, 54243.45756542384, 54596.540345965084, 55087.0, 56316.43683563112, 82914.58542707248, 86861.69707454267, 87321.0, 87768.92808751919, 88566.55716721374, 11584.247023943417, 11649.650510484698, 11993.460294286953, 12086.697832554257, 12592.559260425842, 11351.14866385008, 13570.796438053634, 13805.585832425044, 13839.723205536035, 14001.439942402598, 11146.777064458827, 11176.608818691308, 13183.40674669623, 13643.181409115485, 13748.0, 13039.82641562264, 13434.462621495031, 13854.792178117135, 13868.791968120688, 13987.020908536711, 12526.49894004266, 12987.35063246815, 13058.804117938049, 13260.801087983495, 13292.0, 10686.625968091079, 11036.337819730841, 11280.539426112779, 11329.943350283196, 11530.59642912494, 10609.840852387066, 11070.889291107307, 11327.943360283145, 11442.0, 11446.198766086294], "value": 7439.051071413748, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 113.0, 112.0, 113.0, 113.0, 112.0, 111.0, 111.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 124.0, 155.0, 175.0, 127.0, 157.0, 161.0, 128.0, 197.0, 131.0], "value": 150.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 161.0, 164.0, 174.0, 164.0, 163.0, 162.0, 161.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 159.0, 77.0, 74.0, 75.0, 77.0, 165.0, 76.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 146.0, 86.0, 85.0, 86.0, 149.0, 88.0, 85.0, 142.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 118.0, 117.0, 119.0, 117.0, 117.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 148.0, 146.0, 147.0, 148.0, 147.0, 148.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 100.0, 97.0, 96.0, 97.0, 97.0, 96.0, 95.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 57.0, 53.0, 55.0, 55.0, 53.0, 53.0, 53.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 62.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 62.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 79.0, 82.0, 79.0, 82.0, 81.0, 81.0, 83.0, 103.0, 80.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 122.0, 126.0, 124.0, 123.0, 140.0, 131.0, 132.0, 126.0, 136.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 158.0, 162.0, 158.0, 163.0, 163.0, 165.0, 162.0, 156.0, 157.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 65.0, 62.0, 62.0, 67.0, 63.0, 63.0, 63.0, 63.0, 62.0], "value": 64.2, "unit": "score"}]}]} 08:29:50 INFO - Return code: 0 08:29:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:29:50 ERROR - # TBPL SUCCESS # 08:29:50 INFO - Running post-action listener: _resource_record_post_action 08:29:50 INFO - ##### 08:29:50 INFO - ##### Finished run-tests step (success) 08:29:50 INFO - ##### 08:29:50 INFO - Running post-run listener: _resource_record_post_run 08:29:50 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 541900800; Read time: 160; Write time: 416744 08:29:50 INFO - TinderboxPrint: CPU usage
13.5% 08:29:50 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 160 08:29:50 INFO - TinderboxPrint: I/O write bytes / time
541,900,800 / 416,744 08:29:50 INFO - TinderboxPrint: CPU idle
8,219.5 (86.5%) 08:29:50 INFO - TinderboxPrint: CPU user
1,223.9 (12.9%) 08:29:50 INFO - TinderboxPrint: Swap in / out
0 / 0 08:29:50 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248389632; Read time: 0; Write time: 228144 08:29:50 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 12288; Write bytes: 293511168; Read time: 160; Write time: 188600 08:29:51 INFO - Running post-run listener: _upload_blobber_files 08:29:51 INFO - Blob upload gear active. 08:29:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:29:51 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 08:29:51 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'] 08:29:51 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 08:29:51 INFO - (blobuploader) - INFO - Open directory for files ... 08:29:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:29:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:29:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:52 INFO - (blobuploader) - INFO - Done attempting. 08:29:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:29:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:29:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:55 INFO - (blobuploader) - INFO - Done attempting. 08:29:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:29:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:29:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:56 INFO - (blobuploader) - INFO - Done attempting. 08:29:56 INFO - (blobuploader) - INFO - Iteration through files over. 08:29:56 INFO - Return code: 0 08:29:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:29:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:29:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/27fb1c91d7564529084eec5caf34182a8359d7974306ea67cb4aff3820d870c61ef0fd2ff2c6b529c8a22ee8fea139272f5c108e2dc06ce7cfb1e48471c5f427", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/60416434bb7f0b28118352bb18fcc04e10092d877253bb154d2ec45166b953e57dd5bf464e719bc98e35ca5ed11920df052dc57563da6359c249d8f3e4edc74c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c47df21ad6b50b9d40bc98ad7dd3fee6bc7d5065aecf73009268bf43ffbd4486e765eacede8a1c1b300f929c1361eae5beb16a531b3b4567b5a59a3a423d2fc"} 08:29:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:29:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:29:56 INFO - Contents: 08:29:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/27fb1c91d7564529084eec5caf34182a8359d7974306ea67cb4aff3820d870c61ef0fd2ff2c6b529c8a22ee8fea139272f5c108e2dc06ce7cfb1e48471c5f427", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/60416434bb7f0b28118352bb18fcc04e10092d877253bb154d2ec45166b953e57dd5bf464e719bc98e35ca5ed11920df052dc57563da6359c249d8f3e4edc74c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c47df21ad6b50b9d40bc98ad7dd3fee6bc7d5065aecf73009268bf43ffbd4486e765eacede8a1c1b300f929c1361eae5beb16a531b3b4567b5a59a3a423d2fc"} 08:29:56 INFO - Running post-run listener: copy_logs_to_upload_dir 08:29:56 INFO - Copying logs to upload dir... 08:29:56 INFO - mkdir: /builds/slave/test/build/upload/logs 08:29:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.274835 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-12 08:29:56.365389) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-12 08:29:56.368964) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/27fb1c91d7564529084eec5caf34182a8359d7974306ea67cb4aff3820d870c61ef0fd2ff2c6b529c8a22ee8fea139272f5c108e2dc06ce7cfb1e48471c5f427", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/60416434bb7f0b28118352bb18fcc04e10092d877253bb154d2ec45166b953e57dd5bf464e719bc98e35ca5ed11920df052dc57563da6359c249d8f3e4edc74c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c47df21ad6b50b9d40bc98ad7dd3fee6bc7d5065aecf73009268bf43ffbd4486e765eacede8a1c1b300f929c1361eae5beb16a531b3b4567b5a59a3a423d2fc"} build_url:https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011609 build_url: 'https://queue.taskcluster.net/v1/task/a7wOczqIRq-_QmxEE9ZVcA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/27fb1c91d7564529084eec5caf34182a8359d7974306ea67cb4aff3820d870c61ef0fd2ff2c6b529c8a22ee8fea139272f5c108e2dc06ce7cfb1e48471c5f427", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/60416434bb7f0b28118352bb18fcc04e10092d877253bb154d2ec45166b953e57dd5bf464e719bc98e35ca5ed11920df052dc57563da6359c249d8f3e4edc74c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c47df21ad6b50b9d40bc98ad7dd3fee6bc7d5065aecf73009268bf43ffbd4486e765eacede8a1c1b300f929c1361eae5beb16a531b3b4567b5a59a3a423d2fc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-12 08:29:56.394892) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 08:29:56.395224) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465741280.507195-1652731265 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-12 08:29:56.479359) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-12 08:29:56.479683) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-12 08:29:56.479965) ========= ========= Total master_lag: 0.18 =========