builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1465394412.45 results: success (0) buildid: 20160608043006 builduid: 70e1b4823dc2400bb6e920b809b49070 revision: f8ad071a6e14331d73fa44c8d3108bc2b66b2174 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 07:00:12.445883) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 07:00:12.446351) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 07:00:12.446652) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 07:00:12.461544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 07:00:12.461854) ========= 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=db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 07:00:12-- 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% 23.6M=0s 2016-06-08 07:00:12 (23.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087595 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 07:00:12.563843) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 07:00:12.564159) ========= 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=db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015790 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 07:00:12.613179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 07:00:12.613542) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f8ad071a6e14331d73fa44c8d3108bc2b66b2174 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f8ad071a6e14331d73fa44c8d3108bc2b66b2174 --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=db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 07:00:12,842 truncating revision to first 12 chars 2016-06-08 07:00:12,842 Setting DEBUG logging. 2016-06-08 07:00:12,842 attempt 1/10 2016-06-08 07:00:12,842 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f8ad071a6e14?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 07:00:14,218 unpacking tar archive at: mozilla-central-f8ad071a6e14/testing/mozharness/ program finished with exit code 0 elapsedTime=1.696287 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 07:00:14.323283) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 07:00:14.323618) ========= script_repo_revision: f8ad071a6e14331d73fa44c8d3108bc2b66b2174 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 07:00:14.324012) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 07:00:14.324286) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 07:00:14.333573) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-08 07:00:14.333881) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:00:14 INFO - MultiFileLogger online at 20160608 07:00:14 in /builds/slave/test 07:00:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:00:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:00:14 INFO - {'append_to_log': False, 07:00:14 INFO - 'base_work_dir': '/builds/slave/test', 07:00:14 INFO - 'blob_upload_branch': 'Firefox', 07:00:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:00:14 INFO - 'branch': 'Firefox', 07:00:14 INFO - 'buildbot_json_path': 'buildprops.json', 07:00:14 INFO - 'config_files': ('talos/linux_config.py',), 07:00:14 INFO - 'default_actions': ('clobber', 07:00:14 INFO - 'read-buildbot-config', 07:00:14 INFO - 'download-and-extract', 07:00:14 INFO - 'populate-webroot', 07:00:14 INFO - 'create-virtualenv', 07:00:14 INFO - 'install', 07:00:14 INFO - 'run-tests'), 07:00:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:00:14 INFO - 'download_minidump_stackwalk': True, 07:00:14 INFO - 'download_symbols': 'ondemand', 07:00:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:00:14 INFO - 'tooltool.py': '/tools/tooltool.py', 07:00:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:00:14 INFO - '/tools/misc-python/virtualenv.py')}, 07:00:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:00:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:00:14 INFO - 'installer_path': 'installer.exe', 07:00:14 INFO - 'log_level': 'info', 07:00:14 INFO - 'log_name': 'talos', 07:00:14 INFO - 'log_to_console': True, 07:00:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:00:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:00:14 INFO - 'opt_config_files': (), 07:00:14 INFO - 'pip_index': False, 07:00:14 INFO - 'sps_profile': False, 07:00:14 INFO - 'sps_profile_interval': 0, 07:00:14 INFO - 'suite': 'dromaeojs-e10s', 07:00:14 INFO - 'system_bits': '32', 07:00:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:00:14 INFO - 'title': 'talos-linux64-ix-031', 07:00:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:00:14 INFO - 'use_talos_json': True, 07:00:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:00:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:00:14 INFO - 'work_dir': 'build'} 07:00:14 INFO - ##### 07:00:14 INFO - ##### Running clobber step. 07:00:14 INFO - ##### 07:00:14 INFO - Running pre-action listener: _resource_record_pre_action 07:00:14 INFO - Running main action method: clobber 07:00:14 INFO - rmtree: /builds/slave/test/build 07:00:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:00:15 INFO - Running post-action listener: _resource_record_post_action 07:00:15 INFO - ##### 07:00:15 INFO - ##### Finished clobber step (success) 07:00:15 INFO - ##### 07:00:15 INFO - ##### 07:00:15 INFO - ##### Running read-buildbot-config step. 07:00:15 INFO - ##### 07:00:15 INFO - Running pre-action listener: _resource_record_pre_action 07:00:15 INFO - Running main action method: read_buildbot_config 07:00:15 INFO - Using buildbot properties: 07:00:15 INFO - { 07:00:15 INFO - "project": "", 07:00:15 INFO - "product": "firefox", 07:00:15 INFO - "script_repo_revision": "production", 07:00:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:00:15 INFO - "repository": "", 07:00:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:00:15 INFO - "buildid": "20160608043006", 07:00:15 INFO - "pgo_build": "True", 07:00:15 INFO - "basedir": "/builds/slave/test", 07:00:15 INFO - "buildnumber": 63, 07:00:15 INFO - "slavename": "talos-linux64-ix-031", 07:00:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:00:15 INFO - "platform": "ubuntu64_hw", 07:00:15 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:00:15 INFO - "branch": "mozilla-central", 07:00:15 INFO - "repo_path": "mozilla-central", 07:00:15 INFO - "revision": "f8ad071a6e14331d73fa44c8d3108bc2b66b2174", 07:00:15 INFO - "stage_platform": "linux64-pgo", 07:00:15 INFO - "builduid": "70e1b4823dc2400bb6e920b809b49070", 07:00:15 INFO - "slavebuilddir": "test" 07:00:15 INFO - } 07:00:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:00:15 INFO - Running post-action listener: _resource_record_post_action 07:00:15 INFO - ##### 07:00:15 INFO - ##### Finished read-buildbot-config step (success) 07:00:15 INFO - ##### 07:00:15 INFO - ##### 07:00:15 INFO - ##### Running download-and-extract step. 07:00:15 INFO - ##### 07:00:15 INFO - Running pre-action listener: _resource_record_pre_action 07:00:15 INFO - Running main action method: download_and_extract 07:00:15 INFO - mkdir: /builds/slave/test/build/tests 07:00: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')]} 07:00:15 INFO - https://queue.taskcluster.net/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:00:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:00:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:00:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/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 07:00:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/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 07:00:15 INFO - Downloaded 1361 bytes. 07:00:15 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:00:15 INFO - Using the following test package requirements: 07:00:15 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:00:15 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:00:15 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:00:15 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:15 INFO - u'jsshell-linux-x86_64.zip'], 07:00:15 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:00:15 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:00:15 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:00:15 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:00:15 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:00:15 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:00:15 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:00: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')]} 07:00:15 INFO - https://queue.taskcluster.net/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:00:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:00:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:00:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/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 07:00:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/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 07:00:17 INFO - Downloaded 24451314 bytes. 07:00:17 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'] 07:00:17 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 07:00:18 INFO - Return code: 0 07:00:18 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 07:00:18 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')]} 07:00:18 INFO - https://queue.taskcluster.net/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:00:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:00:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:00:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/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 07:00:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/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 07:00:19 INFO - Downloaded 24451314 bytes. 07:00:19 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'] 07:00:19 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 07:00:21 INFO - Return code: 0 07:00: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')]} 07:00:21 INFO - https://queue.taskcluster.net/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:00:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:00:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:00:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/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 07:00:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/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 07:00:22 INFO - Downloaded 10833369 bytes. 07:00:22 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'] 07:00:22 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 07:00:22 INFO - Return code: 0 07:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:22 INFO - https://queue.taskcluster.net/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:00:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:00:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:00:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/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 07:00:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/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 07:00:24 INFO - Downloaded 59252487 bytes. 07:00:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:00:24 INFO - mkdir: /builds/slave/test/properties 07:00:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:00:24 INFO - Writing to file /builds/slave/test/properties/build_url 07:00:24 INFO - Contents: 07:00:24 INFO - build_url:https://queue.taskcluster.net/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:00:25 INFO - Running post-action listener: _resource_record_post_action 07:00:25 INFO - Running post-action listener: set_extra_try_arguments 07:00:25 INFO - ##### 07:00:25 INFO - ##### Finished download-and-extract step (success) 07:00:25 INFO - ##### 07:00:25 INFO - ##### 07:00:25 INFO - ##### Running populate-webroot step. 07:00:25 INFO - ##### 07:00:25 INFO - Running pre-action listener: _resource_record_pre_action 07:00:25 INFO - Running main action method: populate_webroot 07:00:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:00:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:00:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:00:25 INFO - '--tppagecycles', 07:00:25 INFO - '7'], 07:00:25 INFO - 'tests': ['tsvgm']}}, 07:00:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:00:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:00:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:00:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:00:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:00:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:00:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:25 INFO - 'talos_options': ['--disable-e10s'], 07:00:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:25 INFO - 'talos_options': ['--disable-e10s'], 07:00:25 INFO - 'tests': ['damp', 'tps']}, 07:00:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:25 INFO - 'tests': ['damp', 'tps']}, 07:00:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:00:25 INFO - 'tests': ['dromaeo_dom']}, 07:00:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:00:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:00:25 INFO - 'tests': ['a11yr', 07:00:25 INFO - 'ts_paint', 07:00:25 INFO - 'tpaint', 07:00:25 INFO - 'sessionrestore', 07:00:25 INFO - 'sessionrestore_no_auto_restore', 07:00:25 INFO - 'tabpaint']}, 07:00:25 INFO - 'other-e10s': {'tests': ['a11yr', 07:00:25 INFO - 'ts_paint', 07:00:25 INFO - 'tpaint', 07:00:25 INFO - 'sessionrestore', 07:00:25 INFO - 'sessionrestore_no_auto_restore', 07:00:25 INFO - 'tabpaint']}, 07:00:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:00:25 INFO - 'ts_paint', 07:00:25 INFO - 'tpaint', 07:00:25 INFO - 'sessionrestore', 07:00:25 INFO - 'sessionrestore_no_auto_restore', 07:00:25 INFO - 'tabpaint']}, 07:00:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:00:25 INFO - 'ts_paint', 07:00:25 INFO - 'tpaint', 07:00:25 INFO - 'sessionrestore', 07:00:25 INFO - 'sessionrestore_no_auto_restore', 07:00:25 INFO - 'tabpaint']}, 07:00:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:00:25 INFO - 'tests': ['a11yr', 07:00:25 INFO - 'ts_paint', 07:00:25 INFO - 'tpaint', 07:00:25 INFO - 'sessionrestore', 07:00:25 INFO - 'sessionrestore_no_auto_restore', 07:00:25 INFO - 'tabpaint']}, 07:00:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:00:25 INFO - 'tests': ['a11yr', 07:00:25 INFO - 'ts_paint', 07:00:25 INFO - 'tpaint', 07:00:25 INFO - 'sessionrestore', 07:00:25 INFO - 'sessionrestore_no_auto_restore', 07:00:25 INFO - 'tabpaint']}, 07:00:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:00:25 INFO - 'tests': ['tsvgx', 07:00:25 INFO - 'tsvgr_opacity', 07:00:25 INFO - 'tart', 07:00:25 INFO - 'tscrollx', 07:00:25 INFO - 'cart']}, 07:00:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:00:25 INFO - 'tsvgr_opacity', 07:00:25 INFO - 'tart', 07:00:25 INFO - 'tscrollx', 07:00:25 INFO - 'cart']}, 07:00:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:25 INFO - 'talos_options': ['--disable-e10s'], 07:00:25 INFO - 'tests': ['tp5o']}, 07:00:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:25 INFO - 'tests': ['tp5o']}, 07:00:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:25 INFO - 'talos_options': ['--disable-e10s', 07:00:25 INFO - '--xperf_path', 07:00:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:25 INFO - 'tests': ['tp5n']}, 07:00:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:25 INFO - 'talos_options': ['--xperf_path', 07:00:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:25 INFO - 'tests': ['tp5n']}}, 07:00:25 INFO - 'talos.zip': {'path': '', 07:00:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:00:25 INFO - Running post-action listener: _resource_record_post_action 07:00:25 INFO - ##### 07:00:25 INFO - ##### Finished populate-webroot step (success) 07:00:25 INFO - ##### 07:00:25 INFO - ##### 07:00:25 INFO - ##### Running create-virtualenv step. 07:00:25 INFO - ##### 07:00:25 INFO - Running pre-action listener: _resource_record_pre_action 07:00:25 INFO - Running main action method: create_virtualenv 07:00:25 INFO - Creating virtualenv /builds/slave/test/build/venv 07:00:25 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 07:00:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:00:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:00:25 INFO - Using real prefix '/usr' 07:00:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:00:26 INFO - Installing distribute.............................................................................................................................................................................................done. 07:00:28 INFO - Installing pip.................done. 07:00:28 INFO - Return code: 0 07:00:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:28 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 0x7f93a6f67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11720f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1204050>, '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 0x1170170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170620>, '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': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', '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 07:00:28 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 07:00:28 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 07:00:28 INFO - Using env: {'DISPLAY': ':0', 07:00:28 INFO - 'HOME': '/home/cltbld', 07:00:28 INFO - 'LANG': 'en_US.UTF-8', 07:00:28 INFO - 'LANGUAGE': 'en_US:en', 07:00:28 INFO - 'LOGNAME': 'cltbld', 07:00:28 INFO - 'MAIL': '/var/mail/cltbld', 07:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:28 INFO - 'MOZ_NO_REMOTE': '1', 07:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:28 INFO - 'NO_EM_RESTART': '1', 07:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:28 INFO - 'PWD': '/builds/slave/test', 07:00:28 INFO - 'SHELL': '/bin/bash', 07:00:28 INFO - 'SHLVL': '1', 07:00:28 INFO - 'TERM': 'linux', 07:00:28 INFO - 'TMOUT': '86400', 07:00:28 INFO - 'USER': 'cltbld', 07:00:28 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', 07:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:28 INFO - '_': '/tools/buildbot/bin/python'} 07:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:28 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 07:00:28 INFO - Cleaning up... 07:00:28 INFO - Return code: 0 07:00:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:28 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 0x7f93a6f67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11720f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1204050>, '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 0x1170170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170620>, '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': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', '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 07:00:28 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 07:00:28 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 07:00:28 INFO - Using env: {'DISPLAY': ':0', 07:00:28 INFO - 'HOME': '/home/cltbld', 07:00:28 INFO - 'LANG': 'en_US.UTF-8', 07:00:28 INFO - 'LANGUAGE': 'en_US:en', 07:00:28 INFO - 'LOGNAME': 'cltbld', 07:00:28 INFO - 'MAIL': '/var/mail/cltbld', 07:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:28 INFO - 'MOZ_NO_REMOTE': '1', 07:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:28 INFO - 'NO_EM_RESTART': '1', 07:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:28 INFO - 'PWD': '/builds/slave/test', 07:00:28 INFO - 'SHELL': '/bin/bash', 07:00:28 INFO - 'SHLVL': '1', 07:00:28 INFO - 'TERM': 'linux', 07:00:28 INFO - 'TMOUT': '86400', 07:00:28 INFO - 'USER': 'cltbld', 07:00:28 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', 07:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:28 INFO - '_': '/tools/buildbot/bin/python'} 07:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:28 INFO - Downloading/unpacking psutil>=3.1.1 07:00:28 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 07:00:28 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 07:00:28 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 07:00:28 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 07:00:28 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 07:00:28 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 07:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:00:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:30 INFO - Installing collected packages: psutil 07:00:30 INFO - Running setup.py install for psutil 07:00:30 INFO - building 'psutil._psutil_linux' extension 07:00:30 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 07:00:30 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 07:00:30 INFO - building 'psutil._psutil_posix' extension 07:00:30 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 07:00:31 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 07:00:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:31 INFO - Successfully installed psutil 07:00:31 INFO - Cleaning up... 07:00:31 INFO - Return code: 0 07:00:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:31 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 0x7f93a6f67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11720f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1204050>, '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 0x1170170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170620>, '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': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', '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 07:00:31 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 07:00:31 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 07:00:31 INFO - Using env: {'DISPLAY': ':0', 07:00:31 INFO - 'HOME': '/home/cltbld', 07:00:31 INFO - 'LANG': 'en_US.UTF-8', 07:00:31 INFO - 'LANGUAGE': 'en_US:en', 07:00:31 INFO - 'LOGNAME': 'cltbld', 07:00:31 INFO - 'MAIL': '/var/mail/cltbld', 07:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:31 INFO - 'MOZ_NO_REMOTE': '1', 07:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:31 INFO - 'NO_EM_RESTART': '1', 07:00:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:31 INFO - 'PWD': '/builds/slave/test', 07:00:31 INFO - 'SHELL': '/bin/bash', 07:00:31 INFO - 'SHLVL': '1', 07:00:31 INFO - 'TERM': 'linux', 07:00:31 INFO - 'TMOUT': '86400', 07:00:31 INFO - 'USER': 'cltbld', 07:00:31 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', 07:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:31 INFO - '_': '/tools/buildbot/bin/python'} 07:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:00:31 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 07:00:31 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 07:00:31 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 07:00:31 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 07:00:31 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 07:00:31 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 07:00:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:00:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:00:33 INFO - Installing collected packages: mozsystemmonitor 07:00:33 INFO - Running setup.py install for mozsystemmonitor 07:00:33 INFO - Successfully installed mozsystemmonitor 07:00:33 INFO - Cleaning up... 07:00:33 INFO - Return code: 0 07:00:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:00:33 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')]} 07:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:33 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')]} 07:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:33 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 0x7f93a6f67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11720f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1204050>, '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 0x1170170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170620>, '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': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', '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 07:00:33 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 07:00:33 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 07:00:33 INFO - Using env: {'DISPLAY': ':0', 07:00:33 INFO - 'HOME': '/home/cltbld', 07:00:33 INFO - 'LANG': 'en_US.UTF-8', 07:00:33 INFO - 'LANGUAGE': 'en_US:en', 07:00:33 INFO - 'LOGNAME': 'cltbld', 07:00:33 INFO - 'MAIL': '/var/mail/cltbld', 07:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:33 INFO - 'MOZ_NO_REMOTE': '1', 07:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:33 INFO - 'NO_EM_RESTART': '1', 07:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:33 INFO - 'PWD': '/builds/slave/test', 07:00:33 INFO - 'SHELL': '/bin/bash', 07:00:33 INFO - 'SHLVL': '1', 07:00:33 INFO - 'TERM': 'linux', 07:00:33 INFO - 'TMOUT': '86400', 07:00:33 INFO - 'USER': 'cltbld', 07:00:33 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', 07:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:33 INFO - '_': '/tools/buildbot/bin/python'} 07:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:33 INFO - Downloading/unpacking jsonschema==2.5.1 07:00:33 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 07:00:33 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 07:00:33 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 07:00:33 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 07:00:33 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 07:00:33 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 07:00:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:00:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:35 INFO - Downloading functools32-3.2.3-2.tar.gz 07:00:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:00:35 INFO - warning: no files found matching '*.txt' 07:00:35 INFO - no previously-included directories found matching 'build' 07:00:35 INFO - no previously-included directories found matching 'dist' 07:00:35 INFO - no previously-included directories found matching '.git*' 07:00:35 INFO - Installing collected packages: jsonschema, functools32 07:00:35 INFO - Running setup.py install for functools32 07:00:36 INFO - warning: no files found matching '*.txt' 07:00:36 INFO - no previously-included directories found matching 'build' 07:00:36 INFO - no previously-included directories found matching 'dist' 07:00:36 INFO - no previously-included directories found matching '.git*' 07:00:36 INFO - Successfully installed jsonschema functools32 07:00:36 INFO - Cleaning up... 07:00:36 INFO - Return code: 0 07:00:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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', '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 0x7f93a6f67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11720f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1204050>, '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 0x1170170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170620>, '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': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', '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 07:00: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:00: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 blobuploader==1.2.4 07:00:36 INFO - Using env: {'DISPLAY': ':0', 07:00:36 INFO - 'HOME': '/home/cltbld', 07:00:36 INFO - 'LANG': 'en_US.UTF-8', 07:00:36 INFO - 'LANGUAGE': 'en_US:en', 07:00:36 INFO - 'LOGNAME': 'cltbld', 07:00:36 INFO - 'MAIL': '/var/mail/cltbld', 07:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:36 INFO - 'MOZ_NO_REMOTE': '1', 07:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:36 INFO - 'NO_EM_RESTART': '1', 07:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:36 INFO - 'PWD': '/builds/slave/test', 07:00:36 INFO - 'SHELL': '/bin/bash', 07:00:36 INFO - 'SHLVL': '1', 07:00:36 INFO - 'TERM': 'linux', 07:00:36 INFO - 'TMOUT': '86400', 07:00:36 INFO - 'USER': 'cltbld', 07:00:36 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', 07:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:36 INFO - '_': '/tools/buildbot/bin/python'} 07:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:36 INFO - Downloading/unpacking blobuploader==1.2.4 07:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:38 INFO - Downloading blobuploader-1.2.4.tar.gz 07:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:00:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:38 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 07:00:38 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 07:00:38 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 07:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:38 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 07:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:00:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:38 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 07:00:38 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 07:00:38 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 07:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:38 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 07:00:38 INFO - Downloading docopt-0.6.1.tar.gz 07:00:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:00:38 INFO - Installing collected packages: blobuploader, requests, docopt 07:00:38 INFO - Running setup.py install for blobuploader 07:00:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:00:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:00:39 INFO - Running setup.py install for requests 07:00:39 INFO - Running setup.py install for docopt 07:00:39 INFO - Successfully installed blobuploader requests docopt 07:00:39 INFO - Cleaning up... 07:00:39 INFO - Return code: 0 07:00:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:39 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 0x7f93a6f67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11720f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1204050>, '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 0x1170170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170620>, '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': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', '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 07:00:39 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 07:00:39 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 07:00:39 INFO - Using env: {'DISPLAY': ':0', 07:00:39 INFO - 'HOME': '/home/cltbld', 07:00:39 INFO - 'LANG': 'en_US.UTF-8', 07:00:39 INFO - 'LANGUAGE': 'en_US:en', 07:00:39 INFO - 'LOGNAME': 'cltbld', 07:00:39 INFO - 'MAIL': '/var/mail/cltbld', 07:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:39 INFO - 'MOZ_NO_REMOTE': '1', 07:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:39 INFO - 'NO_EM_RESTART': '1', 07:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:39 INFO - 'PWD': '/builds/slave/test', 07:00:39 INFO - 'SHELL': '/bin/bash', 07:00:39 INFO - 'SHLVL': '1', 07:00:39 INFO - 'TERM': 'linux', 07:00:39 INFO - 'TMOUT': '86400', 07:00:39 INFO - 'USER': 'cltbld', 07:00:39 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', 07:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:39 INFO - '_': '/tools/buildbot/bin/python'} 07:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:00:39 INFO - Running setup.py (path:/tmp/pip-AamTaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:00:39 INFO - Running setup.py (path:/tmp/pip-5d1u6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:00:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:00:39 INFO - Running setup.py (path:/tmp/pip-K6gAaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:00:40 INFO - Running setup.py (path:/tmp/pip-wGJBqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:00:40 INFO - Running setup.py (path:/tmp/pip-CChGez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:00:40 INFO - Running setup.py (path:/tmp/pip-6Qxu2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:00:40 INFO - Running setup.py (path:/tmp/pip-jeuMGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:00:40 INFO - Running setup.py (path:/tmp/pip-UbK9q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:00:40 INFO - Running setup.py (path:/tmp/pip-qIz6ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:00:40 INFO - Running setup.py (path:/tmp/pip-OU6QXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:00:40 INFO - Running setup.py (path:/tmp/pip-t7optb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:00:40 INFO - Running setup.py (path:/tmp/pip-YWLuNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:00:40 INFO - Running setup.py (path:/tmp/pip-N1AXYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:00:40 INFO - Running setup.py (path:/tmp/pip-mXRkeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:40 INFO - Running setup.py (path:/tmp/pip-33Avt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:00:40 INFO - Running setup.py (path:/tmp/pip-cM1dag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:00:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:00:40 INFO - Running setup.py (path:/tmp/pip-uAfTWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:00:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:00:41 INFO - Running setup.py install for manifestparser 07:00:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:00:41 INFO - Running setup.py install for mozcrash 07:00:41 INFO - Running setup.py install for mozdebug 07:00:41 INFO - Running setup.py install for mozdevice 07:00:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:00:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:00:41 INFO - Running setup.py install for mozfile 07:00:41 INFO - Running setup.py install for mozhttpd 07:00:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:00:41 INFO - Running setup.py install for mozinfo 07:00:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:00:41 INFO - Running setup.py install for mozInstall 07:00:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:00:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:00:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:00:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:00:41 INFO - Running setup.py install for mozleak 07:00:41 INFO - Running setup.py install for mozlog 07:00:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:00:42 INFO - Running setup.py install for moznetwork 07:00:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:00:42 INFO - Running setup.py install for mozprocess 07:00:42 INFO - Running setup.py install for mozprofile 07:00:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:00:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:00:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:00:42 INFO - Running setup.py install for mozrunner 07:00:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:00:42 INFO - Running setup.py install for mozscreenshot 07:00:42 INFO - Running setup.py install for moztest 07:00:42 INFO - Running setup.py install for mozversion 07:00:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:00:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:00:42 INFO - Cleaning up... 07:00:42 INFO - Return code: 0 07:00:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:42 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')]} 07:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:42 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')]} 07:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:42 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 0x7f93a6f67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11720f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1204050>, '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 0x1170170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170620>, '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': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', '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 07:00:42 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 07:00:42 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 07:00:42 INFO - Using env: {'DISPLAY': ':0', 07:00:42 INFO - 'HOME': '/home/cltbld', 07:00:42 INFO - 'LANG': 'en_US.UTF-8', 07:00:42 INFO - 'LANGUAGE': 'en_US:en', 07:00:42 INFO - 'LOGNAME': 'cltbld', 07:00:42 INFO - 'MAIL': '/var/mail/cltbld', 07:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:42 INFO - 'MOZ_NO_REMOTE': '1', 07:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:42 INFO - 'NO_EM_RESTART': '1', 07:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:42 INFO - 'PWD': '/builds/slave/test', 07:00:42 INFO - 'SHELL': '/bin/bash', 07:00:42 INFO - 'SHLVL': '1', 07:00:42 INFO - 'TERM': 'linux', 07:00:42 INFO - 'TMOUT': '86400', 07:00:42 INFO - 'USER': 'cltbld', 07:00:42 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', 07:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:42 INFO - '_': '/tools/buildbot/bin/python'} 07:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:00:43 INFO - Running setup.py (path:/tmp/pip-YjFqxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:00:43 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)) 07:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:00:43 INFO - Running setup.py (path:/tmp/pip-iqbvcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:00:43 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)) 07:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:00:43 INFO - Running setup.py (path:/tmp/pip-rZ0d8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:00:43 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)) 07:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:00:43 INFO - Running setup.py (path:/tmp/pip-1ABoRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:00:43 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)) 07:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:00:43 INFO - Running setup.py (path:/tmp/pip-sZXm2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:00:43 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)) 07:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:00:43 INFO - Running setup.py (path:/tmp/pip-v1BiWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:00:43 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)) 07:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:00:43 INFO - Running setup.py (path:/tmp/pip-5qPz9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:00:43 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)) 07:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:00:43 INFO - Running setup.py (path:/tmp/pip-xnlMen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:00:43 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)) 07:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:00:43 INFO - Running setup.py (path:/tmp/pip-Wc5teg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:00:43 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)) 07:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:00:43 INFO - Running setup.py (path:/tmp/pip-dp3cOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:00:43 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)) 07:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:00:43 INFO - Running setup.py (path:/tmp/pip-kK8OQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:00:43 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)) 07:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:00:43 INFO - Running setup.py (path:/tmp/pip-ecHkp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:00:43 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)) 07:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:00:43 INFO - Running setup.py (path:/tmp/pip-qbuBRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:00:43 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)) 07:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:00:43 INFO - Running setup.py (path:/tmp/pip-KkUVfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:00:44 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)) 07:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:44 INFO - Running setup.py (path:/tmp/pip-lHQfJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:44 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)) 07:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:00:44 INFO - Running setup.py (path:/tmp/pip-UfuWWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:00:44 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)) 07:00:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:00:44 INFO - Running setup.py (path:/tmp/pip-hzLhKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:00:44 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)) 07:00:44 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)) 07:00:44 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)) 07:00:44 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)) 07:00:44 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)) 07:00:44 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)) 07:00:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00:46 INFO - Downloading blessings-1.6.tar.gz 07:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:00:46 INFO - Installing collected packages: blessings 07:00:46 INFO - Running setup.py install for blessings 07:00:46 INFO - Successfully installed blessings 07:00:46 INFO - Cleaning up... 07:00:46 INFO - Return code: 0 07:00:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:00:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:46 INFO - Reading from file tmpfile_stdout 07:00:46 INFO - Current package versions: 07:00:46 INFO - argparse == 1.2.1 07:00:46 INFO - blessings == 1.6 07:00:46 INFO - blobuploader == 1.2.4 07:00:46 INFO - docopt == 0.6.1 07:00:46 INFO - functools32 == 3.2.3-2 07:00:46 INFO - jsonschema == 2.5.1 07:00:46 INFO - manifestparser == 1.1 07:00:46 INFO - mozInstall == 1.12 07:00:46 INFO - mozcrash == 0.17 07:00:46 INFO - mozdebug == 0.1 07:00:46 INFO - mozdevice == 0.48 07:00:46 INFO - mozfile == 1.2 07:00:46 INFO - mozhttpd == 0.7 07:00:46 INFO - mozinfo == 0.9 07:00:46 INFO - mozleak == 0.1 07:00:46 INFO - mozlog == 3.2 07:00:46 INFO - moznetwork == 0.27 07:00:46 INFO - mozprocess == 0.22 07:00:46 INFO - mozprofile == 0.28 07:00:46 INFO - mozrunner == 6.11 07:00:46 INFO - mozscreenshot == 0.1 07:00:46 INFO - mozsystemmonitor == 0.3 07:00:46 INFO - moztest == 0.7 07:00:46 INFO - mozversion == 1.4 07:00:46 INFO - psutil == 3.1.1 07:00:46 INFO - requests == 1.2.3 07:00:46 INFO - wsgiref == 0.1.2 07:00:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:46 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 0x7f93a6f67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11720f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1204050>, '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 0x1170170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170620>, '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': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', '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 07:00:46 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 07:00:46 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 07:00:46 INFO - Using env: {'DISPLAY': ':0', 07:00:46 INFO - 'HOME': '/home/cltbld', 07:00:46 INFO - 'LANG': 'en_US.UTF-8', 07:00:46 INFO - 'LANGUAGE': 'en_US:en', 07:00:46 INFO - 'LOGNAME': 'cltbld', 07:00:46 INFO - 'MAIL': '/var/mail/cltbld', 07:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:46 INFO - 'MOZ_NO_REMOTE': '1', 07:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:46 INFO - 'NO_EM_RESTART': '1', 07:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:46 INFO - 'PWD': '/builds/slave/test', 07:00:46 INFO - 'SHELL': '/bin/bash', 07:00:46 INFO - 'SHLVL': '1', 07:00:46 INFO - 'TERM': 'linux', 07:00:46 INFO - 'TMOUT': '86400', 07:00:46 INFO - 'USER': 'cltbld', 07:00:46 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', 07:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:46 INFO - '_': '/tools/buildbot/bin/python'} 07:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:46 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)) 07:00:46 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)) 07:00:46 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)) 07:00:46 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)) 07:00:46 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)) 07:00:46 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)) 07:00:46 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)) 07:00:46 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)) 07:00:46 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)) 07:00:46 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)) 07:00:46 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)) 07:00:46 INFO - Cleaning up... 07:00:46 INFO - Return code: 0 07:00:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93a6f67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11720f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1204050>, '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 0x1170170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170620>, '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': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', '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 07:00:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:00:46 INFO - Using env: {'DISPLAY': ':0', 07:00:46 INFO - 'HOME': '/home/cltbld', 07:00:46 INFO - 'LANG': 'en_US.UTF-8', 07:00:46 INFO - 'LANGUAGE': 'en_US:en', 07:00:46 INFO - 'LOGNAME': 'cltbld', 07:00:46 INFO - 'MAIL': '/var/mail/cltbld', 07:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:46 INFO - 'MOZ_NO_REMOTE': '1', 07:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:46 INFO - 'NO_EM_RESTART': '1', 07:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:46 INFO - 'PWD': '/builds/slave/test', 07:00:46 INFO - 'SHELL': '/bin/bash', 07:00:46 INFO - 'SHLVL': '1', 07:00:46 INFO - 'TERM': 'linux', 07:00:46 INFO - 'TMOUT': '86400', 07:00:46 INFO - 'USER': 'cltbld', 07:00:46 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', 07:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:46 INFO - '_': '/tools/buildbot/bin/python'} 07:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:00:47 INFO - Cleaning up... 07:00:47 INFO - Return code: 0 07:00:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:47 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 0x7f93a6f67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11720f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1204050>, '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 0x1170170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170620>, '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': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', '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 07:00:47 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 07:00:47 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 07:00:47 INFO - Using env: {'DISPLAY': ':0', 07:00:47 INFO - 'HOME': '/home/cltbld', 07:00:47 INFO - 'LANG': 'en_US.UTF-8', 07:00:47 INFO - 'LANGUAGE': 'en_US:en', 07:00:47 INFO - 'LOGNAME': 'cltbld', 07:00:47 INFO - 'MAIL': '/var/mail/cltbld', 07:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:47 INFO - 'MOZ_NO_REMOTE': '1', 07:00:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:47 INFO - 'NO_EM_RESTART': '1', 07:00:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:47 INFO - 'PWD': '/builds/slave/test', 07:00:47 INFO - 'SHELL': '/bin/bash', 07:00:47 INFO - 'SHLVL': '1', 07:00:47 INFO - 'TERM': 'linux', 07:00:47 INFO - 'TMOUT': '86400', 07:00:47 INFO - 'USER': 'cltbld', 07:00:47 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', 07:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:47 INFO - '_': '/tools/buildbot/bin/python'} 07:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:47 INFO - Downloading/unpacking flake8 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:00:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:00:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:00:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:00:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:00:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:00:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:00:49 INFO - no previously-included directories found matching 'docs/_build' 07:00:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:00:49 INFO - Running setup.py install for pep8 07:00:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:00:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:00:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:00:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:00:50 INFO - no previously-included directories found matching 'docs/_build' 07:00:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:00:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:00:50 INFO - Cleaning up... 07:00:50 INFO - Return code: 0 07:00:50 INFO - Running post-action listener: _resource_record_post_action 07:00:50 INFO - Running post-action listener: _start_resource_monitoring 07:00:50 INFO - Starting resource monitoring. 07:00:50 INFO - ##### 07:00:50 INFO - ##### Finished create-virtualenv step (success) 07:00:50 INFO - ##### 07:00:50 INFO - ##### 07:00:50 INFO - ##### Running install step. 07:00:50 INFO - ##### 07:00:50 INFO - Running pre-action listener: _resource_record_pre_action 07:00:50 INFO - Running main action method: install 07:00:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:00:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:50 INFO - Reading from file tmpfile_stdout 07:00:50 INFO - Detecting whether we're running mozinstall >=1.0... 07:00:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:00:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:00:50 INFO - Reading from file tmpfile_stdout 07:00:50 INFO - Output received: 07:00:50 INFO - Usage: mozinstall [options] installer 07:00:50 INFO - Options: 07:00:50 INFO - -h, --help show this help message and exit 07:00:50 INFO - -d DEST, --destination=DEST 07:00:50 INFO - Directory to install application into. [default: 07:00:50 INFO - "/builds/slave/test"] 07:00:50 INFO - --app=APP Application being installed. [default: firefox] 07:00:50 INFO - mkdir: /builds/slave/test/build/application 07:00:50 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'] 07:00:50 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 07:01:07 INFO - Reading from file tmpfile_stdout 07:01:07 INFO - Output received: 07:01:07 INFO - /builds/slave/test/build/application/firefox/firefox 07:01:07 INFO - Running post-action listener: _resource_record_post_action 07:01:07 INFO - ##### 07:01:07 INFO - ##### Finished install step (success) 07:01:07 INFO - ##### 07:01:07 INFO - ##### 07:01:07 INFO - ##### Running run-tests step. 07:01:07 INFO - ##### 07:01:07 INFO - Running pre-action listener: _resource_record_pre_action 07:01:07 INFO - Running main action method: run_tests 07:01:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:01:07 INFO - Python 2.7.3 07:01:07 INFO - Return code: 0 07:01:07 INFO - grabbing minidump binary from tooltool 07:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:07 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 0x1204050>, '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 0x1170170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170620>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:01:07 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 07:01:07 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 07:01:07 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 07:01:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:01:07 INFO - Return code: 0 07:01:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:01:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:01:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:01:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:01:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:01:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:01:08 INFO - Return code: 0 07:01:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 07:01:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 07:01:08 INFO - Using env: {'DISPLAY': ':0', 07:01:08 INFO - 'HOME': '/home/cltbld', 07:01:08 INFO - 'LANG': 'en_US.UTF-8', 07:01:08 INFO - 'LANGUAGE': 'en_US:en', 07:01:08 INFO - 'LOGNAME': 'cltbld', 07:01:08 INFO - 'MAIL': '/var/mail/cltbld', 07:01:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:01:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:01:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:08 INFO - 'MOZ_NO_REMOTE': '1', 07:01:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:01:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:08 INFO - 'NO_EM_RESTART': '1', 07:01:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:08 INFO - 'PWD': '/builds/slave/test', 07:01:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:01:08 INFO - 'SHELL': '/bin/bash', 07:01:08 INFO - 'SHLVL': '1', 07:01:08 INFO - 'TERM': 'linux', 07:01:08 INFO - 'TMOUT': '86400', 07:01:08 INFO - 'USER': 'cltbld', 07:01:08 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852', 07:01:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:08 INFO - '_': '/tools/buildbot/bin/python'} 07:01:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 07:01:08 INFO - mozversion application_buildid: 20160608043006 07:01:08 INFO - mozversion application_changeset: f8ad071a6e14331d73fa44c8d3108bc2b66b2174 07:01:08 INFO - mozversion application_display_name: Nightly 07:01:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:01:08 INFO - mozversion application_name: Firefox 07:01:08 INFO - mozversion application_remotingname: firefox 07:01:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:01:08 INFO - mozversion application_vendor: Mozilla 07:01:08 INFO - mozversion application_version: 50.0a1 07:01:08 INFO - mozversion platform_buildid: 20160608043006 07:01:08 INFO - mozversion platform_changeset: f8ad071a6e14331d73fa44c8d3108bc2b66b2174 07:01:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:01:08 INFO - mozversion platform_version: 50.0a1 07:01:08 INFO - using testdate: 1465394468 07:01:08 INFO - actual date: 1465394468 07:01:08 INFO - starting webserver on 'localhost:42120' 07:01:08 INFO - SUITE-START | Running 2 tests 07:01:08 INFO - TEST-START | dromaeo_css 07:01:08 INFO - operating with platform_type : linux_ 07:01:08 INFO - Initialising browser for dromaeo_css test... 07:01:08 INFO - TEST-INFO | started process 14257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYXSfmq/profile http://localhost:42120/getInfo.html) 07:01:13 INFO - PROCESS | 14257 | __metrics Screen width/height:1600/1200 07:01:13 INFO - PROCESS | 14257 | colorDepth:24 07:01:13 INFO - PROCESS | 14257 | Browser inner width/height: 1024/697 07:01:13 INFO - PROCESS | 14257 | __metrics 07:01:13 ERROR - PROCESS | 14257 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 07:01:14 INFO - TEST-INFO | 14257: exit 0 07:01:14 INFO - Browser initialized. 07:01:14 INFO - Running cycle 1/1 for dromaeo_css test... 07:01:14 INFO - TEST-INFO | started process 14374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYXSfmq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:01:26 INFO - PROCESS | 14374 | RSS: Main: 167264256 07:01:26 INFO - PROCESS | 14374 | 07:02:15 INFO - PROCESS | 14374 | 1465394535894 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] 07:04:23 INFO - PROCESS | 14374 | Cycle 1(1): loaded http://localhost:42120/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42120/tests/dromaeo/cssquery-ext.html) 07:04:24 INFO - PROCESS | 14374 | RSS: Main: 171630592 07:04:24 INFO - PROCESS | 14374 | 07:07:26 INFO - PROCESS | 14374 | Cycle 1(1): loaded http://localhost:42120/tests/dromaeo/cssquery-ext.html (next: http://localhost:42120/tests/dromaeo/cssquery-jquery.html) 07:07:27 INFO - PROCESS | 14374 | RSS: Main: 169836544 07:07:27 INFO - PROCESS | 14374 | 07:10:29 INFO - PROCESS | 14374 | Cycle 1(1): loaded http://localhost:42120/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42120/tests/dromaeo/cssquery-mootools.html) 07:10:29 INFO - PROCESS | 14374 | RSS: Main: 171573248 07:10:29 INFO - PROCESS | 14374 | 07:13:31 INFO - PROCESS | 14374 | Cycle 1(1): loaded http://localhost:42120/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42120/tests/dromaeo/cssquery-prototype.html) 07:13:32 INFO - PROCESS | 14374 | RSS: Main: 168951808 07:13:32 INFO - PROCESS | 14374 | 07:16:34 INFO - PROCESS | 14374 | Cycle 1(1): loaded http://localhost:42120/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42120/tests/dromaeo/cssquery-yui.html) 07:16:35 INFO - PROCESS | 14374 | RSS: Main: 170717184 07:16:35 INFO - PROCESS | 14374 | 07:19:37 INFO - PROCESS | 14374 | Cycle 1(1): loaded http://localhost:42120/tests/dromaeo/cssquery-yui.html (next: http://localhost:42120/tests/dromaeo/cssquery-dojo.html) 07:19:38 INFO - PROCESS | 14374 | RSS: Main: 172142592 07:19:38 INFO - PROCESS | 14374 | 07:19:38 INFO - PROCESS | 14374 | __start_tp_report 07:19:38 INFO - PROCESS | 14374 | _x_x_mozilla_page_load 07:19:38 INFO - PROCESS | 14374 | _x_x_mozilla_page_load_details 07:19:38 INFO - PROCESS | 14374 | |i|pagename|runs| 07:19:38 INFO - PROCESS | 14374 | |0;dojo.html;3156.6685498022703;3184.028871194285;3232.806031638102;3232.8383580820955;3240.6111266648004;5398.649087809299;5468.644538105021;5474.096774032289;5498.532624726898;5501.2848329717135;5317.2821669074665;5379.67721936684;5424.105022671254;5427.782888684458;5529.861753456165;4828.661993660437;4858.392700912386;4950.158473059589;5009.774560144802;5057.822976195834;999.6046564743006;4938.80244790208;4995.175795993657;5017.071841709278;5050.949490505103;4998.800047998076;5008.874778130539;5010.148274793294;5028.421731500887;5054.1913293872985;4874.951250487486;4999.175136102539;5003.874903127415;5046.419661738911;5058.671186372874;4863.902721945541;4878.707277563322;4880.170371036932;4908.607311415079;4912.533309335608;5259.447757985433;5430.402655707869;5438.238646589481;5452.04589196889;5456.48163424474;5764.077747560412;5805.36141024487;5910.054391297372;5911.733971971272;5930.970345148246;5804.8839023219725;5868.149118377854;5870.148828419898;5874.73563689635;5944.167816505693;5491.450854914517;5500.339959204921;5500.889982200333;5506.504414602665;5514.641548299348;5880.705964701748;5881;5923.733431995571;5948.95893218685;5980.491658209014;5705.115707065412;5727.942720572824;5736.741846616912;5737.827865164052;5740.425957404226;5810.1865738796605;5811.593188476851;5825.533957283407;5832.300123985149;5852.034414321589;5730.111832665943;5767.134929760569;5799.3620701722775;5844.59087863854;5874.412558744091;5646.971765141148;5726.398728133569;5745.8563535911935;5775.249217601685;5884.352721200665;4409.316555933835;4434.445694288214;4440.289553671397;4451.577100175478;4467.084247729208;3876.9418458723144;3908.257431088084;3927.509061367329;3952.209558088394;3961.6236457537066;5589.636673616202;5593.74828132735;5603.271574695264;5605;5615.691136987505;5757.424257574209;5881.32364778056;5888.411158884163;5890.2342695449315;5949.196858424144;5511.3937466878615;5564.4991950724625;5587.608867379245;5610;5625.099984002622;5067.214581739836;5113.846584602468;5118.10433174193;5118.257852611425;5154.845354639367;5833.329167145747;6124.739298837964;6165.32181460039;6173.56785025044;6175.96912015437;5865.6480611162615;5906.822795316148;5931.08068249422;5963.880722385615;5966.403359663999;6039.577229593886;6121.785737499166;6125.173101631222;6134.846628834315;6152.600080994721;5649.20911072442;5744.712764361681;5840.94159058404;5851.61964472308;5853.2976042875125;5851.473367396955;5910.940890591211;5921.289445266596;5929.495992840484;5973.074173503114;5746.597738158289;5782.624129431573;5788.942110579009;5795.797147099831;5800.39095894925;5518.779248830162;5631.549476041825;5634.4365563443325;5713.771449141987;5779.68211748341;5497.697626630574;5632.464915832989;5636.520895723909;5657.717114144359;5691.146328050825;5805.477507024388;5838.095095260242;5851.590388672922;5868.149118377726;5879.176915231957;5548.306461692288;5631;5653.208550802973;5682.971585142048;5731.914021289601 07:19:38 INFO - PROCESS | 14374 | |1;ext.html;583.3029529711994;623.9656818874962;628.9276733175686;640.7597151068346;640.7821340744148;42886.57113428865;43989.7800510997;44090.11819763607;44091;48004.75997620007;45251.32123018157;46036;46122;46371.76814115925;46456.30315545261;8835.381523293372;8943.418677785923;8966.686165984192;8968.103189681045;9040.638374465014;8833;8921.107889211093;8975.237104846095;8977.192052715254;8999.370044096915;8888.377813553054;8994.370394072417;8996.325275604324;9025.232855207283;9031.638734450615;8874.822503549958;8927;8935.28517718581;8945.686900958468;8992.640294388217;8769.780755481164;8852.822943541094;8856.51289179095;8873.245774109208;8882.777930551723;41971.1605767886;42085.36871946923;42400;42680;42697;3482.7387945903906;3549.219171782204;3576.695980841632;3581.8925432237074;3595.982020089909;31948.680513194802;32538.186545336557;32724.836375818206;32831;33041;4028.3353246714255;4454.844080457201;4467.039586488921;4581.587657110876;4601.332806743004;263587;350632;353700.99999999744;355124;356104;32462.67537324644;33289.83355083209;63821.361786381545;64470.35529644737;64478;36473.08817279589;36501.26997460036;36506.63493365086;36516.45225321622;36637;15486.5354039379;15711.21443927822;15805.604859878595;15816;15867.285972131282;13145.868541314465;13273.402696878664;13275;13327.000474964223;13352.866471335163;8472;8496.490210587384;8530.70142545008;8595.613197406132;8603.741887743377;3268.362669279468;3271.8854840080485;3274.6561611030497;3306.9503957440656;3315.7181639560426;1005.6681295172575;1032.5921261101973;1051.4427353502504;1118.6252605377126;1149.5344385523877;32807;32898.8355058228;32978.505322420184;33504.3299134016;33572.32855342879;1113.1929351220301;1121.966341009771;1150.4822829726488;1189.8869607387285;1204.10895937006;17273.91363043177;17428.910482073;17456.738148927776;17626.29494820193;17662.735058974125;617258;620701;624070;627200;627311;59583;60258.698706507064;60546.69726651339;60628;60629.69685151546;1341.8322709661293;1387.3063468265866;1400.852910444409;1411.9688289932096;1415.0660564027899;31188.68811311858;32172.517412239304;32241.838790805898;32545.34909301848;33036;53465;53469.46530534645;54118;54175;54197;485224;485334;485759;486411;486806;28449;28526;28819.135425937257;28858;29005.7099429003;49440;50145.49854501408;50180;50652.24021639604;50912.490875092255;41925.79037104795;42743.572564273956;42852.35721464243;43021.35467967921;43283.56716432796;40822;42045.3750087484;42279.26313740551;42620;42764;38358.61641383662;39731.205375892896;39738.60261397349;40591.59408405878;41206.381904270864;35423.29153416866;37872.62127378691;37894.81052594719;38047.809760951015;38229.61770382372;28211.294717632223;28376.43247135087;28835.134945951653;29589;30508.542371864885 07:19:38 INFO - PROCESS | 14374 | |2;jquery.html;378.18878505605494;380.7449009163861;394.07785781271826;403.1895889262581;407.30757711889777;14696.338664760086;15903.44337948172;17251.82748172518;20057.598848023048;20064.59870802583;17742.379016734416;18149.366557009867;18523.629527409445;19059.237630494797;19176.52058698533;5582.8325150245555;5655.066913959192;5768.134779783024;5805.419458054182;5809.041508151171;5699.373068962411;5710.514606258453;5712.800051998181;5730.083186690131;5738.942610573882;5255;5535.059039963216;5631.549476041907;5650.6892120933335;5675.404082571333;5563.499285064343;5564.8052318168875;5573.749181286831;5598.020346439397;5776.451237132465;5626.212330273724;5668.97165514174;5742.253507044099;5743.684097374643;5743.798967036176;13603.455861765517;13895.79156312656;19950.600987980306;20860.47848803777;20908.37274881756;2214.1475531920164;2264.5810525052916;2267.7392099908557;2327.2087490253393;2377.465070359173;9647.855282170773;10117.342372745748;10320.638777642747;10374.585016599327;10481.318714283547;1938.3409640722223;1953.7948515405963;2095.8532902696816;2106.262808017197;2116.0900812650552;71714.64142679305;76331.61834190793;76666.61666691686;78055.21944780536;80066;10804.945975270073;11052.557897684002;11161.944190278997;11327.207095503236;11533.653990380302;15517.612059698598;15689;15710.764338534931;15713.607159821097;15766.605834854221;8142.552159631277;8250.958745206235;8523.616437260338;8755.430896991675;8791.252743516872;8252.46358986664;8369.288610468178;8398.076211616717;8544.957275213585;8571.485710857369;4637.976810115928;4737.265723812815;4818.277258411266;4833.685810422382;4935.457099719028;1993.2126809910005;2045.7238272833274;2047.64166270902;2053.8973051347375;2055.4347554422357;947.5357075033185;976.2921881635899;1003.4882210072915;1028.7788125553043;1051.3008849115406;17350.30598776035;18333.541661458305;18880.622387552172;19538.31615893437;19550.315738949354;962.1340793285958;994.393420013791;1044.4412239452008;1058.5606973106228;1067.5356220044305;10651.467426628638;11025;11069.280496767684;11070.335779853234;11098.833517497244;490867;500038;502530;502974;503881;70433;83500;93005;94931;96741;1016.4409574733867;1091.2088735666737;1091.9508622111864;1095.9342439453658;1110.3005106782675;17209.91395043067;17402.39091631787;17719.55701107431;17782.110894455484;17796.110194490484;31941.201469962507;40057.79971100126;41090.79454602708;41411.37882931698;41590.792046039576;53849;54935.17597235965;54998.17502737382;55587.44412555823;55865.44134558765;7621.923780762121;8662.220400164015;8748.650053998024;8931.776705582412;9076.364654474388;12717.364131793189;13530.661733456349;13653.317334133055;13826.585202443943;13895;11514.136439767219;11545.711357216136;11652.067834573045;12073.879261207627;12137.150399471951;11513.13651476126;11523.53905843757;11578.247413918069;11604.187706860439;11756.529738810352;11699.532018719156;12198.390080495763;12198.81701774492;12410.441530131346;12505.374731263582;7982.521048736862;8021.318187954089;8170.550619715973;8210.753677389688;8239.752807415787;11644.88355116472;11846.822297665369;11985.64043078709;12079.27524348542;12142.028637709138 07:19:38 INFO - PROCESS | 14374 | |3;mootools.html;1489.679718860445;1502.6318551954769;1680.4370535870482;1813.3109418420997;1816.155487698221;7731.884021739678;8158.428909976304;8420.32637389009;9041.773955651111;9065.04816994216;8361.498310101399;8600.182982616641;8642.092580279075;8642.611082501287;8642.956785216082;2259.954800903981;2317.8841057947034;2322.7677232276806;2329.336139200328;2330.0330362899376;2274.1585613323095;2295.885205739715;2310.330004298751;2315.988420057897;2316.5830150572892;2267.5124848157643;2309.1917828759883;2311.0062673050584;2329.8835058247105;2338.1348900906687;2241.316398498457;2245.5621153875;2248.303026061918;2250.4036430345973;2255.469964558319;2260.6382978723327;2264.5923733727923;2264.7169103862016;2283.6346184610547;2294.793468587835;8458.365622578269;8565;8574.828503429959;8581.699640512614;8591.44155629882;5143.228515722672;5269.262303277545;5281.8151364702435;5281.9207711884355;5285.048691235576;3157.842107894619;3174.9682503174904;3299.406106900757;3342.8829990950444;3391.372596069735;1113.3653817324127;1178.1281851429965;1235.1107202814048;1244.402686710375;1249.6001279590535;12046.759064818654;12202.511899524008;12218.511259549607;12240.44917978693;12282.938585307016;4475.820967161342;4580.587747102777;4655.231886738718;4691.929621055687;4707.693999890064;10507.264491485523;10520.316179448464;10536.262461627766;10545.209109316833;10550.103241224428;5258.474152584711;5295.179247216687;5328.254044433782;5329.946700532945;5339.519443250126;4211.494620645542;4578.130155270488;4651.023285110165;4655.86032419028;4877.12211801879;3884.7086468514976;3946.980265098656;3961.227560625708;3997.2804895118575;4032.516098068251;1212.6968257935516;1221.096388672394;1229.975400492003;1235.9443825027895;1236.344737289238;893.8525143351275;1001.8948010458797;1022.0750221049962;1028.5422986770816;1031.3966329697062;5731.598788084877;5926.881462370815;5982.760689572368;6075.2405949256345;6180.134781130645;470.6681789338508;473.091664005111;474.553919315842;476.3117295508027;477.91158635652516;4078.9796051019557;4289.63538099265;4310.741355518679;4314.590113939171;4353.782310884443;9952.701418957442;10330.225233107547;10369.222308326755;10378.844317335246;10403.687889363331;10235.7441063974;10492.370457772558;10586.20603454744;10842.512086956105;10877;7990.920090799018;8234.958825205835;8263.297619702273;8263.95868020656;8271.090180080186;5884.941150588439;6113.510919126548;6132.509399248139;6154.415330543591;6187.041008643668;10098.394096354243;10159.593616255563;10253.794924101625;10265.897341026493;10268.691939241835;9978.451185184884;10331.276810623183;10345.689629311133;10435.530401132119;10440.164786817188;7050.8237294066;7760.18518055596;7924.128345881833;7984.920150798418;8026.8394632105865;8699.869501957603;8709.825803484022;8712.520811355436;8767.60545775429;8785.692500762443;7661.885071723817;7914.327282181079;7932.16712245206;7933.444658873824;7946.721864734706;7188.568685878864;7630.961845190738;7725.768226953201;7907.644156012878;7912.169222231582;7096.929030709834;7113.53762005468;7167.498275120692;7169.820754481179;7192.496525243392;4984.42679091909;5114.872128196825;5220.9477905220465;5289.656172348785;5340.973295133499;5177.611679124006;5256.710880901587;5278.287431196739;5368.141097424394;5384.542313903362 07:19:38 INFO - PROCESS | 14374 | |4;prototype.html;329.90927494938904;332.7936231162038;337.6707709982766;339.86235574592286;341.8769243072495;5520.309961254843;5561.637398837285;5626.80306189283;5648.209250704895;5678.886422271552;5577.358603760569;5589.776408943648;5601.187827764971;5605.775768969236;5607.971960140204;4162.791860406983;4191.979040104795;4305.332673435622;4307.892302692427;4316.460442444694;4296.677749168809;4320.848770293041;4341.717788343748;4373.934390984138;4382.649388048964;4335.761533115693;4359.673024523174;4368.912621747563;4373.4255667959505;4383.627391671712;4253.51084625269;4275.080857615612;4332.783360831946;4341.740895140406;4351.173277077377;3823.4073718573663;3838.136419305634;3859.807009649506;3868.226354729037;3886.747361421527;5324.5740340772645;5378.273933019032;5402.459754024605;5406.54044406226;5412.350517937873;4904.288878112654;4922.75386230687;4991.500849915015;5002.1496345621335;5021.196608542652;5772.8845423091725;5793.594448388614;5815.98220311448;5829.085457271364;5873.148393482964;4230.450041494617;4236.279832428495;4256.893577660552;4258.593894449626;4274.444322238121;5715.657060576337;5972.910406343908;6002.039673652194;6019.428154325332;6098.847528811771;4176.248275310412;4179.519355274182;4213.115245798355;4231.259529582372;4236;4275.657947364203;4278.331450734217;4285.100128972888;4294.334378171388;4305.5048669402795;4717.905641887143;4874.390701162355;4889.731064791399;4898.951010489921;4932.630052746058;5819.679917604572;5820.322651580321;5828.795992140254;5838.7080645967535;5874.706264686749;1451.883849292054;1463.144060724488;1486.4277253257574;1487.761958086701;1498.4380857178558;927.5455027036703;929.5816882402946;937.929655275857;942.948137852411;954.9331546791658;4899.534544218293;4908.607311415079;4980.327655766498;4981.975090124599;4998.350214472168;5223.451537588575;5249.238860365302;5264.499872512105;5323.22813192085;5404.756785944642;4780.832670856504;5004.549590536796;5011.323471331397;5012.498750125032;5040.672356296903;2826.915192544227;2885.336372634306;2892.75411590013;2899.1737354853767;2926.7658587312962;5444.91832622511;5456.727163641802;5484.862878427992;5528.396764938123;5533.363663178706;5177.058603023866;5361.437049109865;5389.865253368619;5414.566834653218;5423.2136340230445;5438.347398312228;5485.917711234335;5557.026990560031;5592.86017849557;5595.804146854841;5233.921491177712;5374.892502150014;5406;5459.535939445192;5539.446055394428;5916.55625828056;6013.158157857991;6032.155498230163;6046.334903160737;6048.092786082123;6294.968525157345;6314.968425157845;6324.841878952879;6345;6358.93641063602;4030.496187976503;4232.111256636018;4235.11062676829;4241.766702831374;4292.806823693004;5802.533923082758;5936.664250543593;5949.315828679584;5978;6008.339082700987;5879.7060146993335;5946.821595352147;5970.194023806905;5986.952283350483;6005.2793664758765;5824.456519022548;5846.532277417881;5862.589618726648;5917.491039784827;5969.104634304716;5592.496675299242;5684.8294551163535;5758.971205143947;5764.625299355528;5771.509421699203;5823.94176058234;5937.5249980000635;5939.990201665641;5961.791337303173;5972.8805423892145;5639.407862174413;5739.167820666064;5747;5775.834062226665;5832 07:19:38 INFO - PROCESS | 14374 | |5;yui.html;780.3756994404475;806.6934564865351;815.3843847894842;815.388458656008;835.9205875441835;15367.846321536781;16004;16270.186490675478;16322.591935201626;16381.83618163818;14507.85492145081;14838.109713417203;14867.330970106344;14869;14932.328045237964;671.9294474080212;789.0491957191599;796.6295672512281;796.8446153000167;799.5322736199302;804.3565147881671;804.806846356876;809.3120847279824;812.273015650992;812.8252425728467;857.8756080368343;863.1282404771194;865.4288169807928;865.9913400865973;867.488181972636;852.228732996639;853.91887770662;854.7649396415973;854.9700760473385;860.7331727164599;622.9719662615194;624.1386886097157;624.7657128576784;624.9437550620421;625.2653132569213;14507.1295722257;14556;14571.562853114423;14616.342264598119;14643.41426342945;14622.415103395851;15189.316480758393;15288.694226115414;15321.92746507745;15376.308066137051;12307.92145570095;12350.320732359716;12367.058823529413;12681;12747.04397170216;3939.2909276330247;3960.386140148282;3968.226195891802;4048.4939382577177;4125.834966601333;67484.3251567483;69012.3098769011;69308.65345673289;69420;71136.28863711348;11523.250988685708;11569.30584164936;11615.30308181495;11776.646700598996;11819.88180118205;22039.779602203773;22301.553968920532;22395.44011399728;22451.101955921906;22889.88555057214;8286.254237118688;8439.240468357877;8482.279006284412;8575.656973721107;8934.597943092576;4745.549172828576;4758.5241475852135;4765.904681906342;4817.78319975602;4896.094222568836;3490.197254631398;3627.782333060025;3636.7999760012926;3636.818159092035;3637.2907283079544;645.1484041065748;670.9765158219536;675.4967549175896;681.7613835157655;683.565935630868;732.6959311885614;757.1519897714485;768.8039549914736;769.9615019249015;795.3478147918651;10234.33476824004;10273.434961077213;10354.585816567404;10512.894871051192;10593.046625803714;638.8818068657313;692.2177938929078;781.6560713286136;792.3344390711715;806.5765473126655;4951.90096198074;4963.8262660806695;5114.181730923109;5147.176451767774;5216.66091704038;118324;118812.40593796976;118883;119632.40183799199;121492.39253803852;104955.4752226234;105945;107273.34539891448;108553.4572327149;109253.45373273082;82869.58565207256;89784.5510772455;91641.5417922906;91984.08015919889;93128;8984.910150898408;8986.32602554798;9023.503707296162;9050.592723327334;9053.773655658399;40579.391309129795;41213.79393103015;43075;47930.281045785036;54043;71167.64416177887;71921.40392980225;72590.63704681443;73197;73392;13086.280254586089;13261.734765304833;13307.334633268105;13338.399772010476;13390.464381424634;13757.79363309531;15086.698266034837;15234.619134521725;15260.160691162093;15372.923135384252;13434.39545220487;13767.311634418038;13988.440462381392;14232.359543820347;14628;13576.524821631196;13963.162210267417;14129.434822606981;14530.782038269223;14666.41334346657;12914.28971406544;13030.4136313868;13074.673133171365;13352.112394680056;13824;11174.553017879194;11366.545338186379;11377.715557111138;11386.259893106922;11618.76762464763;10745.570177192825;10936.677688740529;11026.469721415868;11520.769584608093;11636.53453861836 07:19:38 INFO - PROCESS | 14374 | __end_tp_report 07:19:38 INFO - PROCESS | 14374 | __start_cc_report 07:19:38 INFO - PROCESS | 14374 | _x_x_mozilla_cycle_collect,351 07:19:38 INFO - PROCESS | 14374 | __end_cc_report 07:19:38 INFO - PROCESS | 14374 | __startTimestamp1465395578239__endTimestamp 07:19:38 INFO - PROCESS | 14374 | 07:19:38 INFO - PROCESS | 14374 | ------- Summary: start ------- 07:19:38 INFO - PROCESS | 14374 | Number of tests: 6 07:19:38 INFO - PROCESS | 14374 | 07:19:38 INFO - PROCESS | 14374 | [#0] dojo.html Cycles:165 Average:5416.99 Median:5646.97 stddev:712.70 (12.6%) stddev-sans-first:692.48 07:19:38 INFO - PROCESS | 14374 | Values: 3156.7 3184.0 3232.8 3232.8 3240.6 5398.6 5468.6 5474.1 5498.5 5501.3 5317.3 5379.7 5424.1 5427.8 5529.9 4828.7 4858.4 4950.2 5009.8 5057.8 999.6 4938.8 4995.2 5017.1 5050.9 4998.8 5008.9 5010.1 5028.4 5054.2 4875.0 4999.2 5003.9 5046.4 5058.7 4863.9 4878.7 4880.2 4908.6 4912.5 5259.4 5430.4 5438.2 5452.0 5456.5 5764.1 5805.4 5910.1 5911.7 5931.0 5804.9 5868.1 5870.1 5874.7 5944.2 5491.5 5500.3 5500.9 5506.5 5514.6 5880.7 5881.0 5923.7 5949.0 5980.5 5705.1 5727.9 5736.7 5737.8 5740.4 5810.2 5811.6 5825.5 5832.3 5852.0 5730.1 5767.1 5799.4 5844.6 5874.4 5647.0 5726.4 5745.9 5775.2 5884.4 4409.3 4434.4 4440.3 4451.6 4467.1 3876.9 3908.3 3927.5 3952.2 3961.6 5589.6 5593.7 5603.3 5605.0 5615.7 5757.4 5881.3 5888.4 5890.2 5949.2 5511.4 5564.5 5587.6 5610.0 5625.1 5067.2 5113.8 5118.1 5118.3 5154.8 5833.3 6124.7 6165.3 6173.6 6176.0 5865.6 5906.8 5931.1 5963.9 5966.4 6039.6 6121.8 6125.2 6134.8 6152.6 5649.2 5744.7 5840.9 5851.6 5853.3 5851.5 5910.9 5921.3 5929.5 5973.1 5746.6 5782.6 5788.9 5795.8 5800.4 5518.8 5631.5 5634.4 5713.8 5779.7 5497.7 5632.5 5636.5 5657.7 5691.1 5805.5 5838.1 5851.6 5868.1 5879.2 5548.3 5631.0 5653.2 5683.0 5731.9 07:19:38 INFO - PROCESS | 14374 | 07:19:38 INFO - PROCESS | 14374 | [#1] ext.html Cycles:180 Average:62892.53 Median:42008.27 stddev:132475.33 (315.4%) stddev-sans-first:132764.36 07:19:38 INFO - PROCESS | 14374 | Values: 583.3 624.0 628.9 640.8 640.8 42886.6 43989.8 44090.1 44091.0 48004.8 45251.3 46036.0 46122.0 46371.8 46456.3 8835.4 8943.4 8966.7 8968.1 9040.6 8833.0 8921.1 8975.2 8977.2 8999.4 8888.4 8994.4 8996.3 9025.2 9031.6 8874.8 8927.0 8935.3 8945.7 8992.6 8769.8 8852.8 8856.5 8873.2 8882.8 41971.2 42085.4 42400.0 42680.0 42697.0 3482.7 3549.2 3576.7 3581.9 3596.0 31948.7 32538.2 32724.8 32831.0 33041.0 4028.3 4454.8 4467.0 4581.6 4601.3 263587.0 350632.0 353701.0 355124.0 356104.0 32462.7 33289.8 63821.4 64470.4 64478.0 36473.1 36501.3 36506.6 36516.5 36637.0 15486.5 15711.2 15805.6 15816.0 15867.3 13145.9 13273.4 13275.0 13327.0 13352.9 8472.0 8496.5 8530.7 8595.6 8603.7 3268.4 3271.9 3274.7 3307.0 3315.7 1005.7 1032.6 1051.4 1118.6 1149.5 32807.0 32898.8 32978.5 33504.3 33572.3 1113.2 1122.0 1150.5 1189.9 1204.1 17273.9 17428.9 17456.7 17626.3 17662.7 617258.0 620701.0 624070.0 627200.0 627311.0 59583.0 60258.7 60546.7 60628.0 60629.7 1341.8 1387.3 1400.9 1412.0 1415.1 31188.7 32172.5 32241.8 32545.3 33036.0 53465.0 53469.5 54118.0 54175.0 54197.0 485224.0 485334.0 485759.0 486411.0 486806.0 28449.0 28526.0 28819.1 28858.0 29005.7 49440.0 50145.5 50180.0 50652.2 50912.5 41925.8 42743.6 42852.4 43021.4 43283.6 40822.0 42045.4 42279.3 42620.0 42764.0 38358.6 39731.2 39738.6 40591.6 41206.4 35423.3 37872.6 37894.8 38047.8 38229.6 28211.3 28376.4 28835.1 29589.0 30508.5 07:19:38 INFO - PROCESS | 14374 | 07:19:38 INFO - PROCESS | 14374 | [#2] jquery.html Cycles:180 Average:28738.81 Median:2239.36 stddev:82229.15 (3672.0%) stddev-sans-first:82432.25 07:19:38 INFO - PROCESS | 14374 | Values: 378.2 380.7 394.1 403.2 407.3 14696.3 15903.4 17251.8 20057.6 20064.6 17742.4 18149.4 18523.6 19059.2 19176.5 5582.8 5655.1 5768.1 5805.4 5809.0 5699.4 5710.5 5712.8 5730.1 5738.9 5255.0 5535.1 5631.5 5650.7 5675.4 5563.5 5564.8 5573.7 5598.0 5776.5 5626.2 5669.0 5742.3 5743.7 5743.8 13603.5 13895.8 19950.6 20860.5 20908.4 2214.1 2264.6 2267.7 2327.2 2377.5 9647.9 10117.3 10320.6 10374.6 10481.3 1938.3 1953.8 2095.9 2106.3 2116.1 71714.6 76331.6 76666.6 78055.2 80066.0 10804.9 11052.6 11161.9 11327.2 11533.7 15517.6 15689.0 15710.8 15713.6 15766.6 8142.6 8251.0 8523.6 8755.4 8791.3 8252.5 8369.3 8398.1 8545.0 8571.5 4638.0 4737.3 4818.3 4833.7 4935.5 1993.2 2045.7 2047.6 2053.9 2055.4 947.5 976.3 1003.5 1028.8 1051.3 17350.3 18333.5 18880.6 19538.3 19550.3 962.1 994.4 1044.4 1058.6 1067.5 10651.5 11025.0 11069.3 11070.3 11098.8 490867.0 500038.0 502530.0 502974.0 503881.0 70433.0 83500.0 93005.0 94931.0 96741.0 1016.4 1091.2 1092.0 1095.9 1110.3 17209.9 17402.4 17719.6 17782.1 17796.1 31941.2 40057.8 41090.8 41411.4 41590.8 53849.0 54935.2 54998.2 55587.4 55865.4 7621.9 8662.2 8748.7 8931.8 9076.4 12717.4 13530.7 13653.3 13826.6 13895.0 11514.1 11545.7 11652.1 12073.9 12137.2 11513.1 11523.5 11578.2 11604.2 11756.5 11699.5 12198.4 12198.8 12410.4 12505.4 7982.5 8021.3 8170.6 8210.8 8239.8 11644.9 11846.8 11985.6 12079.3 12142.0 07:19:38 INFO - PROCESS | 14374 | 07:19:38 INFO - PROCESS | 14374 | [#3] mootools.html Cycles:180 Average:5777.68 Median:4615.81 stddev:3283.13 (71.1%) stddev-sans-first:3276.53 07:19:38 INFO - PROCESS | 14374 | Values: 1489.7 1502.6 1680.4 1813.3 1816.2 7731.9 8158.4 8420.3 9041.8 9065.0 8361.5 8600.2 8642.1 8642.6 8643.0 2260.0 2317.9 2322.8 2329.3 2330.0 2274.2 2295.9 2310.3 2316.0 2316.6 2267.5 2309.2 2311.0 2329.9 2338.1 2241.3 2245.6 2248.3 2250.4 2255.5 2260.6 2264.6 2264.7 2283.6 2294.8 8458.4 8565.0 8574.8 8581.7 8591.4 5143.2 5269.3 5281.8 5281.9 5285.0 3157.8 3175.0 3299.4 3342.9 3391.4 1113.4 1178.1 1235.1 1244.4 1249.6 12046.8 12202.5 12218.5 12240.4 12282.9 4475.8 4580.6 4655.2 4691.9 4707.7 10507.3 10520.3 10536.3 10545.2 10550.1 5258.5 5295.2 5328.3 5329.9 5339.5 4211.5 4578.1 4651.0 4655.9 4877.1 3884.7 3947.0 3961.2 3997.3 4032.5 1212.7 1221.1 1230.0 1235.9 1236.3 893.9 1001.9 1022.1 1028.5 1031.4 5731.6 5926.9 5982.8 6075.2 6180.1 470.7 473.1 474.6 476.3 477.9 4079.0 4289.6 4310.7 4314.6 4353.8 9952.7 10330.2 10369.2 10378.8 10403.7 10235.7 10492.4 10586.2 10842.5 10877.0 7990.9 8235.0 8263.3 8264.0 8271.1 5884.9 6113.5 6132.5 6154.4 6187.0 10098.4 10159.6 10253.8 10265.9 10268.7 9978.5 10331.3 10345.7 10435.5 10440.2 7050.8 7760.2 7924.1 7984.9 8026.8 8699.9 8709.8 8712.5 8767.6 8785.7 7661.9 7914.3 7932.2 7933.4 7946.7 7188.6 7631.0 7725.8 7907.6 7912.2 7096.9 7113.5 7167.5 7169.8 7192.5 4984.4 5114.9 5220.9 5289.7 5341.0 5177.6 5256.7 5278.3 5368.1 5384.5 07:19:38 INFO - PROCESS | 14374 | 07:19:38 INFO - PROCESS | 14374 | [#4] prototype.html Cycles:180 Average:4784.92 Median:5396.16 stddev:1402.68 (26.0%) stddev-sans-first:1366.18 07:19:38 INFO - PROCESS | 14374 | Values: 329.9 332.8 337.7 339.9 341.9 5520.3 5561.6 5626.8 5648.2 5678.9 5577.4 5589.8 5601.2 5605.8 5608.0 4162.8 4192.0 4305.3 4307.9 4316.5 4296.7 4320.8 4341.7 4373.9 4382.6 4335.8 4359.7 4368.9 4373.4 4383.6 4253.5 4275.1 4332.8 4341.7 4351.2 3823.4 3838.1 3859.8 3868.2 3886.7 5324.6 5378.3 5402.5 5406.5 5412.4 4904.3 4922.8 4991.5 5002.1 5021.2 5772.9 5793.6 5816.0 5829.1 5873.1 4230.5 4236.3 4256.9 4258.6 4274.4 5715.7 5972.9 6002.0 6019.4 6098.8 4176.2 4179.5 4213.1 4231.3 4236.0 4275.7 4278.3 4285.1 4294.3 4305.5 4717.9 4874.4 4889.7 4899.0 4932.6 5819.7 5820.3 5828.8 5838.7 5874.7 1451.9 1463.1 1486.4 1487.8 1498.4 927.5 929.6 937.9 942.9 954.9 4899.5 4908.6 4980.3 4982.0 4998.4 5223.5 5249.2 5264.5 5323.2 5404.8 4780.8 5004.5 5011.3 5012.5 5040.7 2826.9 2885.3 2892.8 2899.2 2926.8 5444.9 5456.7 5484.9 5528.4 5533.4 5177.1 5361.4 5389.9 5414.6 5423.2 5438.3 5485.9 5557.0 5592.9 5595.8 5233.9 5374.9 5406.0 5459.5 5539.4 5916.6 6013.2 6032.2 6046.3 6048.1 6295.0 6315.0 6324.8 6345.0 6358.9 4030.5 4232.1 4235.1 4241.8 4292.8 5802.5 5936.7 5949.3 5978.0 6008.3 5879.7 5946.8 5970.2 5987.0 6005.3 5824.5 5846.5 5862.6 5917.5 5969.1 5592.5 5684.8 5759.0 5764.6 5771.5 5823.9 5937.5 5940.0 5961.8 5972.9 5639.4 5739.2 5747.0 5775.8 5832.0 07:19:38 INFO - PROCESS | 14374 | 07:19:38 INFO - PROCESS | 14374 | [#5] yui.html Cycles:180 Average:20981.61 Median:3949.84 stddev:30555.17 (773.6%) stddev-sans-first:30603.24 07:19:38 INFO - PROCESS | 14374 | Values: 780.4 806.7 815.4 815.4 835.9 15367.8 16004.0 16270.2 16322.6 16381.8 14507.9 14838.1 14867.3 14869.0 14932.3 671.9 789.0 796.6 796.8 799.5 804.4 804.8 809.3 812.3 812.8 857.9 863.1 865.4 866.0 867.5 852.2 853.9 854.8 855.0 860.7 623.0 624.1 624.8 624.9 625.3 14507.1 14556.0 14571.6 14616.3 14643.4 14622.4 15189.3 15288.7 15321.9 15376.3 12307.9 12350.3 12367.1 12681.0 12747.0 3939.3 3960.4 3968.2 4048.5 4125.8 67484.3 69012.3 69308.7 69420.0 71136.3 11523.3 11569.3 11615.3 11776.6 11819.9 22039.8 22301.6 22395.4 22451.1 22889.9 8286.3 8439.2 8482.3 8575.7 8934.6 4745.5 4758.5 4765.9 4817.8 4896.1 3490.2 3627.8 3636.8 3636.8 3637.3 645.1 671.0 675.5 681.8 683.6 732.7 757.2 768.8 770.0 795.3 10234.3 10273.4 10354.6 10512.9 10593.0 638.9 692.2 781.7 792.3 806.6 4951.9 4963.8 5114.2 5147.2 5216.7 118324.0 118812.4 118883.0 119632.4 121492.4 104955.5 105945.0 107273.3 108553.5 109253.5 82869.6 89784.6 91641.5 91984.1 93128.0 8984.9 8986.3 9023.5 9050.6 9053.8 40579.4 41213.8 43075.0 47930.3 54043.0 71167.6 71921.4 72590.6 73197.0 73392.0 13086.3 13261.7 13307.3 13338.4 13390.5 13757.8 15086.7 15234.6 15260.2 15372.9 13434.4 13767.3 13988.4 14232.4 14628.0 13576.5 13963.2 14129.4 14530.8 14666.4 12914.3 13030.4 13074.7 13352.1 13824.0 11174.6 11366.5 11377.7 11386.3 11618.8 10745.6 10936.7 11026.5 11520.8 11636.5 07:19:38 INFO - PROCESS | 14374 | -------- Summary: end -------- 07:19:38 INFO - PROCESS | 14374 | 07:19:38 INFO - TEST-INFO | 14374: exit 0 07:19:38 INFO - TEST-OK | dromaeo_css | took 1110462ms 07:19:38 INFO - TEST-START | kraken 07:19:38 INFO - operating with platform_type : linux_ 07:19:38 INFO - Initialising browser for kraken test... 07:19:38 INFO - TEST-INFO | started process 14613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3XhLKo/profile http://localhost:42120/getInfo.html) 07:19:43 INFO - PROCESS | 14613 | __metrics Screen width/height:1600/1200 07:19:43 INFO - PROCESS | 14613 | colorDepth:24 07:19:43 INFO - PROCESS | 14613 | Browser inner width/height: 1024/697 07:19:43 INFO - PROCESS | 14613 | __metrics 07:19:43 ERROR - PROCESS | 14613 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 07:19:44 INFO - TEST-INFO | 14613: exit 0 07:19:44 INFO - Browser initialized. 07:19:44 INFO - Running cycle 1/1 for kraken test... 07:19:44 INFO - TEST-INFO | started process 14731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3XhLKo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:56 INFO - PROCESS | 14731 | RSS: Main: 167919616 07:19:56 INFO - PROCESS | 14731 | 07:19:59 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:42120/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42120/tests/kraken/driver.html?testName=audio-beat-detection) 07:19:59 INFO - PROCESS | 14731 | RSS: Main: 173416448 07:19:59 INFO - PROCESS | 14731 | 07:20:02 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:42120/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42120/tests/kraken/driver.html?testName=audio-dft) 07:20:03 INFO - PROCESS | 14731 | RSS: Main: 172802048 07:20:03 INFO - PROCESS | 14731 | 07:20:06 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:42120/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42120/tests/kraken/driver.html?testName=audio-fft) 07:20:06 INFO - PROCESS | 14731 | RSS: Main: 167432192 07:20:06 INFO - PROCESS | 14731 | 07:20:08 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:42120/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42120/tests/kraken/driver.html?testName=audio-oscillator) 07:20:09 INFO - PROCESS | 14731 | RSS: Main: 168009728 07:20:09 INFO - PROCESS | 14731 | 07:20:11 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:42120/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42120/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:20:12 INFO - PROCESS | 14731 | RSS: Main: 167948288 07:20:12 INFO - PROCESS | 14731 | 07:20:15 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:42120/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42120/tests/kraken/driver.html?testName=imaging-darkroom) 07:20:16 INFO - PROCESS | 14731 | RSS: Main: 168263680 07:20:16 INFO - PROCESS | 14731 | 07:20:19 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:42120/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42120/tests/kraken/driver.html?testName=imaging-desaturate) 07:20:20 INFO - PROCESS | 14731 | RSS: Main: 168857600 07:20:20 INFO - PROCESS | 14731 | 07:20:22 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:42120/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42120/tests/kraken/driver.html?testName=json-parse-financial) 07:20:23 INFO - PROCESS | 14731 | RSS: Main: 168648704 07:20:23 INFO - PROCESS | 14731 | 07:20:25 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:42120/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42120/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:20:25 INFO - PROCESS | 14731 | RSS: Main: 169013248 07:20:25 INFO - PROCESS | 14731 | 07:20:27 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:42120/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42120/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:20:28 INFO - PROCESS | 14731 | RSS: Main: 168947712 07:20:28 INFO - PROCESS | 14731 | 07:20:30 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:42120/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42120/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:20:30 INFO - PROCESS | 14731 | RSS: Main: 169218048 07:20:30 INFO - PROCESS | 14731 | 07:20:33 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:42120/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42120/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:20:34 INFO - PROCESS | 14731 | RSS: Main: 169275392 07:20:34 INFO - PROCESS | 14731 | 07:20:36 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:42120/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42120/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:20:37 INFO - PROCESS | 14731 | RSS: Main: 169418752 07:20:37 INFO - PROCESS | 14731 | 07:20:39 INFO - PROCESS | 14731 | Cycle 1(1): loaded http://localhost:42120/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42120/tests/kraken/driver.html?testName=ai-astar) 07:20:39 INFO - PROCESS | 14731 | RSS: Main: 169947136 07:20:39 INFO - PROCESS | 14731 | 07:20:39 INFO - PROCESS | 14731 | __start_tp_report 07:20:39 INFO - PROCESS | 14731 | _x_x_mozilla_page_load 07:20:39 INFO - PROCESS | 14731 | _x_x_mozilla_page_load_details 07:20:39 INFO - PROCESS | 14731 | |i|pagename|runs| 07:20:39 INFO - PROCESS | 14731 | |0;ai-astar;111;105;111;111;110;111;109;109;111;111 07:20:39 INFO - PROCESS | 14731 | |1;audio-beat-detection;155;126;163;179;128;157;159;129;186;127 07:20:39 INFO - PROCESS | 14731 | |2;audio-dft;162;163;163;160;166;172;166;161;162;161 07:20:39 INFO - PROCESS | 14731 | |3;audio-fft;76;74;77;156;77;76;75;75;172;76 07:20:39 INFO - PROCESS | 14731 | |4;audio-oscillator;86;89;156;84;85;84;147;85;85;139 07:20:39 INFO - PROCESS | 14731 | |5;imaging-gaussian-blur;117;118;117;118;118;118;118;118;118;118 07:20:39 INFO - PROCESS | 14731 | |6;imaging-darkroom;146;147;148;145;148;147;147;147;147;147 07:20:39 INFO - PROCESS | 14731 | |7;imaging-desaturate;96;97;96;96;95;95;95;96;95;95 07:20:39 INFO - PROCESS | 14731 | |8;json-parse-financial;62;55;57;55;55;60;55;56;55;56 07:20:39 INFO - PROCESS | 14731 | |9;json-stringify-tinderbox;60;61;61;61;61;62;61;61;60;61 07:20:39 INFO - PROCESS | 14731 | |10;stanford-crypto-aes;79;79;79;81;81;85;81;81;108;80 07:20:39 INFO - PROCESS | 14731 | |11;stanford-crypto-ccm;123;125;132;131;128;135;131;127;151;126 07:20:39 INFO - PROCESS | 14731 | |12;stanford-crypto-pbkdf2;161;166;164;160;168;175;160;164;163;158 07:20:39 INFO - PROCESS | 14731 | |13;stanford-crypto-sha256-iterative;67;64;64;69;62;63;67;62;64;67 07:20:39 INFO - PROCESS | 14731 | __end_tp_report 07:20:39 INFO - PROCESS | 14731 | __start_cc_report 07:20:39 INFO - PROCESS | 14731 | _x_x_mozilla_cycle_collect,850 07:20:39 INFO - PROCESS | 14731 | __end_cc_report 07:20:39 INFO - PROCESS | 14731 | __startTimestamp1465395639516__endTimestamp 07:20:39 INFO - PROCESS | 14731 | 07:20:39 INFO - PROCESS | 14731 | ------- Summary: start ------- 07:20:39 INFO - PROCESS | 14731 | Number of tests: 14 07:20:39 INFO - PROCESS | 14731 | 07:20:39 INFO - PROCESS | 14731 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:1.91 (1.7%) stddev-sans-first:1.99 07:20:39 INFO - PROCESS | 14731 | Values: 111.0 105.0 111.0 111.0 110.0 111.0 109.0 109.0 111.0 111.0 07:20:39 INFO - PROCESS | 14731 | 07:20:39 INFO - PROCESS | 14731 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:158.00 stddev:22.32 (14.1%) stddev-sans-first:23.62 07:20:39 INFO - PROCESS | 14731 | Values: 155.0 126.0 163.0 179.0 128.0 157.0 159.0 129.0 186.0 127.0 07:20:39 INFO - PROCESS | 14731 | 07:20:39 INFO - PROCESS | 14731 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:3.57 (2.2%) stddev-sans-first:3.73 07:20:39 INFO - PROCESS | 14731 | Values: 162.0 163.0 163.0 160.0 166.0 172.0 166.0 161.0 162.0 161.0 07:20:39 INFO - PROCESS | 14731 | 07:20:39 INFO - PROCESS | 14731 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.00 stddev:37.41 (49.2%) stddev-sans-first:39.15 07:20:39 INFO - PROCESS | 14731 | Values: 76.0 74.0 77.0 156.0 77.0 76.0 75.0 75.0 172.0 76.0 07:20:39 INFO - PROCESS | 14731 | 07:20:39 INFO - PROCESS | 14731 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:85.00 stddev:30.20 (35.5%) stddev-sans-first:31.32 07:20:39 INFO - PROCESS | 14731 | Values: 86.0 89.0 156.0 84.0 85.0 84.0 147.0 85.0 85.0 139.0 07:20:39 INFO - PROCESS | 14731 | 07:20:39 INFO - PROCESS | 14731 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 07:20:39 INFO - PROCESS | 14731 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 07:20:39 INFO - PROCESS | 14731 | 07:20:39 INFO - PROCESS | 14731 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 07:20:39 INFO - PROCESS | 14731 | Values: 146.0 147.0 148.0 145.0 148.0 147.0 147.0 147.0 147.0 147.0 07:20:39 INFO - PROCESS | 14731 | 07:20:39 INFO - PROCESS | 14731 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 07:20:39 INFO - PROCESS | 14731 | Values: 96.0 97.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 07:20:39 INFO - PROCESS | 14731 | 07:20:39 INFO - PROCESS | 14731 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.00 stddev:2.46 (4.4%) stddev-sans-first:1.66 07:20:39 INFO - PROCESS | 14731 | Values: 62.0 55.0 57.0 55.0 55.0 60.0 55.0 56.0 55.0 56.0 07:20:39 INFO - PROCESS | 14731 | 07:20:39 INFO - PROCESS | 14731 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 07:20:39 INFO - PROCESS | 14731 | Values: 60.0 61.0 61.0 61.0 61.0 62.0 61.0 61.0 60.0 61.0 07:20:39 INFO - PROCESS | 14731 | 07:20:39 INFO - PROCESS | 14731 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:81.00 stddev:8.82 (10.9%) stddev-sans-first:9.21 07:20:39 INFO - PROCESS | 14731 | Values: 79.0 79.0 79.0 81.0 81.0 85.0 81.0 81.0 108.0 80.0 07:20:39 INFO - PROCESS | 14731 | 07:20:39 INFO - PROCESS | 14731 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:131.00 stddev:7.94 (6.1%) stddev-sans-first:7.89 07:20:39 INFO - PROCESS | 14731 | Values: 123.0 125.0 132.0 131.0 128.0 135.0 131.0 127.0 151.0 126.0 07:20:39 INFO - PROCESS | 14731 | 07:20:39 INFO - PROCESS | 14731 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:164.00 stddev:4.93 (3.0%) stddev-sans-first:5.12 07:20:39 INFO - PROCESS | 14731 | Values: 161.0 166.0 164.0 160.0 168.0 175.0 160.0 164.0 163.0 158.0 07:20:39 INFO - PROCESS | 14731 | 07:20:39 INFO - PROCESS | 14731 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.50 stddev:2.42 (3.7%) stddev-sans-first:2.45 07:20:39 INFO - PROCESS | 14731 | Values: 67.0 64.0 64.0 69.0 62.0 63.0 67.0 62.0 64.0 67.0 07:20:39 INFO - PROCESS | 14731 | -------- Summary: end -------- 07:20:39 INFO - PROCESS | 14731 | 07:20:40 INFO - TEST-INFO | 14731: exit 0 07:20:40 INFO - TEST-OK | kraken | took 61568ms 07:20:40 INFO - SUITE-END | took 1172s 07:20:40 INFO - Completed test suite (00:19:32) 07:20:40 INFO - javascript benchmark 07:20:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7245.420718769181, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3156.6685498022703, 3184.028871194285, 3232.806031638102, 3232.8383580820955, 3240.6111266648004, 5398.649087809299, 5468.644538105021, 5474.096774032289, 5498.532624726898, 5501.2848329717135, 5317.2821669074665, 5379.67721936684, 5424.105022671254, 5427.782888684458, 5529.861753456165, 4828.661993660437, 4858.392700912386, 4950.158473059589, 5009.774560144802, 5057.822976195834, 999.6046564743006, 4938.80244790208, 4995.175795993657, 5017.071841709278, 5050.949490505103, 4998.800047998076, 5008.874778130539, 5010.148274793294, 5028.421731500887, 5054.1913293872985, 4874.951250487486, 4999.175136102539, 5003.874903127415, 5046.419661738911, 5058.671186372874, 4863.902721945541, 4878.707277563322, 4880.170371036932, 4908.607311415079, 4912.533309335608, 5259.447757985433, 5430.402655707869, 5438.238646589481, 5452.04589196889, 5456.48163424474, 5764.077747560412, 5805.36141024487, 5910.054391297372, 5911.733971971272, 5930.970345148246, 5804.8839023219725, 5868.149118377854, 5870.148828419898, 5874.73563689635, 5944.167816505693, 5491.450854914517, 5500.339959204921, 5500.889982200333, 5506.504414602665, 5514.641548299348, 5880.705964701748, 5881.0, 5923.733431995571, 5948.95893218685, 5980.491658209014, 5705.115707065412, 5727.942720572824, 5736.741846616912, 5737.827865164052, 5740.425957404226, 5810.1865738796605, 5811.593188476851, 5825.533957283407, 5832.300123985149, 5852.034414321589, 5730.111832665943, 5767.134929760569, 5799.3620701722775, 5844.59087863854, 5874.412558744091, 5646.971765141148, 5726.398728133569, 5745.8563535911935, 5775.249217601685, 5884.352721200665, 4409.316555933835, 4434.445694288214, 4440.289553671397, 4451.577100175478, 4467.084247729208, 3876.9418458723144, 3908.257431088084, 3927.509061367329, 3952.209558088394, 3961.6236457537066, 5589.636673616202, 5593.74828132735, 5603.271574695264, 5605.0, 5615.691136987505, 5757.424257574209, 5881.32364778056, 5888.411158884163, 5890.2342695449315, 5949.196858424144, 5511.3937466878615, 5564.4991950724625, 5587.608867379245, 5610.0, 5625.099984002622, 5067.214581739836, 5113.846584602468, 5118.10433174193, 5118.257852611425, 5154.845354639367, 5833.329167145747, 6124.739298837964, 6165.32181460039, 6173.56785025044, 6175.96912015437, 5865.6480611162615, 5906.822795316148, 5931.08068249422, 5963.880722385615, 5966.403359663999, 6039.577229593886, 6121.785737499166, 6125.173101631222, 6134.846628834315, 6152.600080994721, 5649.20911072442, 5744.712764361681, 5840.94159058404, 5851.61964472308, 5853.2976042875125, 5851.473367396955, 5910.940890591211, 5921.289445266596, 5929.495992840484, 5973.074173503114, 5746.597738158289, 5782.624129431573, 5788.942110579009, 5795.797147099831, 5800.39095894925, 5518.779248830162, 5631.549476041825, 5634.4365563443325, 5713.771449141987, 5779.68211748341, 5497.697626630574, 5632.464915832989, 5636.520895723909, 5657.717114144359, 5691.146328050825, 5805.477507024388, 5838.095095260242, 5851.590388672922, 5868.149118377726, 5879.176915231957, 5548.306461692288, 5631.0, 5653.208550802973, 5682.971585142048, 5731.914021289601], "value": 5370.476017131672, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.3029529711994, 623.9656818874962, 628.9276733175686, 640.7597151068346, 640.7821340744148, 42886.57113428865, 43989.7800510997, 44090.11819763607, 44091.0, 48004.75997620007, 45251.32123018157, 46036.0, 46122.0, 46371.76814115925, 46456.30315545261, 8835.381523293372, 8943.418677785923, 8966.686165984192, 8968.103189681045, 9040.638374465014, 8833.0, 8921.107889211093, 8975.237104846095, 8977.192052715254, 8999.370044096915, 8888.377813553054, 8994.370394072417, 8996.325275604324, 9025.232855207283, 9031.638734450615, 8874.822503549958, 8927.0, 8935.28517718581, 8945.686900958468, 8992.640294388217, 8769.780755481164, 8852.822943541094, 8856.51289179095, 8873.245774109208, 8882.777930551723, 41971.1605767886, 42085.36871946923, 42400.0, 42680.0, 42697.0, 3482.7387945903906, 3549.219171782204, 3576.695980841632, 3581.8925432237074, 3595.982020089909, 31948.680513194802, 32538.186545336557, 32724.836375818206, 32831.0, 33041.0, 4028.3353246714255, 4454.844080457201, 4467.039586488921, 4581.587657110876, 4601.332806743004, 263587.0, 350632.0, 353700.99999999744, 355124.0, 356104.0, 32462.67537324644, 33289.83355083209, 63821.361786381545, 64470.35529644737, 64478.0, 36473.08817279589, 36501.26997460036, 36506.63493365086, 36516.45225321622, 36637.0, 15486.5354039379, 15711.21443927822, 15805.604859878595, 15816.0, 15867.285972131282, 13145.868541314465, 13273.402696878664, 13275.0, 13327.000474964223, 13352.866471335163, 8472.0, 8496.490210587384, 8530.70142545008, 8595.613197406132, 8603.741887743377, 3268.362669279468, 3271.8854840080485, 3274.6561611030497, 3306.9503957440656, 3315.7181639560426, 1005.6681295172575, 1032.5921261101973, 1051.4427353502504, 1118.6252605377126, 1149.5344385523877, 32807.0, 32898.8355058228, 32978.505322420184, 33504.3299134016, 33572.32855342879, 1113.1929351220301, 1121.966341009771, 1150.4822829726488, 1189.8869607387285, 1204.10895937006, 17273.91363043177, 17428.910482073, 17456.738148927776, 17626.29494820193, 17662.735058974125, 617258.0, 620701.0, 624070.0, 627200.0, 627311.0, 59583.0, 60258.698706507064, 60546.69726651339, 60628.0, 60629.69685151546, 1341.8322709661293, 1387.3063468265866, 1400.852910444409, 1411.9688289932096, 1415.0660564027899, 31188.68811311858, 32172.517412239304, 32241.838790805898, 32545.34909301848, 33036.0, 53465.0, 53469.46530534645, 54118.0, 54175.0, 54197.0, 485224.0, 485334.0, 485759.0, 486411.0, 486806.0, 28449.0, 28526.0, 28819.135425937257, 28858.0, 29005.7099429003, 49440.0, 50145.49854501408, 50180.0, 50652.24021639604, 50912.490875092255, 41925.79037104795, 42743.572564273956, 42852.35721464243, 43021.35467967921, 43283.56716432796, 40822.0, 42045.3750087484, 42279.26313740551, 42620.0, 42764.0, 38358.61641383662, 39731.205375892896, 39738.60261397349, 40591.59408405878, 41206.381904270864, 35423.29153416866, 37872.62127378691, 37894.81052594719, 38047.809760951015, 38229.61770382372, 28211.294717632223, 28376.43247135087, 28835.134945951653, 29589.0, 30508.542371864885], "value": 19359.187855528024, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.18878505605494, 380.7449009163861, 394.07785781271826, 403.1895889262581, 407.30757711889777, 14696.338664760086, 15903.44337948172, 17251.82748172518, 20057.598848023048, 20064.59870802583, 17742.379016734416, 18149.366557009867, 18523.629527409445, 19059.237630494797, 19176.52058698533, 5582.8325150245555, 5655.066913959192, 5768.134779783024, 5805.419458054182, 5809.041508151171, 5699.373068962411, 5710.514606258453, 5712.800051998181, 5730.083186690131, 5738.942610573882, 5255.0, 5535.059039963216, 5631.549476041907, 5650.6892120933335, 5675.404082571333, 5563.499285064343, 5564.8052318168875, 5573.749181286831, 5598.020346439397, 5776.451237132465, 5626.212330273724, 5668.97165514174, 5742.253507044099, 5743.684097374643, 5743.798967036176, 13603.455861765517, 13895.79156312656, 19950.600987980306, 20860.47848803777, 20908.37274881756, 2214.1475531920164, 2264.5810525052916, 2267.7392099908557, 2327.2087490253393, 2377.465070359173, 9647.855282170773, 10117.342372745748, 10320.638777642747, 10374.585016599327, 10481.318714283547, 1938.3409640722223, 1953.7948515405963, 2095.8532902696816, 2106.262808017197, 2116.0900812650552, 71714.64142679305, 76331.61834190793, 76666.61666691686, 78055.21944780536, 80066.0, 10804.945975270073, 11052.557897684002, 11161.944190278997, 11327.207095503236, 11533.653990380302, 15517.612059698598, 15689.0, 15710.764338534931, 15713.607159821097, 15766.605834854221, 8142.552159631277, 8250.958745206235, 8523.616437260338, 8755.430896991675, 8791.252743516872, 8252.46358986664, 8369.288610468178, 8398.076211616717, 8544.957275213585, 8571.485710857369, 4637.976810115928, 4737.265723812815, 4818.277258411266, 4833.685810422382, 4935.457099719028, 1993.2126809910005, 2045.7238272833274, 2047.64166270902, 2053.8973051347375, 2055.4347554422357, 947.5357075033185, 976.2921881635899, 1003.4882210072915, 1028.7788125553043, 1051.3008849115406, 17350.30598776035, 18333.541661458305, 18880.622387552172, 19538.31615893437, 19550.315738949354, 962.1340793285958, 994.393420013791, 1044.4412239452008, 1058.5606973106228, 1067.5356220044305, 10651.467426628638, 11025.0, 11069.280496767684, 11070.335779853234, 11098.833517497244, 490867.0, 500038.0, 502530.0, 502974.0, 503881.0, 70433.0, 83500.0, 93005.0, 94931.0, 96741.0, 1016.4409574733867, 1091.2088735666737, 1091.9508622111864, 1095.9342439453658, 1110.3005106782675, 17209.91395043067, 17402.39091631787, 17719.55701107431, 17782.110894455484, 17796.110194490484, 31941.201469962507, 40057.79971100126, 41090.79454602708, 41411.37882931698, 41590.792046039576, 53849.0, 54935.17597235965, 54998.17502737382, 55587.44412555823, 55865.44134558765, 7621.923780762121, 8662.220400164015, 8748.650053998024, 8931.776705582412, 9076.364654474388, 12717.364131793189, 13530.661733456349, 13653.317334133055, 13826.585202443943, 13895.0, 11514.136439767219, 11545.711357216136, 11652.067834573045, 12073.879261207627, 12137.150399471951, 11513.13651476126, 11523.53905843757, 11578.247413918069, 11604.187706860439, 11756.529738810352, 11699.532018719156, 12198.390080495763, 12198.81701774492, 12410.441530131346, 12505.374731263582, 7982.521048736862, 8021.318187954089, 8170.550619715973, 8210.753677389688, 8239.752807415787, 11644.88355116472, 11846.822297665369, 11985.64043078709, 12079.27524348542, 12142.028637709138], "value": 9161.967707960463, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1489.679718860445, 1502.6318551954769, 1680.4370535870482, 1813.3109418420997, 1816.155487698221, 7731.884021739678, 8158.428909976304, 8420.32637389009, 9041.773955651111, 9065.04816994216, 8361.498310101399, 8600.182982616641, 8642.092580279075, 8642.611082501287, 8642.956785216082, 2259.954800903981, 2317.8841057947034, 2322.7677232276806, 2329.336139200328, 2330.0330362899376, 2274.1585613323095, 2295.885205739715, 2310.330004298751, 2315.988420057897, 2316.5830150572892, 2267.5124848157643, 2309.1917828759883, 2311.0062673050584, 2329.8835058247105, 2338.1348900906687, 2241.316398498457, 2245.5621153875, 2248.303026061918, 2250.4036430345973, 2255.469964558319, 2260.6382978723327, 2264.5923733727923, 2264.7169103862016, 2283.6346184610547, 2294.793468587835, 8458.365622578269, 8565.0, 8574.828503429959, 8581.699640512614, 8591.44155629882, 5143.228515722672, 5269.262303277545, 5281.8151364702435, 5281.9207711884355, 5285.048691235576, 3157.842107894619, 3174.9682503174904, 3299.406106900757, 3342.8829990950444, 3391.372596069735, 1113.3653817324127, 1178.1281851429965, 1235.1107202814048, 1244.402686710375, 1249.6001279590535, 12046.759064818654, 12202.511899524008, 12218.511259549607, 12240.44917978693, 12282.938585307016, 4475.820967161342, 4580.587747102777, 4655.231886738718, 4691.929621055687, 4707.693999890064, 10507.264491485523, 10520.316179448464, 10536.262461627766, 10545.209109316833, 10550.103241224428, 5258.474152584711, 5295.179247216687, 5328.254044433782, 5329.946700532945, 5339.519443250126, 4211.494620645542, 4578.130155270488, 4651.023285110165, 4655.86032419028, 4877.12211801879, 3884.7086468514976, 3946.980265098656, 3961.227560625708, 3997.2804895118575, 4032.516098068251, 1212.6968257935516, 1221.096388672394, 1229.975400492003, 1235.9443825027895, 1236.344737289238, 893.8525143351275, 1001.8948010458797, 1022.0750221049962, 1028.5422986770816, 1031.3966329697062, 5731.598788084877, 5926.881462370815, 5982.760689572368, 6075.2405949256345, 6180.134781130645, 470.6681789338508, 473.091664005111, 474.553919315842, 476.3117295508027, 477.91158635652516, 4078.9796051019557, 4289.63538099265, 4310.741355518679, 4314.590113939171, 4353.782310884443, 9952.701418957442, 10330.225233107547, 10369.222308326755, 10378.844317335246, 10403.687889363331, 10235.7441063974, 10492.370457772558, 10586.20603454744, 10842.512086956105, 10877.0, 7990.920090799018, 8234.958825205835, 8263.297619702273, 8263.95868020656, 8271.090180080186, 5884.941150588439, 6113.510919126548, 6132.509399248139, 6154.415330543591, 6187.041008643668, 10098.394096354243, 10159.593616255563, 10253.794924101625, 10265.897341026493, 10268.691939241835, 9978.451185184884, 10331.276810623183, 10345.689629311133, 10435.530401132119, 10440.164786817188, 7050.8237294066, 7760.18518055596, 7924.128345881833, 7984.920150798418, 8026.8394632105865, 8699.869501957603, 8709.825803484022, 8712.520811355436, 8767.60545775429, 8785.692500762443, 7661.885071723817, 7914.327282181079, 7932.16712245206, 7933.444658873824, 7946.721864734706, 7188.568685878864, 7630.961845190738, 7725.768226953201, 7907.644156012878, 7912.169222231582, 7096.929030709834, 7113.53762005468, 7167.498275120692, 7169.820754481179, 7192.496525243392, 4984.42679091909, 5114.872128196825, 5220.9477905220465, 5289.656172348785, 5340.973295133499, 5177.611679124006, 5256.710880901587, 5278.287431196739, 5368.141097424394, 5384.542313903362], "value": 4560.361177581826, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.90927494938904, 332.7936231162038, 337.6707709982766, 339.86235574592286, 341.8769243072495, 5520.309961254843, 5561.637398837285, 5626.80306189283, 5648.209250704895, 5678.886422271552, 5577.358603760569, 5589.776408943648, 5601.187827764971, 5605.775768969236, 5607.971960140204, 4162.791860406983, 4191.979040104795, 4305.332673435622, 4307.892302692427, 4316.460442444694, 4296.677749168809, 4320.848770293041, 4341.717788343748, 4373.934390984138, 4382.649388048964, 4335.761533115693, 4359.673024523174, 4368.912621747563, 4373.4255667959505, 4383.627391671712, 4253.51084625269, 4275.080857615612, 4332.783360831946, 4341.740895140406, 4351.173277077377, 3823.4073718573663, 3838.136419305634, 3859.807009649506, 3868.226354729037, 3886.747361421527, 5324.5740340772645, 5378.273933019032, 5402.459754024605, 5406.54044406226, 5412.350517937873, 4904.288878112654, 4922.75386230687, 4991.500849915015, 5002.1496345621335, 5021.196608542652, 5772.8845423091725, 5793.594448388614, 5815.98220311448, 5829.085457271364, 5873.148393482964, 4230.450041494617, 4236.279832428495, 4256.893577660552, 4258.593894449626, 4274.444322238121, 5715.657060576337, 5972.910406343908, 6002.039673652194, 6019.428154325332, 6098.847528811771, 4176.248275310412, 4179.519355274182, 4213.115245798355, 4231.259529582372, 4236.0, 4275.657947364203, 4278.331450734217, 4285.100128972888, 4294.334378171388, 4305.5048669402795, 4717.905641887143, 4874.390701162355, 4889.731064791399, 4898.951010489921, 4932.630052746058, 5819.679917604572, 5820.322651580321, 5828.795992140254, 5838.7080645967535, 5874.706264686749, 1451.883849292054, 1463.144060724488, 1486.4277253257574, 1487.761958086701, 1498.4380857178558, 927.5455027036703, 929.5816882402946, 937.929655275857, 942.948137852411, 954.9331546791658, 4899.534544218293, 4908.607311415079, 4980.327655766498, 4981.975090124599, 4998.350214472168, 5223.451537588575, 5249.238860365302, 5264.499872512105, 5323.22813192085, 5404.756785944642, 4780.832670856504, 5004.549590536796, 5011.323471331397, 5012.498750125032, 5040.672356296903, 2826.915192544227, 2885.336372634306, 2892.75411590013, 2899.1737354853767, 2926.7658587312962, 5444.91832622511, 5456.727163641802, 5484.862878427992, 5528.396764938123, 5533.363663178706, 5177.058603023866, 5361.437049109865, 5389.865253368619, 5414.566834653218, 5423.2136340230445, 5438.347398312228, 5485.917711234335, 5557.026990560031, 5592.86017849557, 5595.804146854841, 5233.921491177712, 5374.892502150014, 5406.0, 5459.535939445192, 5539.446055394428, 5916.55625828056, 6013.158157857991, 6032.155498230163, 6046.334903160737, 6048.092786082123, 6294.968525157345, 6314.968425157845, 6324.841878952879, 6345.0, 6358.93641063602, 4030.496187976503, 4232.111256636018, 4235.11062676829, 4241.766702831374, 4292.806823693004, 5802.533923082758, 5936.664250543593, 5949.315828679584, 5978.0, 6008.339082700987, 5879.7060146993335, 5946.821595352147, 5970.194023806905, 5986.952283350483, 6005.2793664758765, 5824.456519022548, 5846.532277417881, 5862.589618726648, 5917.491039784827, 5969.104634304716, 5592.496675299242, 5684.8294551163535, 5758.971205143947, 5764.625299355528, 5771.509421699203, 5823.94176058234, 5937.5249980000635, 5939.990201665641, 5961.791337303173, 5972.8805423892145, 5639.407862174413, 5739.167820666064, 5747.0, 5775.834062226665, 5832.0], "value": 4334.614783344644, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.3756994404475, 806.6934564865351, 815.3843847894842, 815.388458656008, 835.9205875441835, 15367.846321536781, 16004.0, 16270.186490675478, 16322.591935201626, 16381.83618163818, 14507.85492145081, 14838.109713417203, 14867.330970106344, 14869.0, 14932.328045237964, 671.9294474080212, 789.0491957191599, 796.6295672512281, 796.8446153000167, 799.5322736199302, 804.3565147881671, 804.806846356876, 809.3120847279824, 812.273015650992, 812.8252425728467, 857.8756080368343, 863.1282404771194, 865.4288169807928, 865.9913400865973, 867.488181972636, 852.228732996639, 853.91887770662, 854.7649396415973, 854.9700760473385, 860.7331727164599, 622.9719662615194, 624.1386886097157, 624.7657128576784, 624.9437550620421, 625.2653132569213, 14507.1295722257, 14556.0, 14571.562853114423, 14616.342264598119, 14643.41426342945, 14622.415103395851, 15189.316480758393, 15288.694226115414, 15321.92746507745, 15376.308066137051, 12307.92145570095, 12350.320732359716, 12367.058823529413, 12681.0, 12747.04397170216, 3939.2909276330247, 3960.386140148282, 3968.226195891802, 4048.4939382577177, 4125.834966601333, 67484.3251567483, 69012.3098769011, 69308.65345673289, 69420.0, 71136.28863711348, 11523.250988685708, 11569.30584164936, 11615.30308181495, 11776.646700598996, 11819.88180118205, 22039.779602203773, 22301.553968920532, 22395.44011399728, 22451.101955921906, 22889.88555057214, 8286.254237118688, 8439.240468357877, 8482.279006284412, 8575.656973721107, 8934.597943092576, 4745.549172828576, 4758.5241475852135, 4765.904681906342, 4817.78319975602, 4896.094222568836, 3490.197254631398, 3627.782333060025, 3636.7999760012926, 3636.818159092035, 3637.2907283079544, 645.1484041065748, 670.9765158219536, 675.4967549175896, 681.7613835157655, 683.565935630868, 732.6959311885614, 757.1519897714485, 768.8039549914736, 769.9615019249015, 795.3478147918651, 10234.33476824004, 10273.434961077213, 10354.585816567404, 10512.894871051192, 10593.046625803714, 638.8818068657313, 692.2177938929078, 781.6560713286136, 792.3344390711715, 806.5765473126655, 4951.90096198074, 4963.8262660806695, 5114.181730923109, 5147.176451767774, 5216.66091704038, 118324.0, 118812.40593796976, 118883.0, 119632.40183799199, 121492.39253803852, 104955.4752226234, 105945.0, 107273.34539891448, 108553.4572327149, 109253.45373273082, 82869.58565207256, 89784.5510772455, 91641.5417922906, 91984.08015919889, 93128.0, 8984.910150898408, 8986.32602554798, 9023.503707296162, 9050.592723327334, 9053.773655658399, 40579.391309129795, 41213.79393103015, 43075.0, 47930.281045785036, 54043.0, 71167.64416177887, 71921.40392980225, 72590.63704681443, 73197.0, 73392.0, 13086.280254586089, 13261.734765304833, 13307.334633268105, 13338.399772010476, 13390.464381424634, 13757.79363309531, 15086.698266034837, 15234.619134521725, 15260.160691162093, 15372.923135384252, 13434.39545220487, 13767.311634418038, 13988.440462381392, 14232.359543820347, 14628.0, 13576.524821631196, 13963.162210267417, 14129.434822606981, 14530.782038269223, 14666.41334346657, 12914.28971406544, 13030.4136313868, 13074.673133171365, 13352.112394680056, 13824.0, 11174.553017879194, 11366.545338186379, 11377.715557111138, 11386.259893106922, 11618.76762464763, 10745.570177192825, 10936.677688740529, 11026.469721415868, 11520.769584608093, 11636.53453861836], "value": 7682.458607231557, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 111.0, 111.0, 110.0, 111.0, 109.0, 109.0, 111.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 163.0, 179.0, 128.0, 157.0, 159.0, 129.0, 186.0, 127.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 160.0, 166.0, 172.0, 166.0, 161.0, 162.0, 161.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 77.0, 156.0, 77.0, 76.0, 75.0, 75.0, 172.0, 76.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 89.0, 156.0, 84.0, 85.0, 84.0, 147.0, 85.0, 85.0, 139.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 145.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 55.0, 57.0, 55.0, 55.0, 60.0, 55.0, 56.0, 55.0, 56.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 60.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 81.0, 81.0, 85.0, 81.0, 81.0, 108.0, 80.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 125.0, 132.0, 131.0, 128.0, 135.0, 131.0, 127.0, 151.0, 126.0], "value": 130.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 166.0, 164.0, 160.0, 168.0, 175.0, 160.0, 164.0, 163.0, 158.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 64.0, 69.0, 62.0, 63.0, 67.0, 62.0, 64.0, 67.0], "value": 64.9, "unit": "score"}]}]} 07:20:40 INFO - Return code: 0 07:20:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:20:40 ERROR - # TBPL SUCCESS # 07:20:40 INFO - Running post-action listener: _resource_record_post_action 07:20:40 INFO - ##### 07:20:40 INFO - ##### Finished run-tests step (success) 07:20:40 INFO - ##### 07:20:40 INFO - Running post-run listener: _resource_record_post_run 07:20:40 INFO - Total resource usage - Wall time: 1190s; CPU: 14.0%; Read bytes: 8192; Write bytes: 551038976; Read time: 220; Write time: 617108 07:20:40 INFO - TinderboxPrint: CPU usage
13.5% 07:20:40 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 220 07:20:40 INFO - TinderboxPrint: I/O write bytes / time
551,038,976 / 617,108 07:20:40 INFO - TinderboxPrint: CPU idle
8,209.5 (86.5%) 07:20:40 INFO - TinderboxPrint: CPU user
1,229.7 (13.0%) 07:20:40 INFO - TinderboxPrint: Swap in / out
0 / 0 07:20:40 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255901696; Read time: 0; Write time: 392836 07:20:40 INFO - run-tests - Wall time: 1174s; CPU: 14.0%; Read bytes: 8192; Write bytes: 295137280; Read time: 220; Write time: 224272 07:20:41 INFO - Running post-run listener: _upload_blobber_files 07:20:41 INFO - Blob upload gear active. 07:20:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:20:41 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 07:20:41 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:20:41 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:20:41 INFO - (blobuploader) - INFO - Open directory for files ... 07:20:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:20:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:20:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:42 INFO - (blobuploader) - INFO - Done attempting. 07:20:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:20:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:20:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:46 INFO - (blobuploader) - INFO - Done attempting. 07:20:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:20:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:20:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:47 INFO - (blobuploader) - INFO - Done attempting. 07:20:47 INFO - (blobuploader) - INFO - Iteration through files over. 07:20:47 INFO - Return code: 0 07:20:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:20:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:20:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79d4e9443498257cddac9bb8efb3e23e9a4692c5a182794b85ed1c3e32b524fcca3ecc811405849d7d55fcaa4af94eba0b6f53ce1865cbe4193ef6145c58b9e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85fc096ff69cf7a1d63896902afd20b13371b1793744fb9c8df79580a18a416f5cc54d146b47a7dd73028ccefe75db55f45eeb0dfd76ca9e2a4b8aa3e7ac4c60", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c586496710aab93342cbb09bda2a4f6c56d82dea0ad2c975d7811618f4d9b6f990819d361c5ed3bf61473c178fc36aca87f0b262daf5730d7b43b3b1b0e05bb7"} 07:20:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:20:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:20:47 INFO - Contents: 07:20:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79d4e9443498257cddac9bb8efb3e23e9a4692c5a182794b85ed1c3e32b524fcca3ecc811405849d7d55fcaa4af94eba0b6f53ce1865cbe4193ef6145c58b9e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85fc096ff69cf7a1d63896902afd20b13371b1793744fb9c8df79580a18a416f5cc54d146b47a7dd73028ccefe75db55f45eeb0dfd76ca9e2a4b8aa3e7ac4c60", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c586496710aab93342cbb09bda2a4f6c56d82dea0ad2c975d7811618f4d9b6f990819d361c5ed3bf61473c178fc36aca87f0b262daf5730d7b43b3b1b0e05bb7"} 07:20:47 INFO - Running post-run listener: copy_logs_to_upload_dir 07:20:47 INFO - Copying logs to upload dir... 07:20:47 INFO - mkdir: /builds/slave/test/build/upload/logs 07:20:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.875003 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-08 07:20:47.231739) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 07:20:47.235618) ========= 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=db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852 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/Firefox/sha512/79d4e9443498257cddac9bb8efb3e23e9a4692c5a182794b85ed1c3e32b524fcca3ecc811405849d7d55fcaa4af94eba0b6f53ce1865cbe4193ef6145c58b9e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85fc096ff69cf7a1d63896902afd20b13371b1793744fb9c8df79580a18a416f5cc54d146b47a7dd73028ccefe75db55f45eeb0dfd76ca9e2a4b8aa3e7ac4c60", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c586496710aab93342cbb09bda2a4f6c56d82dea0ad2c975d7811618f4d9b6f990819d361c5ed3bf61473c178fc36aca87f0b262daf5730d7b43b3b1b0e05bb7"} build_url:https://queue.taskcluster.net/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/dbbUxgYiRT6ExJwJ86wfAQ/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/Firefox/sha512/79d4e9443498257cddac9bb8efb3e23e9a4692c5a182794b85ed1c3e32b524fcca3ecc811405849d7d55fcaa4af94eba0b6f53ce1865cbe4193ef6145c58b9e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85fc096ff69cf7a1d63896902afd20b13371b1793744fb9c8df79580a18a416f5cc54d146b47a7dd73028ccefe75db55f45eeb0dfd76ca9e2a4b8aa3e7ac4c60", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c586496710aab93342cbb09bda2a4f6c56d82dea0ad2c975d7811618f4d9b6f990819d361c5ed3bf61473c178fc36aca87f0b262daf5730d7b43b3b1b0e05bb7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 07:20:47.260990) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 07:20:47.261324) ========= 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=db0483c52d987ecb441a263b000001ad-1465394412.14457-740916852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 07:20:47.343930) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 07:20:47.344278) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 07:20:47.344563) ========= ========= Total master_lag: 0.18 =========