builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1466770229.11 results: success (0) buildid: 20160624023004 builduid: 4cde38562f2748f18a7049080cbb6ee8 revision: 9f27664669366144c1756f0b416277c16ac96ac2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 05:10:29.107024) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 05:10:29.107530) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 05:10:29.107829) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 05:10:29.122782) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:10:29.123171) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 05:10:29-- 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% 223M=0s 2016-06-24 05:10:29 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082422 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:10:29.219221) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:10:29.219644) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017136 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:10:29.272192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:10:29.272585) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9f27664669366144c1756f0b416277c16ac96ac2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 9f27664669366144c1756f0b416277c16ac96ac2 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 05:10:30,091 truncating revision to first 12 chars 2016-06-24 05:10:30,091 Setting DEBUG logging. 2016-06-24 05:10:30,091 attempt 1/10 2016-06-24 05:10:30,091 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9f2766466936?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 05:10:30,396 unpacking tar archive at: fx-team-9f2766466936/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659888 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:10:29.945147) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 05:10:29.945470) ========= script_repo_revision: 9f27664669366144c1756f0b416277c16ac96ac2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 05:10:29.945860) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 05:10:29.946130) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 05:10:29.953503) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-24 05:10:29.953846) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:10:30 INFO - MultiFileLogger online at 20160624 05:10:30 in /builds/slave/test 05:10:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:10:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:10:30 INFO - {'append_to_log': False, 05:10:30 INFO - 'base_work_dir': '/builds/slave/test', 05:10:30 INFO - 'blob_upload_branch': 'Fx-Team', 05:10:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:10:30 INFO - 'branch': 'Fx-Team', 05:10:30 INFO - 'buildbot_json_path': 'buildprops.json', 05:10:30 INFO - 'config_files': ('talos/linux_config.py',), 05:10:30 INFO - 'default_actions': ('clobber', 05:10:30 INFO - 'read-buildbot-config', 05:10:30 INFO - 'download-and-extract', 05:10:30 INFO - 'populate-webroot', 05:10:30 INFO - 'create-virtualenv', 05:10:30 INFO - 'install', 05:10:30 INFO - 'run-tests'), 05:10:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:10:30 INFO - 'download_minidump_stackwalk': True, 05:10:30 INFO - 'download_symbols': 'ondemand', 05:10:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:10:30 INFO - 'tooltool.py': '/tools/tooltool.py', 05:10:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:10:30 INFO - '/tools/misc-python/virtualenv.py')}, 05:10:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:10:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:10:30 INFO - 'installer_path': 'installer.exe', 05:10:30 INFO - 'log_level': 'info', 05:10:30 INFO - 'log_name': 'talos', 05:10:30 INFO - 'log_to_console': True, 05:10:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:10:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:10:30 INFO - 'opt_config_files': (), 05:10:30 INFO - 'pip_index': False, 05:10:30 INFO - 'sps_profile': False, 05:10:30 INFO - 'sps_profile_interval': 0, 05:10:30 INFO - 'suite': 'dromaeojs-e10s', 05:10:30 INFO - 'system_bits': '32', 05:10:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:10:30 INFO - 'title': 'talos-linux64-ix-041', 05:10:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:10:30 INFO - 'use_talos_json': True, 05:10:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:10:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:10:30 INFO - 'work_dir': 'build'} 05:10:30 INFO - ##### 05:10:30 INFO - ##### Running clobber step. 05:10:30 INFO - ##### 05:10:30 INFO - Running pre-action listener: _resource_record_pre_action 05:10:30 INFO - Running main action method: clobber 05:10:30 INFO - rmtree: /builds/slave/test/build 05:10:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:10:31 INFO - Running post-action listener: _resource_record_post_action 05:10:31 INFO - ##### 05:10:31 INFO - ##### Finished clobber step (success) 05:10:31 INFO - ##### 05:10:31 INFO - ##### 05:10:31 INFO - ##### Running read-buildbot-config step. 05:10:31 INFO - ##### 05:10:31 INFO - Running pre-action listener: _resource_record_pre_action 05:10:31 INFO - Running main action method: read_buildbot_config 05:10:31 INFO - Using buildbot properties: 05:10:31 INFO - { 05:10:31 INFO - "project": "", 05:10:31 INFO - "product": "firefox", 05:10:31 INFO - "script_repo_revision": "production", 05:10:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:10:31 INFO - "repository": "", 05:10:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:10:31 INFO - "buildid": "20160624023004", 05:10:31 INFO - "pgo_build": "True", 05:10:31 INFO - "basedir": "/builds/slave/test", 05:10:31 INFO - "buildnumber": 568, 05:10:31 INFO - "slavename": "talos-linux64-ix-041", 05:10:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:10:31 INFO - "platform": "ubuntu64_hw", 05:10:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:10:31 INFO - "branch": "fx-team", 05:10:31 INFO - "repo_path": "integration/fx-team", 05:10:31 INFO - "revision": "9f27664669366144c1756f0b416277c16ac96ac2", 05:10:31 INFO - "stage_platform": "linux64-pgo", 05:10:31 INFO - "builduid": "4cde38562f2748f18a7049080cbb6ee8", 05:10:31 INFO - "slavebuilddir": "test" 05:10:31 INFO - } 05:10:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:10:31 INFO - Running post-action listener: _resource_record_post_action 05:10:31 INFO - ##### 05:10:31 INFO - ##### Finished read-buildbot-config step (success) 05:10:31 INFO - ##### 05:10:31 INFO - ##### 05:10:31 INFO - ##### Running download-and-extract step. 05:10:31 INFO - ##### 05:10:31 INFO - Running pre-action listener: _resource_record_pre_action 05:10:31 INFO - Running main action method: download_and_extract 05:10:31 INFO - mkdir: /builds/slave/test/build/tests 05:10: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')]} 05:10:31 INFO - https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:10:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:10:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:10:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:10:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:10:38 INFO - Downloaded 1361 bytes. 05:10:38 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:10:38 INFO - Using the following test package requirements: 05:10:38 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:10:38 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:10:38 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:10:38 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:38 INFO - u'jsshell-linux-x86_64.zip'], 05:10:38 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:10:38 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:10:38 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:10:38 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:10:38 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:10:38 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:10:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:38 INFO - https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:10:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:10:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:10:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:10:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:10:42 INFO - Downloaded 24277318 bytes. 05:10:42 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'] 05:10:42 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 05:10:43 INFO - Return code: 0 05:10:43 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 05:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:43 INFO - https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:10:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:10:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:10:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:10:47 INFO - Downloaded 24277318 bytes. 05:10:47 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'] 05:10:47 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 05:10:48 INFO - Return code: 0 05:10:48 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')]} 05:10:48 INFO - https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:10:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:10:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:10:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:10:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:10:49 INFO - Downloaded 14405518 bytes. 05:10:49 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'] 05:10:49 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 05:10:49 INFO - Return code: 0 05:10:49 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')]} 05:10:49 INFO - https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:10:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:10:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:10:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:10:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/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 05:10:53 INFO - Downloaded 60165888 bytes. 05:10:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:10:53 INFO - mkdir: /builds/slave/test/properties 05:10:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:10:53 INFO - Writing to file /builds/slave/test/properties/build_url 05:10:53 INFO - Contents: 05:10:53 INFO - build_url:https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:10:54 INFO - Running post-action listener: _resource_record_post_action 05:10:54 INFO - Running post-action listener: set_extra_try_arguments 05:10:54 INFO - ##### 05:10:54 INFO - ##### Finished download-and-extract step (success) 05:10:54 INFO - ##### 05:10:54 INFO - ##### 05:10:54 INFO - ##### Running populate-webroot step. 05:10:54 INFO - ##### 05:10:54 INFO - Running pre-action listener: _resource_record_pre_action 05:10:54 INFO - Running main action method: populate_webroot 05:10:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:10:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:10:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:10:54 INFO - '--tppagecycles', 05:10:54 INFO - '7'], 05:10:54 INFO - 'tests': ['tsvgm']}}, 05:10:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:10:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:10:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:10:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:10:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:10:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:10:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:54 INFO - 'talos_options': ['--disable-e10s'], 05:10:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:54 INFO - 'talos_options': ['--disable-e10s'], 05:10:54 INFO - 'tests': ['damp', 'tps']}, 05:10:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:54 INFO - 'tests': ['damp', 'tps']}, 05:10:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:10:54 INFO - 'tests': ['dromaeo_dom']}, 05:10:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:10:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:10:54 INFO - 'tests': ['basic_compositor_video']}, 05:10:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:10:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:10:54 INFO - 'tests': ['a11yr', 05:10:54 INFO - 'ts_paint', 05:10:54 INFO - 'tpaint', 05:10:54 INFO - 'sessionrestore', 05:10:54 INFO - 'sessionrestore_no_auto_restore', 05:10:54 INFO - 'tabpaint']}, 05:10:54 INFO - 'other-e10s': {'tests': ['a11yr', 05:10:54 INFO - 'ts_paint', 05:10:54 INFO - 'tpaint', 05:10:54 INFO - 'sessionrestore', 05:10:54 INFO - 'sessionrestore_no_auto_restore', 05:10:54 INFO - 'tabpaint']}, 05:10:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:10:54 INFO - 'ts_paint', 05:10:54 INFO - 'tpaint', 05:10:54 INFO - 'sessionrestore', 05:10:54 INFO - 'sessionrestore_no_auto_restore', 05:10:54 INFO - 'tabpaint']}, 05:10:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:10:54 INFO - 'ts_paint', 05:10:54 INFO - 'tpaint', 05:10:54 INFO - 'sessionrestore', 05:10:54 INFO - 'sessionrestore_no_auto_restore', 05:10:54 INFO - 'tabpaint']}, 05:10:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:10:54 INFO - 'tests': ['a11yr', 05:10:54 INFO - 'ts_paint', 05:10:54 INFO - 'tpaint', 05:10:54 INFO - 'sessionrestore', 05:10:54 INFO - 'sessionrestore_no_auto_restore', 05:10:54 INFO - 'tabpaint']}, 05:10:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:10:54 INFO - 'tests': ['a11yr', 05:10:54 INFO - 'ts_paint', 05:10:54 INFO - 'tpaint', 05:10:54 INFO - 'sessionrestore', 05:10:54 INFO - 'sessionrestore_no_auto_restore', 05:10:54 INFO - 'tabpaint']}, 05:10:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:10:54 INFO - 'tests': ['tsvgx', 05:10:54 INFO - 'tsvgr_opacity', 05:10:54 INFO - 'tart', 05:10:54 INFO - 'tscrollx', 05:10:54 INFO - 'cart']}, 05:10:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:10:54 INFO - 'tsvgr_opacity', 05:10:54 INFO - 'tart', 05:10:54 INFO - 'tscrollx', 05:10:54 INFO - 'cart']}, 05:10:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:54 INFO - 'talos_options': ['--disable-e10s'], 05:10:54 INFO - 'tests': ['tp5o']}, 05:10:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:54 INFO - 'tests': ['tp5o']}, 05:10:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:54 INFO - 'talos_options': ['--disable-e10s', 05:10:54 INFO - '--xperf_path', 05:10:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:54 INFO - 'tests': ['tp5n']}, 05:10:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:54 INFO - 'talos_options': ['--xperf_path', 05:10:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:54 INFO - 'tests': ['tp5n']}}, 05:10:54 INFO - 'talos.zip': {'path': '', 05:10:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:10:54 INFO - Running post-action listener: _resource_record_post_action 05:10:54 INFO - ##### 05:10:54 INFO - ##### Finished populate-webroot step (success) 05:10:54 INFO - ##### 05:10:54 INFO - ##### 05:10:54 INFO - ##### Running create-virtualenv step. 05:10:54 INFO - ##### 05:10:54 INFO - Running pre-action listener: _resource_record_pre_action 05:10:54 INFO - Running main action method: create_virtualenv 05:10:54 INFO - Creating virtualenv /builds/slave/test/build/venv 05:10:54 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 05:10:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:10:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:10:54 INFO - Using real prefix '/usr' 05:10:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:10:54 INFO - Installing distribute.............................................................................................................................................................................................done. 05:10:56 INFO - Installing pip.................done. 05:10:56 INFO - Return code: 0 05:10:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:10:56 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')]} 05:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:56 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')]} 05:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:56 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 0x7f9d0246bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e44a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e41d00>, '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 0x1e42ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e42f60>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', '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 05:10:56 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 05:10:56 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 05:10:56 INFO - Using env: {'DISPLAY': ':0', 05:10:56 INFO - 'HOME': '/home/cltbld', 05:10:56 INFO - 'LANG': 'en_US.UTF-8', 05:10:56 INFO - 'LANGUAGE': 'en_US:en', 05:10:56 INFO - 'LOGNAME': 'cltbld', 05:10:56 INFO - 'MAIL': '/var/mail/cltbld', 05:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:56 INFO - 'MOZ_NO_REMOTE': '1', 05:10:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:56 INFO - 'NO_EM_RESTART': '1', 05:10:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:56 INFO - 'PWD': '/builds/slave/test', 05:10:56 INFO - 'SHELL': '/bin/bash', 05:10:56 INFO - 'SHLVL': '1', 05:10:56 INFO - 'TERM': 'linux', 05:10:56 INFO - 'TMOUT': '86400', 05:10:56 INFO - 'USER': 'cltbld', 05:10:56 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', 05:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:56 INFO - '_': '/tools/buildbot/bin/python'} 05:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:57 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 05:10:57 INFO - Cleaning up... 05:10:57 INFO - Return code: 0 05:10:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9d0246bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e44a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e41d00>, '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 0x1e42ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e42f60>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', '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 05:10:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:10:57 INFO - Using env: {'DISPLAY': ':0', 05:10:57 INFO - 'HOME': '/home/cltbld', 05:10:57 INFO - 'LANG': 'en_US.UTF-8', 05:10:57 INFO - 'LANGUAGE': 'en_US:en', 05:10:57 INFO - 'LOGNAME': 'cltbld', 05:10:57 INFO - 'MAIL': '/var/mail/cltbld', 05:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:57 INFO - 'MOZ_NO_REMOTE': '1', 05:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:57 INFO - 'NO_EM_RESTART': '1', 05:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:57 INFO - 'PWD': '/builds/slave/test', 05:10:57 INFO - 'SHELL': '/bin/bash', 05:10:57 INFO - 'SHLVL': '1', 05:10:57 INFO - 'TERM': 'linux', 05:10:57 INFO - 'TMOUT': '86400', 05:10:57 INFO - 'USER': 'cltbld', 05:10:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', 05:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:57 INFO - '_': '/tools/buildbot/bin/python'} 05:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:57 INFO - Downloading/unpacking psutil>=3.1.1 05:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:10:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:59 INFO - Installing collected packages: psutil 05:10:59 INFO - Running setup.py install for psutil 05:10:59 INFO - building 'psutil._psutil_linux' extension 05:10:59 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 05:10:59 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 05:10:59 INFO - building 'psutil._psutil_posix' extension 05:10:59 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 05:10:59 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 05:10:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:59 INFO - Successfully installed psutil 05:10:59 INFO - Cleaning up... 05:10:59 INFO - Return code: 0 05:10:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:59 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 0x7f9d0246bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e44a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e41d00>, '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 0x1e42ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e42f60>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', '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 05:10:59 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 05:10:59 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 05:10:59 INFO - Using env: {'DISPLAY': ':0', 05:10:59 INFO - 'HOME': '/home/cltbld', 05:10:59 INFO - 'LANG': 'en_US.UTF-8', 05:10:59 INFO - 'LANGUAGE': 'en_US:en', 05:10:59 INFO - 'LOGNAME': 'cltbld', 05:10:59 INFO - 'MAIL': '/var/mail/cltbld', 05:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:59 INFO - 'MOZ_NO_REMOTE': '1', 05:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:59 INFO - 'NO_EM_RESTART': '1', 05:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:59 INFO - 'PWD': '/builds/slave/test', 05:10:59 INFO - 'SHELL': '/bin/bash', 05:10:59 INFO - 'SHLVL': '1', 05:10:59 INFO - 'TERM': 'linux', 05:10:59 INFO - 'TMOUT': '86400', 05:10:59 INFO - 'USER': 'cltbld', 05:10:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', 05:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:59 INFO - '_': '/tools/buildbot/bin/python'} 05:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:11:01 INFO - Installing collected packages: mozsystemmonitor 05:11:01 INFO - Running setup.py install for mozsystemmonitor 05:11:02 INFO - Successfully installed mozsystemmonitor 05:11:02 INFO - Cleaning up... 05:11:02 INFO - Return code: 0 05:11:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:11:02 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')]} 05:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:02 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')]} 05:11:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:02 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 0x7f9d0246bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e44a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e41d00>, '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 0x1e42ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e42f60>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', '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 05:11:02 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 05:11:02 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 05:11:02 INFO - Using env: {'DISPLAY': ':0', 05:11:02 INFO - 'HOME': '/home/cltbld', 05:11:02 INFO - 'LANG': 'en_US.UTF-8', 05:11:02 INFO - 'LANGUAGE': 'en_US:en', 05:11:02 INFO - 'LOGNAME': 'cltbld', 05:11:02 INFO - 'MAIL': '/var/mail/cltbld', 05:11:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:02 INFO - 'MOZ_NO_REMOTE': '1', 05:11:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:02 INFO - 'NO_EM_RESTART': '1', 05:11:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:02 INFO - 'PWD': '/builds/slave/test', 05:11:02 INFO - 'SHELL': '/bin/bash', 05:11:02 INFO - 'SHLVL': '1', 05:11:02 INFO - 'TERM': 'linux', 05:11:02 INFO - 'TMOUT': '86400', 05:11:02 INFO - 'USER': 'cltbld', 05:11:02 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', 05:11:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:02 INFO - '_': '/tools/buildbot/bin/python'} 05:11:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:02 INFO - Downloading/unpacking jsonschema==2.5.1 05:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:11:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:11:04 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 05:11:04 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 05:11:04 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 05:11:04 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 05:11:04 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 05:11:04 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 05:11:04 INFO - Downloading functools32-3.2.3-2.tar.gz 05:11:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:11:04 INFO - warning: no files found matching '*.txt' 05:11:04 INFO - no previously-included directories found matching 'build' 05:11:04 INFO - no previously-included directories found matching 'dist' 05:11:04 INFO - no previously-included directories found matching '.git*' 05:11:04 INFO - Installing collected packages: jsonschema, functools32 05:11:04 INFO - Running setup.py install for functools32 05:11:04 INFO - warning: no files found matching '*.txt' 05:11:04 INFO - no previously-included directories found matching 'build' 05:11:04 INFO - no previously-included directories found matching 'dist' 05:11:04 INFO - no previously-included directories found matching '.git*' 05:11:04 INFO - Successfully installed jsonschema functools32 05:11:04 INFO - Cleaning up... 05:11:04 INFO - Return code: 0 05:11:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:11:04 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')]} 05:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:04 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')]} 05:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:04 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 0x7f9d0246bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e44a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e41d00>, '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 0x1e42ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e42f60>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', '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 05:11:04 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 05:11:04 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 05:11:04 INFO - Using env: {'DISPLAY': ':0', 05:11:04 INFO - 'HOME': '/home/cltbld', 05:11:04 INFO - 'LANG': 'en_US.UTF-8', 05:11:04 INFO - 'LANGUAGE': 'en_US:en', 05:11:04 INFO - 'LOGNAME': 'cltbld', 05:11:04 INFO - 'MAIL': '/var/mail/cltbld', 05:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:04 INFO - 'MOZ_NO_REMOTE': '1', 05:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:04 INFO - 'NO_EM_RESTART': '1', 05:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:04 INFO - 'PWD': '/builds/slave/test', 05:11:04 INFO - 'SHELL': '/bin/bash', 05:11:04 INFO - 'SHLVL': '1', 05:11:04 INFO - 'TERM': 'linux', 05:11:04 INFO - 'TMOUT': '86400', 05:11:04 INFO - 'USER': 'cltbld', 05:11:04 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', 05:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:04 INFO - '_': '/tools/buildbot/bin/python'} 05:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:04 INFO - Downloading/unpacking blobuploader==1.2.4 05:11:04 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 05:11:04 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 05:11:04 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 05:11:04 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 05:11:04 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 05:11:04 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 05:11:06 INFO - Downloading blobuploader-1.2.4.tar.gz 05:11:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:11:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:11:06 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 05:11:06 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 05:11:06 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 05:11:06 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 05:11:06 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 05:11:06 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 05:11:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:11:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:11:07 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 05:11:07 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 05:11:07 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 05:11:07 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 05:11:07 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 05:11:07 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 05:11:07 INFO - Downloading docopt-0.6.1.tar.gz 05:11:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:11:07 INFO - Installing collected packages: blobuploader, requests, docopt 05:11:07 INFO - Running setup.py install for blobuploader 05:11:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:11:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:11:07 INFO - Running setup.py install for requests 05:11:08 INFO - Running setup.py install for docopt 05:11:08 INFO - Successfully installed blobuploader requests docopt 05:11:08 INFO - Cleaning up... 05:11:08 INFO - Return code: 0 05:11:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:08 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 0x7f9d0246bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e44a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e41d00>, '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 0x1e42ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e42f60>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', '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 05:11:08 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 05:11:08 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 05:11:08 INFO - Using env: {'DISPLAY': ':0', 05:11:08 INFO - 'HOME': '/home/cltbld', 05:11:08 INFO - 'LANG': 'en_US.UTF-8', 05:11:08 INFO - 'LANGUAGE': 'en_US:en', 05:11:08 INFO - 'LOGNAME': 'cltbld', 05:11:08 INFO - 'MAIL': '/var/mail/cltbld', 05:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:08 INFO - 'MOZ_NO_REMOTE': '1', 05:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:08 INFO - 'NO_EM_RESTART': '1', 05:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:08 INFO - 'PWD': '/builds/slave/test', 05:11:08 INFO - 'SHELL': '/bin/bash', 05:11:08 INFO - 'SHLVL': '1', 05:11:08 INFO - 'TERM': 'linux', 05:11:08 INFO - 'TMOUT': '86400', 05:11:08 INFO - 'USER': 'cltbld', 05:11:08 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', 05:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:08 INFO - '_': '/tools/buildbot/bin/python'} 05:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:08 INFO - Running setup.py (path:/tmp/pip-3YXVmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:08 INFO - Running setup.py (path:/tmp/pip-uO9fYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:08 INFO - Running setup.py (path:/tmp/pip-D4aUFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:08 INFO - Running setup.py (path:/tmp/pip-YW3loy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:08 INFO - Running setup.py (path:/tmp/pip-43WAYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:08 INFO - Running setup.py (path:/tmp/pip-fah6s1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:08 INFO - Running setup.py (path:/tmp/pip-MaliNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:08 INFO - Running setup.py (path:/tmp/pip-ZXTkyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:09 INFO - Running setup.py (path:/tmp/pip-vRxsrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:09 INFO - Running setup.py (path:/tmp/pip-mbiv0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:09 INFO - Running setup.py (path:/tmp/pip-TqdfRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:09 INFO - Running setup.py (path:/tmp/pip-vIX1zG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:09 INFO - Running setup.py (path:/tmp/pip-vjGLub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:09 INFO - Running setup.py (path:/tmp/pip-JQek8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:09 INFO - Running setup.py (path:/tmp/pip-NI8Vfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:09 INFO - Running setup.py (path:/tmp/pip-Jic6xV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:09 INFO - Running setup.py (path:/tmp/pip-er2rzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:11:09 INFO - Running setup.py install for manifestparser 05:11:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:11:09 INFO - Running setup.py install for mozcrash 05:11:09 INFO - Running setup.py install for mozdebug 05:11:10 INFO - Running setup.py install for mozdevice 05:11:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:11:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:11:10 INFO - Running setup.py install for mozfile 05:11:10 INFO - Running setup.py install for mozhttpd 05:11:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:11:10 INFO - Running setup.py install for mozinfo 05:11:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:11:10 INFO - Running setup.py install for mozInstall 05:11:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:11:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:11:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:11:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:11:10 INFO - Running setup.py install for mozleak 05:11:10 INFO - Running setup.py install for mozlog 05:11:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:11:10 INFO - Running setup.py install for moznetwork 05:11:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:11:10 INFO - Running setup.py install for mozprocess 05:11:11 INFO - Running setup.py install for mozprofile 05:11:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:11:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:11:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:11:11 INFO - Running setup.py install for mozrunner 05:11:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:11:11 INFO - Running setup.py install for mozscreenshot 05:11:11 INFO - Running setup.py install for moztest 05:11:11 INFO - Running setup.py install for mozversion 05:11:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:11:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:11:11 INFO - Cleaning up... 05:11:11 INFO - Return code: 0 05:11:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:11 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')]} 05:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:11 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')]} 05:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:11 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 0x7f9d0246bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e44a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e41d00>, '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 0x1e42ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e42f60>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', '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 05:11:11 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 05:11:11 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 05:11:11 INFO - Using env: {'DISPLAY': ':0', 05:11:11 INFO - 'HOME': '/home/cltbld', 05:11:11 INFO - 'LANG': 'en_US.UTF-8', 05:11:11 INFO - 'LANGUAGE': 'en_US:en', 05:11:11 INFO - 'LOGNAME': 'cltbld', 05:11:11 INFO - 'MAIL': '/var/mail/cltbld', 05:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:11 INFO - 'MOZ_NO_REMOTE': '1', 05:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:11 INFO - 'NO_EM_RESTART': '1', 05:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:11 INFO - 'PWD': '/builds/slave/test', 05:11:11 INFO - 'SHELL': '/bin/bash', 05:11:11 INFO - 'SHLVL': '1', 05:11:11 INFO - 'TERM': 'linux', 05:11:11 INFO - 'TMOUT': '86400', 05:11:11 INFO - 'USER': 'cltbld', 05:11:11 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', 05:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:11 INFO - '_': '/tools/buildbot/bin/python'} 05:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:11 INFO - Running setup.py (path:/tmp/pip-af3mE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:11 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)) 05:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:11 INFO - Running setup.py (path:/tmp/pip-jw19BE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:11 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)) 05:11:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:11 INFO - Running setup.py (path:/tmp/pip-M6p6ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:12 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)) 05:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:12 INFO - Running setup.py (path:/tmp/pip-AdEjR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:12 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)) 05:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:12 INFO - Running setup.py (path:/tmp/pip-fNmuyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:12 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)) 05:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:12 INFO - Running setup.py (path:/tmp/pip-enjhmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:12 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)) 05:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:12 INFO - Running setup.py (path:/tmp/pip-OQQ2Pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:12 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)) 05:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:12 INFO - Running setup.py (path:/tmp/pip-Gw94Fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:12 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)) 05:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:12 INFO - Running setup.py (path:/tmp/pip-k6DmSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:12 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)) 05:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:12 INFO - Running setup.py (path:/tmp/pip-YxdA_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:12 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)) 05:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:12 INFO - Running setup.py (path:/tmp/pip-G4Jc_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:12 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)) 05:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:12 INFO - Running setup.py (path:/tmp/pip-nbwYZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:12 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)) 05:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:12 INFO - Running setup.py (path:/tmp/pip-JufRC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:12 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)) 05:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:12 INFO - Running setup.py (path:/tmp/pip-bWfOD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:12 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)) 05:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:12 INFO - Running setup.py (path:/tmp/pip-bE7dqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:12 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)) 05:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:12 INFO - Running setup.py (path:/tmp/pip-XuXstN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:12 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)) 05:11:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:12 INFO - Running setup.py (path:/tmp/pip-SXjErn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:13 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)) 05:11:13 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)) 05:11:13 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)) 05:11:13 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)) 05:11:13 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)) 05:11:13 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)) 05:11:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:11:13 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 05:11:13 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 05:11:13 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 05:11:13 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 05:11:13 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 05:11:13 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 05:11:14 INFO - Downloading blessings-1.6.tar.gz 05:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:11:14 INFO - Installing collected packages: blessings 05:11:14 INFO - Running setup.py install for blessings 05:11:15 INFO - Successfully installed blessings 05:11:15 INFO - Cleaning up... 05:11:15 INFO - Return code: 0 05:11:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:11:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:15 INFO - Reading from file tmpfile_stdout 05:11:15 INFO - Current package versions: 05:11:15 INFO - argparse == 1.2.1 05:11:15 INFO - blessings == 1.6 05:11:15 INFO - blobuploader == 1.2.4 05:11:15 INFO - docopt == 0.6.1 05:11:15 INFO - functools32 == 3.2.3-2 05:11:15 INFO - jsonschema == 2.5.1 05:11:15 INFO - manifestparser == 1.1 05:11:15 INFO - mozInstall == 1.12 05:11:15 INFO - mozcrash == 0.17 05:11:15 INFO - mozdebug == 0.1 05:11:15 INFO - mozdevice == 0.48 05:11:15 INFO - mozfile == 1.2 05:11:15 INFO - mozhttpd == 0.7 05:11:15 INFO - mozinfo == 0.9 05:11:15 INFO - mozleak == 0.1 05:11:15 INFO - mozlog == 3.2 05:11:15 INFO - moznetwork == 0.27 05:11:15 INFO - mozprocess == 0.22 05:11:15 INFO - mozprofile == 0.28 05:11:15 INFO - mozrunner == 6.11 05:11:15 INFO - mozscreenshot == 0.1 05:11:15 INFO - mozsystemmonitor == 0.3 05:11:15 INFO - moztest == 0.7 05:11:15 INFO - mozversion == 1.4 05:11:15 INFO - psutil == 3.1.1 05:11:15 INFO - requests == 1.2.3 05:11:15 INFO - wsgiref == 0.1.2 05:11:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:15 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 0x7f9d0246bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e44a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e41d00>, '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 0x1e42ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e42f60>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', '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 05:11:15 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 05:11:15 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 05:11:15 INFO - Using env: {'DISPLAY': ':0', 05:11:15 INFO - 'HOME': '/home/cltbld', 05:11:15 INFO - 'LANG': 'en_US.UTF-8', 05:11:15 INFO - 'LANGUAGE': 'en_US:en', 05:11:15 INFO - 'LOGNAME': 'cltbld', 05:11:15 INFO - 'MAIL': '/var/mail/cltbld', 05:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:15 INFO - 'MOZ_NO_REMOTE': '1', 05:11:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:15 INFO - 'NO_EM_RESTART': '1', 05:11:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:15 INFO - 'PWD': '/builds/slave/test', 05:11:15 INFO - 'SHELL': '/bin/bash', 05:11:15 INFO - 'SHLVL': '1', 05:11:15 INFO - 'TERM': 'linux', 05:11:15 INFO - 'TMOUT': '86400', 05:11:15 INFO - 'USER': 'cltbld', 05:11:15 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', 05:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:15 INFO - '_': '/tools/buildbot/bin/python'} 05:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:15 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)) 05:11:15 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)) 05:11:15 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)) 05:11:15 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)) 05:11:15 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)) 05:11:15 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)) 05:11:15 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)) 05:11:15 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)) 05:11:15 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)) 05:11:15 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)) 05:11:15 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)) 05:11:15 INFO - Cleaning up... 05:11:15 INFO - Return code: 0 05:11:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:15 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 0x7f9d0246bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e44a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e41d00>, '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 0x1e42ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e42f60>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', '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 05:11:15 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 05:11:15 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 05:11:15 INFO - Using env: {'DISPLAY': ':0', 05:11:15 INFO - 'HOME': '/home/cltbld', 05:11:15 INFO - 'LANG': 'en_US.UTF-8', 05:11:15 INFO - 'LANGUAGE': 'en_US:en', 05:11:15 INFO - 'LOGNAME': 'cltbld', 05:11:15 INFO - 'MAIL': '/var/mail/cltbld', 05:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:15 INFO - 'MOZ_NO_REMOTE': '1', 05:11:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:15 INFO - 'NO_EM_RESTART': '1', 05:11:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:15 INFO - 'PWD': '/builds/slave/test', 05:11:15 INFO - 'SHELL': '/bin/bash', 05:11:15 INFO - 'SHLVL': '1', 05:11:15 INFO - 'TERM': 'linux', 05:11:15 INFO - 'TMOUT': '86400', 05:11:15 INFO - 'USER': 'cltbld', 05:11:15 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', 05:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:15 INFO - '_': '/tools/buildbot/bin/python'} 05:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:11:15 INFO - Cleaning up... 05:11:15 INFO - Return code: 0 05:11:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:15 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 0x7f9d0246bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e44a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e41d00>, '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 0x1e42ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e42f60>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', '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 05:11:15 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 05:11:15 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 05:11:15 INFO - Using env: {'DISPLAY': ':0', 05:11:15 INFO - 'HOME': '/home/cltbld', 05:11:15 INFO - 'LANG': 'en_US.UTF-8', 05:11:15 INFO - 'LANGUAGE': 'en_US:en', 05:11:15 INFO - 'LOGNAME': 'cltbld', 05:11:15 INFO - 'MAIL': '/var/mail/cltbld', 05:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:15 INFO - 'MOZ_NO_REMOTE': '1', 05:11:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:15 INFO - 'NO_EM_RESTART': '1', 05:11:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:15 INFO - 'PWD': '/builds/slave/test', 05:11:15 INFO - 'SHELL': '/bin/bash', 05:11:15 INFO - 'SHLVL': '1', 05:11:15 INFO - 'TERM': 'linux', 05:11:15 INFO - 'TMOUT': '86400', 05:11:15 INFO - 'USER': 'cltbld', 05:11:15 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', 05:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:15 INFO - '_': '/tools/buildbot/bin/python'} 05:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:16 INFO - Downloading/unpacking flake8 05:11:16 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 05:11:16 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 05:11:16 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 05:11:16 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 05:11:16 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 05:11:16 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 05:11:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:11:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:11:17 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 05:11:17 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 05:11:17 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 05:11:17 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 05:11:17 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 05:11:17 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 05:11:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:11:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:11:18 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 05:11:18 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 05:11:18 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 05:11:18 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 05:11:18 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 05:11:18 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 05:11:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:11:18 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 05:11:18 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 05:11:18 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 05:11:18 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 05:11:18 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 05:11:18 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 05:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:11:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:11:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:11:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:11:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:11:18 INFO - no previously-included directories found matching 'docs/_build' 05:11:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:11:18 INFO - Running setup.py install for pep8 05:11:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:11:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:11:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:11:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:11:18 INFO - no previously-included directories found matching 'docs/_build' 05:11:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:11:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:11:18 INFO - Cleaning up... 05:11:18 INFO - Return code: 0 05:11:18 INFO - Running post-action listener: _resource_record_post_action 05:11:18 INFO - Running post-action listener: _start_resource_monitoring 05:11:18 INFO - Starting resource monitoring. 05:11:18 INFO - ##### 05:11:18 INFO - ##### Finished create-virtualenv step (success) 05:11:18 INFO - ##### 05:11:18 INFO - ##### 05:11:18 INFO - ##### Running install step. 05:11:18 INFO - ##### 05:11:18 INFO - Running pre-action listener: _resource_record_pre_action 05:11:18 INFO - Running main action method: install 05:11:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:19 INFO - Reading from file tmpfile_stdout 05:11:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:11:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:11:19 INFO - Reading from file tmpfile_stdout 05:11:19 INFO - Output received: 05:11:19 INFO - Usage: mozinstall [options] installer 05:11:19 INFO - Options: 05:11:19 INFO - -h, --help show this help message and exit 05:11:19 INFO - -d DEST, --destination=DEST 05:11:19 INFO - Directory to install application into. [default: 05:11:19 INFO - "/builds/slave/test"] 05:11:19 INFO - --app=APP Application being installed. [default: firefox] 05:11:19 INFO - mkdir: /builds/slave/test/build/application 05:11:19 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'] 05:11:19 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 05:11:36 INFO - Reading from file tmpfile_stdout 05:11:36 INFO - Output received: 05:11:36 INFO - /builds/slave/test/build/application/firefox/firefox 05:11:36 INFO - Running post-action listener: _resource_record_post_action 05:11:36 INFO - ##### 05:11:36 INFO - ##### Finished install step (success) 05:11:36 INFO - ##### 05:11:36 INFO - ##### 05:11:36 INFO - ##### Running run-tests step. 05:11:36 INFO - ##### 05:11:36 INFO - Running pre-action listener: _resource_record_pre_action 05:11:36 INFO - Running main action method: run_tests 05:11:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:11:36 INFO - Python 2.7.3 05:11:36 INFO - Return code: 0 05:11:36 INFO - grabbing minidump binary from tooltool 05:11: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')]} 05:11:36 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 0x1e41d00>, '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 0x1e42ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e42f60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:11:36 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 05:11:36 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 05:11:36 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 05:11:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:11:36 INFO - Return code: 0 05:11:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:11:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:11:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:11:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:11:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:11:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:11:37 INFO - Return code: 0 05:11:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 05:11:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 05:11:37 INFO - Using env: {'DISPLAY': ':0', 05:11:37 INFO - 'HOME': '/home/cltbld', 05:11:37 INFO - 'LANG': 'en_US.UTF-8', 05:11:37 INFO - 'LANGUAGE': 'en_US:en', 05:11:37 INFO - 'LOGNAME': 'cltbld', 05:11:37 INFO - 'MAIL': '/var/mail/cltbld', 05:11:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:11:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:37 INFO - 'MOZ_NO_REMOTE': '1', 05:11:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:37 INFO - 'NO_EM_RESTART': '1', 05:11:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:37 INFO - 'PWD': '/builds/slave/test', 05:11:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:11:37 INFO - 'SHELL': '/bin/bash', 05:11:37 INFO - 'SHLVL': '1', 05:11:37 INFO - 'TERM': 'linux', 05:11:37 INFO - 'TMOUT': '86400', 05:11:37 INFO - 'USER': 'cltbld', 05:11:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846', 05:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:37 INFO - '_': '/tools/buildbot/bin/python'} 05:11:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 05:11:37 INFO - mozversion application_buildid: 20160624023004 05:11:37 INFO - mozversion application_changeset: 9f27664669366144c1756f0b416277c16ac96ac2 05:11:37 INFO - mozversion application_display_name: Nightly 05:11:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:11:37 INFO - mozversion application_name: Firefox 05:11:37 INFO - mozversion application_remotingname: firefox 05:11:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:11:37 INFO - mozversion application_vendor: Mozilla 05:11:37 INFO - mozversion application_version: 50.0a1 05:11:37 INFO - mozversion platform_buildid: 20160624023004 05:11:37 INFO - mozversion platform_changeset: 9f27664669366144c1756f0b416277c16ac96ac2 05:11:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:11:37 INFO - mozversion platform_version: 50.0a1 05:11:37 INFO - using testdate: 1466770297 05:11:37 INFO - actual date: 1466770297 05:11:37 INFO - starting webserver on 'localhost:34128' 05:11:37 INFO - SUITE-START | Running 2 tests 05:11:37 INFO - TEST-START | dromaeo_css 05:11:37 INFO - operating with platform_type : linux_ 05:11:37 INFO - Initialising browser for dromaeo_css test... 05:11:37 INFO - TEST-INFO | started process 10425 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdBL6VT/profile http://localhost:34128/getInfo.html) 05:11:42 INFO - PROCESS | 10425 | __metrics Screen width/height:1600/1200 05:11:42 INFO - PROCESS | 10425 | colorDepth:24 05:11:42 INFO - PROCESS | 10425 | Browser inner width/height: 1024/697 05:11:42 INFO - PROCESS | 10425 | __metrics 05:11:43 ERROR - PROCESS | 10425 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:11:44 INFO - TEST-INFO | 10425: exit 0 05:11:44 INFO - Browser initialized. 05:11:44 INFO - Running cycle 1/1 for dromaeo_css test... 05:11:44 INFO - TEST-INFO | started process 10546 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdBL6VT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:56 INFO - PROCESS | 10546 | RSS: Main: 184578048 05:11:56 INFO - PROCESS | 10546 | 05:12:46 INFO - PROCESS | 10546 | 1466770366091 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] 05:14:55 INFO - PROCESS | 10546 | Cycle 1(1): loaded http://localhost:34128/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34128/tests/dromaeo/cssquery-ext.html) 05:14:56 INFO - PROCESS | 10546 | RSS: Main: 188514304 05:14:56 INFO - PROCESS | 10546 | 05:17:58 INFO - PROCESS | 10546 | Cycle 1(1): loaded http://localhost:34128/tests/dromaeo/cssquery-ext.html (next: http://localhost:34128/tests/dromaeo/cssquery-jquery.html) 05:17:58 INFO - PROCESS | 10546 | RSS: Main: 187691008 05:17:58 INFO - PROCESS | 10546 | 05:21:00 INFO - PROCESS | 10546 | Cycle 1(1): loaded http://localhost:34128/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34128/tests/dromaeo/cssquery-mootools.html) 05:21:01 INFO - PROCESS | 10546 | RSS: Main: 189407232 05:21:01 INFO - PROCESS | 10546 | 05:24:02 INFO - PROCESS | 10546 | Cycle 1(1): loaded http://localhost:34128/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34128/tests/dromaeo/cssquery-prototype.html) 05:24:03 INFO - PROCESS | 10546 | RSS: Main: 186593280 05:24:03 INFO - PROCESS | 10546 | 05:27:06 INFO - PROCESS | 10546 | Cycle 1(1): loaded http://localhost:34128/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34128/tests/dromaeo/cssquery-yui.html) 05:27:06 INFO - PROCESS | 10546 | RSS: Main: 188485632 05:27:06 INFO - PROCESS | 10546 | 05:30:08 INFO - PROCESS | 10546 | Cycle 1(1): loaded http://localhost:34128/tests/dromaeo/cssquery-yui.html (next: http://localhost:34128/tests/dromaeo/cssquery-dojo.html) 05:30:09 INFO - PROCESS | 10546 | RSS: Main: 189517824 05:30:09 INFO - PROCESS | 10546 | 05:30:09 INFO - PROCESS | 10546 | __start_tp_report 05:30:09 INFO - PROCESS | 10546 | _x_x_mozilla_page_load 05:30:09 INFO - PROCESS | 10546 | _x_x_mozilla_page_load_details 05:30:09 INFO - PROCESS | 10546 | |i|pagename|runs| 05:30:09 INFO - PROCESS | 10546 | |0;dojo.html;3126.6248050233976;3131.9843400782993;3134.7022032906866;3167.192365946684;3173.143251322143;5417.810376636814;5496.0931446311415;5532.6680399176075;5552.056150454422;5569.498745112939;5382.8923421531545;5509.779608815653;5539.529140023093;5548.7225638718;5568.331800183973;5004.499550045003;5063.31645227895;5104.66819656723;5116.641835071547;5151.896962060757;4996.900061998758;5150.948490515084;5160;5184.040952423795;5201.557867581241;4922.990786888679;4965.031818795336;5022.321986531808;5087.771050302746;5121.180611102243;5018.598512119058;5020.59835213182;5022.17134172861;5028.7988480460735;5080.923786143211;4955.1080805455;4995.125852975715;4996.225585034325;5003.974980125076;5045.47022562633;5366.221897824833;5402.35171779385;5457.126859702468;5506.476884695948;5509.559235261169;5899.203607513016;5913;5927.911081333784;5936.436038576328;5964.463198312129;5765.740541675635;5971.731272092767;5971.820845374646;5972.522198224175;5980.790672326491;5473.917891231635;5483.204935284361;5488.368837583649;5502.394736578973;5528.723563821793;6015.54883383748;6046.63720176782;6050.878982420327;6053.182820319201;6054.182685337511;5600.971995139998;5754.251947246831;5754.9424505754405;5767;5769.480746732815;5838.416158384128;5935.406459354116;5935.643861368331;5939.881202376015;6000.789972350947;5710.685912274782;5886.94113058864;5905.822825315247;5910.231669882974;5912.940870591325;5689.601727879009;5892.823215303548;5944.167816505693;5962.433568810956;5981.342052374235;4382.23310920594;4433.379326894237;4440.955590444119;4441.866743997685;4465.843695470643;3985.92028159441;4009.6190861868076;4017.598240175959;4033.3748269018347;4046.251443482965;5671.716414179275;5676.801311954062;5697.173909783141;5703.971480142573;5726.4559866813415;5776.393478684678;5920.082387229986;5957.940420595825;5970.641761494324;5984.162217289583;5672;5676.545876329884;5690.800821971294;5712.228849105318;5754.798582049608;5107.336046313955;5120.462351453119;5124.871878203075;5172.870678232999;5174.922376164361;5959.67221802805;6118.95422233728;6158.630482171084;6178.598391104564;6225.470834979077;6041.758329666764;6048.455638992512;6058.3335833057445;6060.272767267956;6088.391160883876;6186.628802271878;6235.064740288993;6282.151909492343;6290.465310448663;6296.590721603081;5636.323641163087;5840.678762667924;5867.618604790675;5902.2327097477055;5944.613600115978;6011.939880601138;6020.337762846171;6024.608400453956;6029.8191054268445;6049.697515124314;5601.579881508822;5869.911951320648;5896.528277737685;5898.879212949526;5900.911486327623;5576.804811831566;5745.1382292656435;5770.50950669181;5817.680027598522;5846.649201047951;5613.522850557748;5644.8024319148635;5697.544196464356;5700.743466543932;5726.713664316684;5623.971880140573;5783.334916484489;5784.190213370048;5834.649921004753;5847.356790752929;5503.752331145188;5587.832365029056;5589.049861523632;5620.213170156099;5629.577781666473 05:30:09 INFO - PROCESS | 10546 | |1;ext.html;587.991180132298;627.2253766598251;646.5894157210173;648.5589798936727;649.8180509457353;39191;42758.78620606893;43092.35361469576;43139.56860431395;43176.13647727043;43585.128297434036;43856.56143438564;43954.780226098825;43994.34008489875;44215.11569768611;8729.214370706652;8859.822803543926;8884;8922.955385223066;8924.152205540495;8847.601857916377;8890.911090889073;8900.955495222548;8913.28693704502;8935.151160639729;8889.111088891124;8901.599428025755;8926.910730892705;8927.151920567536;8934.821303573957;8877.979032411291;8883.067277935788;8927.821443571158;8929.151730585583;8947.418417802823;8861.689840855604;8931.687390941352;8937.597808098652;8939.955300223522;8957.059508751618;41556.29884057557;41680.791596041825;41704.37443438321;41783.582164178275;41899.58100419018;3581.2837432513343;3644.234710710754;3724.478572999782;3788.242351529705;3841.2125514269505;32551.6744832551;32929.341413171845;33483;33533.66466335354;33664.15839604005;4480.529544397824;4522.728636281834;4527.207738645724;4537.727736335831;4542.659300552472;337516;339098.99999999756;340035;341128;344161;60862;61219.10247180215;61461;61510.69244653838;61913.690431547555;35514.8224258877;36623;36665;64995;65065.67467162634;17081.743773843402;17085.060321682176;17115.74326385105;17133.91433042827;17241.482755517354;12822.487100515875;12850.807237891438;12943.288119153349;12979.41592628334;13029.543965961146;19746.30887918916;19809.30667426662;19816.70274945877;20045.699314510293;20063.598728025358;7031.683574239171;7135.323199048219;7224.385927196142;7242.13094428672;7552.962235188789;943.7923656795494;989.4459102902398;1049.5906596427399;1075.3977772447454;1102.4950941964162;31576.684233157375;31832.840835795672;32169;32598.511022334686;32968;1036.233187441288;1090.1605763562013;1099.3294090604725;1201;1215.9392030398444;16280.918595406947;16926.06906620148;16934.49196524106;17021.31914723397;17064;565376;566032;570996;572350;573777;59615.40384596099;59928;59929.101063484086;60019.399806001384;60366;1337.5987203838808;1357.151780137414;1376.029898921258;1379.9379027943967;1385.9792103118461;30861.691383085883;31100.22249443782;31461;31496.37007259888;32752.181195470304;51526;51941;52072.47927520828;52135.47864521458;52158;403449;412635;412967;413632;414685;28689.28276793097;28974.710252897203;29037;29069.127926161404;29108.563371549866;48679.026419472124;49112.263316049575;49492.75253623853;49517;50088.49911500984;39420.60579394169;40245;40572.39141412822;41320;42359;40102.59897400989;40903.7954810236;41304.58695413128;41855.162896742506;42078.579214207464;40239.597604024755;41279.58720412757;41492.79253603713;41513.792431037655;41954;36203.45694814527;36667.44998824967;36902.63097368992;37057.25885482221;37497.81251093727;27556.586651199847;28292.15123546297;28494.287642808267;28638.570421443277;28694.426111477234 05:30:09 INFO - PROCESS | 10546 | |2;jquery.html;391.8824352694192;393.8818354493652;395.359517581518;399.76014391365186;414.4612004394287;18044.90977545112;19303.13135908884;19615.705764413546;19654.606907861835;20390.184392624313;18164.364247251317;18488.260469581233;18822.153003114858;18832.811671883275;18858.24567017321;5484.7531861066245;5596.832095037155;5625;5631.8028868989595;5690.630109042899;5544.0575102232515;5577.8605534861545;5655.604107712462;5676.829695109132;5678.6024978251535;5485.862853428656;5541.972290138544;5649.519790817785;5658.971705141489;5666.546676265889;5544.279243698334;5578.135389014689;5595.4124816894255;5612.915806262909;5615;4861.465238823726;5023.799048038074;5056.544910957995;5057.418396884369;5067.467915868818;21858.672119918214;21970.670439943413;22758.203462878886;23026;23077.7692223079;2142.7750086240876;2272.7613600571867;2374.6794182785447;2399.8680072596;2726.2775364528416;9468.810623787555;9664;9761.267904907161;9840.901590984071;9859.457729824857;1918.4532408263717;1969.2910552201197;1991.8434012717896;2028.8376929845724;2057.146284292017;72122.63938680326;82462.58768706118;83318.58340708258;83750.58124709337;85212.14787852103;10390.740231494274;10830.241883068109;11084.33493990347;11226.775464490664;11288.492017859217;15264.542063738105;15397.846021539865;15492.84507154914;15519.22403879824;15522.223888805514;7752.26353496417;7801;7995;7996.320312773363;8095.3523718102415;7491.325780679765;7560.6219689016425;7597.278258565428;7643.783302842114;7801.219878012267;4703.365045718784;4748.358971538867;4768.546988036131;4803.1114243864995;4825.5898248648555;1899.3352326685826;1908.9236430542624;1924.259160223324;1965.508622844289;2023.190723710498;957.2724729205714;981.896900825403;989.4953573677333;1028.28534168752;1042.0829669890447;18612.534686632942;18754.437366879014;18849.81150188508;18937.33719319817;19792.01039947997;967.970960871175;974.9366291191192;975.3465178330536;977.5454413697522;984.8473486609587;10588.735281618021;10798.352098873935;10872.836907446395;10892.727681807859;10909.509072091774;292311.53844230645;476642;486324;490652;492891;91254;92815;93650.53174734219;94224;96166.51916740372;1012.964546240878;1016.5425558498705;1023.3297190340339;1024.9743756406149;1034.4103860799423;17180.91409542944;17412.73880891813;17525.386611468537;17677;17687.204075816877;30927.536086958262;31764.982326678928;40068.79965600153;41196.588034119275;41409.58590414178;56933;57055.71472142779;57280.42719572918;57697.84604307806;57857.371410286236;7779.455438119504;7801.102873169431;7822.491538050009;8176.591170441335;8448.23965843077;11754.471048802654;12880.806787898377;12889.355532223539;12899.613011609667;13074.411651475517;11117.555297788322;11328.207025508465;11360.772784544428;11398.259113157617;11502;11207.831882521605;11218.775624487302;11232.157588181082;11336.376499292619;11439;10844.945775271073;10934.945325273322;10942;11056.502457389597;11174.720631984266;7760.068791745027;7811.765647030598;7857.9214207857185;7861.842763144591;8179.182081791773;9415.293852960918;11183.384913829817;11219.270747401393;11236.381998990135;11489.712757181138 05:30:09 INFO - PROCESS | 10546 | |3;mootools.html;1467.0390893964454;1517.3475405575603;1595.1545680789186;1699.6005938604433;1748.8163742807012;8093.352531797457;8589.699360522383;8721.389502734803;9232.076792320773;9246.90753092469;8773.736787896358;9020.278377729783;9066.863997040049;9075.455472671645;9091.18179363857;2342.121704360869;2395.185636883459;2401.927942161738;2402.7116745990506;2411.3489357873364;2403.615421532555;2412.9155479558217;2447.412620970963;2451.2891261534223;2452.91414800482;2354.988225058872;2381.654660074288;2388.462595915914;2407.963880541793;2420.092465325503;2308.042162502559;2310.1221535816367;2328.5342931413616;2331.6036273833406;2344;2283.862968221912;2304.6427803690453;2329.2429960262984;2335.089315167086;2335.859848409084;9113;9199.126083022102;9217.893852737647;9271.258299336037;9287.489188094652;5179.922301165486;5315.123004704219;5320.068987927098;5331;5360.437154098841;3356.6475520070285;3385.6783605557434;3387.136280248521;3452.87914922979;3477.2871561329866;1156.6703489505535;1182.131133616791;1186.9703257418635;1192.0999645267768;1192.6720151958282;11953.521859125625;12024.939875300568;12036.39818009096;12038;12065.095117866107;4700;4719.5752382285755;4784.569388754959;4790.137775200497;4794.352762377034;10199.592016319413;10210.489475526194;10218;10232.795344093225;10238.897611023944;5244.685318880803;5270.552003079782;5278.9472105278455;5284.788608455696;5293.338332708411;4276.294411422081;4820.25286080658;4846.75766211688;4984.327115839388;5007.12375334315;4005.539362973237;4006.859759908389;4105.89735256615;4124.711270211056;4162.41726158338;1252.8997680185564;1304.5108084468325;1319.8020296955342;1335.7929520924272;1343.9260840653662;985.280745056113;995.5121990224883;996.4071377530358;996.8155891160159;1002.6089824968268;5970.164177015221;5989.79035733756;6072.666003369769;6128.540359473057;6205.472534834499;940.8400571902793;959.0821494196148;975.9560819763128;987.1411871671548;1004.6182450668699;3950.4074388841905;3963;4041.8513709159815;4200.474940632421;4267;11178.217524773188;11325.943370283096;11433.828492572618;11447.713807154887;11666.941665291619;10778.245522813328;11264.267822591506;11442.313461192354;11537.250078744855;11549.36478493691;8279.917200828035;8524.786880327918;8578.699745509002;8612.956935215283;8643.740687779376;6005.939940600713;6055.939440605537;6133.202683651097;6177;6181.474574661024;10247.692569222936;10467.685969420929;10505.054545090978;10610.681679549625;10825.188110891871;10712.73218169552;10754.784904301714;10789.730256743644;10919.962603552649;10932.125429965425;7837.216278372117;8056.274935255855;8139.75580732579;8196.918030819854;8357.707480238405;8907.421017633833;8934.50860202695;8948.910510895068;8965.462072275684;9012.2339601132;7649.770506884803;7825.491343062683;7850;7894;8020.197980201933;7823.217678232131;7853.450258481851;7863.252990965849;7919.12889582157;7922.445428819928;7178.533395329287;7188.5327453715345;7257.782266532013;7261.128664560287;7317.853642927005;5202.4797520249185;5273.762680679302;5277.076511610376;5283;5320.388155362028;5143.151380022255;5256.264123022856;5283.788648454019;5291.867703307448;5312.521873031291 05:30:09 INFO - PROCESS | 10546 | |4;prototype.html;316.3893685187587;319.74739955435206;325.8549945274352;329.42186462757854;330.60327606871743;5509.393966663663;5541.9168712469345;5667.744951477183;5728.25532680752;5736.770529178833;5592.7762889484375;5598.328200615922;5605.943940560594;5620.747066382012;5631.774729010845;4343.218220720261;4385.10105428388;4400.471943366801;4401.845935392262;4404.361367601696;4115.54728979812;4344.175446312556;4361.280388735855;4414.690971631987;4430.091831174617;4240.469941257343;4273.423087883127;4289.485261768592;4291.399204111427;4300.612944834964;4170.540310891164;4299.6345310648785;4304.225239456897;4323.935140972888;4329.571241490301;3765.811709414518;3771.679407250387;3787.5833658297565;3788.583255841855;3813.733038687293;5428.647137936061;5569.443055694439;5597;5603.411641777596;5603.719814009324;4833.830815921426;4924.975375123137;4938.777755001033;4944.87637809054;5019.598432125421;5854.76580936762;5870.148828419898;5879.353271140171;5890.793822216202;5907.822765317047;4072.67857321327;4130.731502452331;4137.441445404862;4138.79306034697;4161.523893283492;5829.621074630136;6083.452489275986;6088.238970128734;6135.846603834895;6200.906986395207;4090.118545469058;4158.584141585818;4179.958200418017;4192.287311157111;4202.285611446062;4206.41110244566;4246.554111818276;4248.383984322256;4249.851255206115;4261.680373971903;4745.082776996095;4946.653734238569;4957.950420495821;4972.055309491185;4985.8005679772405;5644.306707987587;5914.4381283777975;5931.139984702194;5955.34491205967;6006.969965150233;1458.4968185975822;1467.6350993576077;1468.9706205875823;1472.374240947593;1477.6601381682274;901.8466860633708;906.6962567539948;926.3700683535126;934.9018353072829;936.279065119854;5133.332666753373;5143.331366922351;5151.7681704323395;5169.25045868347;5174.120399532013;5343;5343.679379237258;5359.946400535945;5395.973020134874;5410.675359478444;5094.898102038012;5099.847004589868;5135.151345515611;5323.52088312046;5756.856078598069;3234.8706051757667;3245.221146924768;3247.6427592964756;3249.2201871550656;3261.967380326214;6013.909791353133;6337;6338.683065846689;6348.968255158695;6356;6140.938590614126;6190.659513726789;6218.844528886814;6231.376862313823;6252.718627661675;6188.566800324024;6198.8532121557655;6211.863009180335;6276.426665067301;6311.715972781236;5736.799212027559;6014.165679467629;6113.908291375722;6119.785807496716;6124.479419249414;6023.698815059317;6075;6103.7253323601435;6114.318562395199;6157.384261573807;5961.612495187799;6210.254769427697;6264.812055638338;6304.05439184126;6361.809145725636;4297.290946993711;4300.053988122608;4302.182585308781;4308.612224899774;4367.388565600755;5784.248047753765;5931.466168044896;6100.572959892765;6110.847228819137;6138.232720909887;5879.265091863517;5888.882222355443;5894.528437724886;5913.408659134052;5924.081767326072;5855.151003104611;5862.94137058624;5865.794697185578;5877.823665290048;5892.558058145571;5619.775208991595;5845.684720937925;5875.882482350415;5889.646621202742;5896.941030589811;5887.852803679943;5924.11138329254;5979.222701048836;6021;6062.90905636407;5656.60403771732;5790;5795.449432303924;5805.187273781589;5806.5064469518875 05:30:09 INFO - PROCESS | 10546 | |5;yui.html;660.864522772832;670.7719375412358;731.8609464201801;818.918108189181;846.6063280574533;14688.779668304984;15577.688446231068;15625.531234062997;15636.530904072868;15642;14755.55733328002;15050.322735476902;15077.246137693126;15203.467878624251;15216.69566608667;826.1243082332732;827.0117209934131;834.511810590802;837.351052933975;837.5351679817699;787.6613056385752;795.9721409750659;816.4040250617053;817.0481389181597;825.1830687619274;856.9357298202628;858.1547176031604;860.5611138319471;863.0290922711949;865.1521508921261;846.8391005708926;847.474565769224;848.1094850407079;850.3069997951711;853.5561508015797;629.4775336470718;630.6562923206864;630.8927482328015;632.2097378277153;633.8763941031501;15325.770113448307;15360.615984600363;15378.461753838674;15407.691846163127;15432.768508472382;11968.222065565711;12060;12152.21010634306;12360.938195308965;12585.559505417266;11957;12065.095117866107;12603.936980315131;12701.174423662433;12707.936460317731;3859.8842034739005;3875.8837234883;3901.4147877818273;3941.5270167580074;4026.778527181004;76398.61800690962;76737.61631191864;76884;77073.61463192705;77731;10969.670909872717;11038.282511636718;11231.71920701989;11354.205205635692;11537.653870383901;21764.673529897063;21774.346769596938;21778.34664960054;21787.34637960832;21910.780892191193;8069.677212911418;8329.916700833035;8373.204545568162;8630.913690863137;8704.434211776213;4490.550944905483;4618.399608050999;4657.67396282257;4686.27362758773;4921.680090794087;3373.5614370132216;3524.753267271318;3527.9118022049142;3537.8761743339373;3546.04256850654;582.5892745614332;594.3580932592789;596.6509591888707;610.0452791381474;615.9538034647419;621.9098230756515;710.4210068793916;719.3274288540232;721.3039416962656;753.9821241324169;8760.8685869712;9083.227925626396;9309.581068851918;9346.672866449642;9439.716808495756;623.6975067092457;637.8724255148989;652.2108249018646;652.3704625036862;690.9827254318682;4250.53244143144;4720.881977950578;4786.7845946931775;4829.372181616367;4842.975785121052;74906;110363;117363.54500502383;118012;129054;83656.58171709103;108322.45838770756;111309;113392.29911551333;113408;77686.6115669418;87117.89087720701;87196.56401718078;90446.54776726206;91194;9524.333296669167;9720.75698107553;9803.16673082796;9961.49138780261;10053.246006549392;49562;49796;49925.50074499209;49947.75026124846;50874;68025;72791;74851.62574187313;75071;75414;12674.619761407173;12826.102172847812;12864.983534577686;12878.613641590393;12927;13977.543720190455;14222.217778022308;14308.353183897803;14334.126040427896;14415.207163606103;13681.17912925188;13741.312934353042;13781.379837907518;13826.239556824472;13951.930240348733;12970;13315.866841331463;13496.46014159462;13517.932410337886;13588.796168057685;13703.520376786764;13757.17456952586;13819.861801381858;13829.654258643614;13870.306484675928;10406.791864162826;10412.739681507719;10534.26260161812;10661.987111224422;10741.731456713645;10276.845847312446;10383.948080259852;10444.843327349943;10546.314489558154;10595.47022648849 05:30:09 INFO - PROCESS | 10546 | __end_tp_report 05:30:09 INFO - PROCESS | 10546 | __start_cc_report 05:30:09 INFO - PROCESS | 10546 | _x_x_mozilla_cycle_collect,356 05:30:09 INFO - PROCESS | 10546 | __end_cc_report 05:30:09 INFO - PROCESS | 10546 | __startTimestamp1466771409174__endTimestamp 05:30:09 INFO - PROCESS | 10546 | 05:30:09 INFO - PROCESS | 10546 | ------- Summary: start ------- 05:30:09 INFO - PROCESS | 10546 | Number of tests: 6 05:30:09 INFO - PROCESS | 10546 | 05:30:09 INFO - PROCESS | 10546 | [#0] dojo.html Cycles:165 Average:5501.98 Median:5690.80 stddev:642.32 (11.3%) stddev-sans-first:616.67 05:30:09 INFO - PROCESS | 10546 | Values: 3126.6 3132.0 3134.7 3167.2 3173.1 5417.8 5496.1 5532.7 5552.1 5569.5 5382.9 5509.8 5539.5 5548.7 5568.3 5004.5 5063.3 5104.7 5116.6 5151.9 4996.9 5150.9 5160.0 5184.0 5201.6 4923.0 4965.0 5022.3 5087.8 5121.2 5018.6 5020.6 5022.2 5028.8 5080.9 4955.1 4995.1 4996.2 5004.0 5045.5 5366.2 5402.4 5457.1 5506.5 5509.6 5899.2 5913.0 5927.9 5936.4 5964.5 5765.7 5971.7 5971.8 5972.5 5980.8 5473.9 5483.2 5488.4 5502.4 5528.7 6015.5 6046.6 6050.9 6053.2 6054.2 5601.0 5754.3 5754.9 5767.0 5769.5 5838.4 5935.4 5935.6 5939.9 6000.8 5710.7 5886.9 5905.8 5910.2 5912.9 5689.6 5892.8 5944.2 5962.4 5981.3 4382.2 4433.4 4441.0 4441.9 4465.8 3985.9 4009.6 4017.6 4033.4 4046.3 5671.7 5676.8 5697.2 5704.0 5726.5 5776.4 5920.1 5957.9 5970.6 5984.2 5672.0 5676.5 5690.8 5712.2 5754.8 5107.3 5120.5 5124.9 5172.9 5174.9 5959.7 6119.0 6158.6 6178.6 6225.5 6041.8 6048.5 6058.3 6060.3 6088.4 6186.6 6235.1 6282.2 6290.5 6296.6 5636.3 5840.7 5867.6 5902.2 5944.6 6011.9 6020.3 6024.6 6029.8 6049.7 5601.6 5869.9 5896.5 5898.9 5900.9 5576.8 5745.1 5770.5 5817.7 5846.6 5613.5 5644.8 5697.5 5700.7 5726.7 5624.0 5783.3 5784.2 5834.6 5847.4 5503.8 5587.8 5589.0 5620.2 5629.6 05:30:09 INFO - PROCESS | 10546 | 05:30:09 INFO - PROCESS | 10546 | [#1] ext.html Cycles:180 Average:60150.50 Median:228088.90 stddev:119683.82 (52.5%) stddev-sans-first:119936.02 05:30:09 INFO - PROCESS | 10546 | Values: 588.0 627.2 646.6 648.6 649.8 39191.0 42758.8 43092.4 43139.6 43176.1 43585.1 43856.6 43954.8 43994.3 44215.1 8729.2 8859.8 8884.0 8923.0 8924.2 8847.6 8890.9 8901.0 8913.3 8935.2 8889.1 8901.6 8926.9 8927.2 8934.8 8878.0 8883.1 8927.8 8929.2 8947.4 8861.7 8931.7 8937.6 8940.0 8957.1 41556.3 41680.8 41704.4 41783.6 41899.6 3581.3 3644.2 3724.5 3788.2 3841.2 32551.7 32929.3 33483.0 33533.7 33664.2 4480.5 4522.7 4527.2 4537.7 4542.7 337516.0 339099.0 340035.0 341128.0 344161.0 60862.0 61219.1 61461.0 61510.7 61913.7 35514.8 36623.0 36665.0 64995.0 65065.7 17081.7 17085.1 17115.7 17133.9 17241.5 12822.5 12850.8 12943.3 12979.4 13029.5 19746.3 19809.3 19816.7 20045.7 20063.6 7031.7 7135.3 7224.4 7242.1 7553.0 943.8 989.4 1049.6 1075.4 1102.5 31576.7 31832.8 32169.0 32598.5 32968.0 1036.2 1090.2 1099.3 1201.0 1215.9 16280.9 16926.1 16934.5 17021.3 17064.0 565376.0 566032.0 570996.0 572350.0 573777.0 59615.4 59928.0 59929.1 60019.4 60366.0 1337.6 1357.2 1376.0 1379.9 1386.0 30861.7 31100.2 31461.0 31496.4 32752.2 51526.0 51941.0 52072.5 52135.5 52158.0 403449.0 412635.0 412967.0 413632.0 414685.0 28689.3 28974.7 29037.0 29069.1 29108.6 48679.0 49112.3 49492.8 49517.0 50088.5 39420.6 40245.0 40572.4 41320.0 42359.0 40102.6 40903.8 41304.6 41855.2 42078.6 40239.6 41279.6 41492.8 41513.8 41954.0 36203.5 36667.4 36902.6 37057.3 37497.8 27556.6 28292.2 28494.3 28638.6 28694.4 05:30:09 INFO - PROCESS | 10546 | 05:30:09 INFO - PROCESS | 10546 | [#2] jquery.html Cycles:180 Average:27549.69 Median:394.62 stddev:75284.51 (19077.7%) stddev-sans-first:75468.09 05:30:09 INFO - PROCESS | 10546 | Values: 391.9 393.9 395.4 399.8 414.5 18044.9 19303.1 19615.7 19654.6 20390.2 18164.4 18488.3 18822.2 18832.8 18858.2 5484.8 5596.8 5625.0 5631.8 5690.6 5544.1 5577.9 5655.6 5676.8 5678.6 5485.9 5542.0 5649.5 5659.0 5666.5 5544.3 5578.1 5595.4 5612.9 5615.0 4861.5 5023.8 5056.5 5057.4 5067.5 21858.7 21970.7 22758.2 23026.0 23077.8 2142.8 2272.8 2374.7 2399.9 2726.3 9468.8 9664.0 9761.3 9840.9 9859.5 1918.5 1969.3 1991.8 2028.8 2057.1 72122.6 82462.6 83318.6 83750.6 85212.1 10390.7 10830.2 11084.3 11226.8 11288.5 15264.5 15397.8 15492.8 15519.2 15522.2 7752.3 7801.0 7995.0 7996.3 8095.4 7491.3 7560.6 7597.3 7643.8 7801.2 4703.4 4748.4 4768.5 4803.1 4825.6 1899.3 1908.9 1924.3 1965.5 2023.2 957.3 981.9 989.5 1028.3 1042.1 18612.5 18754.4 18849.8 18937.3 19792.0 968.0 974.9 975.3 977.5 984.8 10588.7 10798.4 10872.8 10892.7 10909.5 292311.5 476642.0 486324.0 490652.0 492891.0 91254.0 92815.0 93650.5 94224.0 96166.5 1013.0 1016.5 1023.3 1025.0 1034.4 17180.9 17412.7 17525.4 17677.0 17687.2 30927.5 31765.0 40068.8 41196.6 41409.6 56933.0 57055.7 57280.4 57697.8 57857.4 7779.5 7801.1 7822.5 8176.6 8448.2 11754.5 12880.8 12889.4 12899.6 13074.4 11117.6 11328.2 11360.8 11398.3 11502.0 11207.8 11218.8 11232.2 11336.4 11439.0 10844.9 10934.9 10942.0 11056.5 11174.7 7760.1 7811.8 7857.9 7861.8 8179.2 9415.3 11183.4 11219.3 11236.4 11489.7 05:30:09 INFO - PROCESS | 10546 | 05:30:09 INFO - PROCESS | 10546 | [#3] mootools.html Cycles:180 Average:5950.60 Median:4787.35 stddev:3387.73 (70.8%) stddev-sans-first:3380.48 05:30:09 INFO - PROCESS | 10546 | Values: 1467.0 1517.3 1595.2 1699.6 1748.8 8093.4 8589.7 8721.4 9232.1 9246.9 8773.7 9020.3 9066.9 9075.5 9091.2 2342.1 2395.2 2401.9 2402.7 2411.3 2403.6 2412.9 2447.4 2451.3 2452.9 2355.0 2381.7 2388.5 2408.0 2420.1 2308.0 2310.1 2328.5 2331.6 2344.0 2283.9 2304.6 2329.2 2335.1 2335.9 9113.0 9199.1 9217.9 9271.3 9287.5 5179.9 5315.1 5320.1 5331.0 5360.4 3356.6 3385.7 3387.1 3452.9 3477.3 1156.7 1182.1 1187.0 1192.1 1192.7 11953.5 12024.9 12036.4 12038.0 12065.1 4700.0 4719.6 4784.6 4790.1 4794.4 10199.6 10210.5 10218.0 10232.8 10238.9 5244.7 5270.6 5278.9 5284.8 5293.3 4276.3 4820.3 4846.8 4984.3 5007.1 4005.5 4006.9 4105.9 4124.7 4162.4 1252.9 1304.5 1319.8 1335.8 1343.9 985.3 995.5 996.4 996.8 1002.6 5970.2 5989.8 6072.7 6128.5 6205.5 940.8 959.1 976.0 987.1 1004.6 3950.4 3963.0 4041.9 4200.5 4267.0 11178.2 11325.9 11433.8 11447.7 11666.9 10778.2 11264.3 11442.3 11537.3 11549.4 8279.9 8524.8 8578.7 8613.0 8643.7 6005.9 6055.9 6133.2 6177.0 6181.5 10247.7 10467.7 10505.1 10610.7 10825.2 10712.7 10754.8 10789.7 10920.0 10932.1 7837.2 8056.3 8139.8 8196.9 8357.7 8907.4 8934.5 8948.9 8965.5 9012.2 7649.8 7825.5 7850.0 7894.0 8020.2 7823.2 7853.5 7863.3 7919.1 7922.4 7178.5 7188.5 7257.8 7261.1 7317.9 5202.5 5273.8 5277.1 5283.0 5320.4 5143.2 5256.3 5283.8 5291.9 5312.5 05:30:09 INFO - PROCESS | 10546 | 05:30:09 INFO - PROCESS | 10546 | [#4] prototype.html Cycles:180 Average:4905.72 Median:5600.87 stddev:1466.72 (26.2%) stddev-sans-first:1429.81 05:30:09 INFO - PROCESS | 10546 | Values: 316.4 319.7 325.9 329.4 330.6 5509.4 5541.9 5667.7 5728.3 5736.8 5592.8 5598.3 5605.9 5620.7 5631.8 4343.2 4385.1 4400.5 4401.8 4404.4 4115.5 4344.2 4361.3 4414.7 4430.1 4240.5 4273.4 4289.5 4291.4 4300.6 4170.5 4299.6 4304.2 4323.9 4329.6 3765.8 3771.7 3787.6 3788.6 3813.7 5428.6 5569.4 5597.0 5603.4 5603.7 4833.8 4925.0 4938.8 4944.9 5019.6 5854.8 5870.1 5879.4 5890.8 5907.8 4072.7 4130.7 4137.4 4138.8 4161.5 5829.6 6083.5 6088.2 6135.8 6200.9 4090.1 4158.6 4180.0 4192.3 4202.3 4206.4 4246.6 4248.4 4249.9 4261.7 4745.1 4946.7 4958.0 4972.1 4985.8 5644.3 5914.4 5931.1 5955.3 6007.0 1458.5 1467.6 1469.0 1472.4 1477.7 901.8 906.7 926.4 934.9 936.3 5133.3 5143.3 5151.8 5169.3 5174.1 5343.0 5343.7 5359.9 5396.0 5410.7 5094.9 5099.8 5135.2 5323.5 5756.9 3234.9 3245.2 3247.6 3249.2 3262.0 6013.9 6337.0 6338.7 6349.0 6356.0 6140.9 6190.7 6218.8 6231.4 6252.7 6188.6 6198.9 6211.9 6276.4 6311.7 5736.8 6014.2 6113.9 6119.8 6124.5 6023.7 6075.0 6103.7 6114.3 6157.4 5961.6 6210.3 6264.8 6304.1 6361.8 4297.3 4300.1 4302.2 4308.6 4367.4 5784.2 5931.5 6100.6 6110.8 6138.2 5879.3 5888.9 5894.5 5913.4 5924.1 5855.2 5862.9 5865.8 5877.8 5892.6 5619.8 5845.7 5875.9 5889.6 5896.9 5887.9 5924.1 5979.2 6021.0 6062.9 5656.6 5790.0 5795.4 5805.2 5806.5 05:30:09 INFO - PROCESS | 10546 | 05:30:09 INFO - PROCESS | 10546 | [#5] yui.html Cycles:180 Average:20733.01 Median:4554.48 stddev:30244.52 (664.1%) stddev-sans-first:30291.82 05:30:09 INFO - PROCESS | 10546 | Values: 660.9 670.8 731.9 818.9 846.6 14688.8 15577.7 15625.5 15636.5 15642.0 14755.6 15050.3 15077.2 15203.5 15216.7 826.1 827.0 834.5 837.4 837.5 787.7 796.0 816.4 817.0 825.2 856.9 858.2 860.6 863.0 865.2 846.8 847.5 848.1 850.3 853.6 629.5 630.7 630.9 632.2 633.9 15325.8 15360.6 15378.5 15407.7 15432.8 11968.2 12060.0 12152.2 12360.9 12585.6 11957.0 12065.1 12603.9 12701.2 12707.9 3859.9 3875.9 3901.4 3941.5 4026.8 76398.6 76737.6 76884.0 77073.6 77731.0 10969.7 11038.3 11231.7 11354.2 11537.7 21764.7 21774.3 21778.3 21787.3 21910.8 8069.7 8329.9 8373.2 8630.9 8704.4 4490.6 4618.4 4657.7 4686.3 4921.7 3373.6 3524.8 3527.9 3537.9 3546.0 582.6 594.4 596.7 610.0 616.0 621.9 710.4 719.3 721.3 754.0 8760.9 9083.2 9309.6 9346.7 9439.7 623.7 637.9 652.2 652.4 691.0 4250.5 4720.9 4786.8 4829.4 4843.0 74906.0 110363.0 117363.5 118012.0 129054.0 83656.6 108322.5 111309.0 113392.3 113408.0 77686.6 87117.9 87196.6 90446.5 91194.0 9524.3 9720.8 9803.2 9961.5 10053.2 49562.0 49796.0 49925.5 49947.8 50874.0 68025.0 72791.0 74851.6 75071.0 75414.0 12674.6 12826.1 12865.0 12878.6 12927.0 13977.5 14222.2 14308.4 14334.1 14415.2 13681.2 13741.3 13781.4 13826.2 13951.9 12970.0 13315.9 13496.5 13517.9 13588.8 13703.5 13757.2 13819.9 13829.7 13870.3 10406.8 10412.7 10534.3 10662.0 10741.7 10276.8 10383.9 10444.8 10546.3 10595.5 05:30:09 INFO - PROCESS | 10546 | -------- Summary: end -------- 05:30:09 INFO - PROCESS | 10546 | 05:30:09 INFO - TEST-INFO | 10546: exit 0 05:30:09 INFO - TEST-OK | dromaeo_css | took 1112399ms 05:30:09 INFO - TEST-START | kraken 05:30:09 INFO - operating with platform_type : linux_ 05:30:09 INFO - Initialising browser for kraken test... 05:30:09 INFO - TEST-INFO | started process 10797 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzViPnZ/profile http://localhost:34128/getInfo.html) 05:30:14 INFO - PROCESS | 10797 | __metrics Screen width/height:1600/1200 05:30:14 INFO - PROCESS | 10797 | colorDepth:24 05:30:14 INFO - PROCESS | 10797 | Browser inner width/height: 1024/697 05:30:14 INFO - PROCESS | 10797 | __metrics 05:30:15 ERROR - PROCESS | 10797 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:30:16 INFO - TEST-INFO | 10797: exit 0 05:30:16 INFO - Browser initialized. 05:30:16 INFO - Running cycle 1/1 for kraken test... 05:30:16 INFO - TEST-INFO | started process 10918 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzViPnZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:28 INFO - PROCESS | 10918 | RSS: Main: 185217024 05:30:28 INFO - PROCESS | 10918 | 05:30:30 INFO - PROCESS | 10918 | Cycle 1(1): loaded http://localhost:34128/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34128/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:31 INFO - PROCESS | 10918 | RSS: Main: 190615552 05:30:31 INFO - PROCESS | 10918 | 05:30:34 INFO - PROCESS | 10918 | Cycle 1(1): loaded http://localhost:34128/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34128/tests/kraken/driver.html?testName=audio-dft) 05:30:34 INFO - PROCESS | 10918 | RSS: Main: 190050304 05:30:34 INFO - PROCESS | 10918 | 05:30:37 INFO - PROCESS | 10918 | Cycle 1(1): loaded http://localhost:34128/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34128/tests/kraken/driver.html?testName=audio-fft) 05:30:38 INFO - PROCESS | 10918 | RSS: Main: 185065472 05:30:38 INFO - PROCESS | 10918 | 05:30:40 INFO - PROCESS | 10918 | Cycle 1(1): loaded http://localhost:34128/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34128/tests/kraken/driver.html?testName=audio-oscillator) 05:30:41 INFO - PROCESS | 10918 | RSS: Main: 185802752 05:30:41 INFO - PROCESS | 10918 | 05:30:43 INFO - PROCESS | 10918 | Cycle 1(1): loaded http://localhost:34128/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34128/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:30:44 INFO - PROCESS | 10918 | RSS: Main: 186372096 05:30:44 INFO - PROCESS | 10918 | 05:30:47 INFO - PROCESS | 10918 | Cycle 1(1): loaded http://localhost:34128/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34128/tests/kraken/driver.html?testName=imaging-darkroom) 05:30:48 INFO - PROCESS | 10918 | RSS: Main: 187011072 05:30:48 INFO - PROCESS | 10918 | 05:30:51 INFO - PROCESS | 10918 | Cycle 1(1): loaded http://localhost:34128/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34128/tests/kraken/driver.html?testName=imaging-desaturate) 05:30:52 INFO - PROCESS | 10918 | RSS: Main: 184000512 05:30:52 INFO - PROCESS | 10918 | 05:30:54 INFO - PROCESS | 10918 | Cycle 1(1): loaded http://localhost:34128/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34128/tests/kraken/driver.html?testName=json-parse-financial) 05:30:55 INFO - PROCESS | 10918 | RSS: Main: 185044992 05:30:55 INFO - PROCESS | 10918 | 05:30:57 INFO - PROCESS | 10918 | Cycle 1(1): loaded http://localhost:34128/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34128/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:30:57 INFO - PROCESS | 10918 | RSS: Main: 185569280 05:30:57 INFO - PROCESS | 10918 | 05:30:59 INFO - PROCESS | 10918 | Cycle 1(1): loaded http://localhost:34128/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34128/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:31:00 INFO - PROCESS | 10918 | RSS: Main: 185810944 05:31:00 INFO - PROCESS | 10918 | 05:31:02 INFO - PROCESS | 10918 | Cycle 1(1): loaded http://localhost:34128/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34128/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:02 INFO - PROCESS | 10918 | RSS: Main: 185966592 05:31:02 INFO - PROCESS | 10918 | 05:31:05 INFO - PROCESS | 10918 | Cycle 1(1): loaded http://localhost:34128/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34128/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:31:06 INFO - PROCESS | 10918 | RSS: Main: 185950208 05:31:06 INFO - PROCESS | 10918 | 05:31:08 INFO - PROCESS | 10918 | Cycle 1(1): loaded http://localhost:34128/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34128/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:31:09 INFO - PROCESS | 10918 | RSS: Main: 185700352 05:31:09 INFO - PROCESS | 10918 | 05:31:11 INFO - PROCESS | 10918 | Cycle 1(1): loaded http://localhost:34128/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34128/tests/kraken/driver.html?testName=ai-astar) 05:31:11 INFO - PROCESS | 10918 | RSS: Main: 186814464 05:31:11 INFO - PROCESS | 10918 | 05:31:11 INFO - PROCESS | 10918 | __start_tp_report 05:31:11 INFO - PROCESS | 10918 | _x_x_mozilla_page_load 05:31:11 INFO - PROCESS | 10918 | _x_x_mozilla_page_load_details 05:31:11 INFO - PROCESS | 10918 | |i|pagename|runs| 05:31:11 INFO - PROCESS | 10918 | |0;ai-astar;104;111;105;110;114;115;112;112;112;113 05:31:11 INFO - PROCESS | 10918 | |1;audio-beat-detection;161;128;155;182;127;159;161;126;198;129 05:31:11 INFO - PROCESS | 10918 | |2;audio-dft;164;163;163;165;165;169;163;163;167;163 05:31:11 INFO - PROCESS | 10918 | |3;audio-fft;76;75;75;169;76;77;75;77;169;74 05:31:11 INFO - PROCESS | 10918 | |4;audio-oscillator;86;89;154;85;85;85;142;85;85;143 05:31:11 INFO - PROCESS | 10918 | |5;imaging-gaussian-blur;117;118;117;117;118;118;118;118;117;118 05:31:11 INFO - PROCESS | 10918 | |6;imaging-darkroom;148;147;148;149;147;147;148;148;146;147 05:31:11 INFO - PROCESS | 10918 | |7;imaging-desaturate;96;96;96;96;96;95;96;96;96;95 05:31:11 INFO - PROCESS | 10918 | |8;json-parse-financial;55;56;56;56;55;56;57;55;56;55 05:31:11 INFO - PROCESS | 10918 | |9;json-stringify-tinderbox;61;63;62;63;62;62;62;63;62;63 05:31:11 INFO - PROCESS | 10918 | |10;stanford-crypto-aes;79;78;78;80;79;81;81;81;101;80 05:31:11 INFO - PROCESS | 10918 | |11;stanford-crypto-ccm;134;126;125;119;121;122;130;143;144;124 05:31:11 INFO - PROCESS | 10918 | |12;stanford-crypto-pbkdf2;165;164;161;158;158;158;161;157;161;164 05:31:11 INFO - PROCESS | 10918 | |13;stanford-crypto-sha256-iterative;64;67;63;63;63;62;64;64;64;65 05:31:11 INFO - PROCESS | 10918 | __end_tp_report 05:31:11 INFO - PROCESS | 10918 | __start_cc_report 05:31:11 INFO - PROCESS | 10918 | _x_x_mozilla_cycle_collect,871 05:31:11 INFO - PROCESS | 10918 | __end_cc_report 05:31:11 INFO - PROCESS | 10918 | __startTimestamp1466771471413__endTimestamp 05:31:11 INFO - PROCESS | 10918 | 05:31:11 INFO - PROCESS | 10918 | ------- Summary: start ------- 05:31:11 INFO - PROCESS | 10918 | Number of tests: 14 05:31:11 INFO - PROCESS | 10918 | 05:31:11 INFO - PROCESS | 10918 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.61 (3.2%) stddev-sans-first:2.88 05:31:11 INFO - PROCESS | 10918 | Values: 104.0 111.0 105.0 110.0 114.0 115.0 112.0 112.0 112.0 113.0 05:31:11 INFO - PROCESS | 10918 | 05:31:11 INFO - PROCESS | 10918 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:160.00 stddev:25.03 (15.6%) stddev-sans-first:26.36 05:31:11 INFO - PROCESS | 10918 | Values: 161.0 128.0 155.0 182.0 127.0 159.0 161.0 126.0 198.0 129.0 05:31:11 INFO - PROCESS | 10918 | 05:31:11 INFO - PROCESS | 10918 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:2.07 (1.3%) stddev-sans-first:2.19 05:31:11 INFO - PROCESS | 10918 | Values: 164.0 163.0 163.0 165.0 165.0 169.0 163.0 163.0 167.0 163.0 05:31:11 INFO - PROCESS | 10918 | 05:31:11 INFO - PROCESS | 10918 | [#3] audio-fft Cycles:10 Average:94.30 Median:75.50 stddev:39.38 (52.2%) stddev-sans-first:41.21 05:31:11 INFO - PROCESS | 10918 | Values: 76.0 75.0 75.0 169.0 76.0 77.0 75.0 77.0 169.0 74.0 05:31:11 INFO - PROCESS | 10918 | 05:31:11 INFO - PROCESS | 10918 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:85.00 stddev:29.47 (34.7%) stddev-sans-first:30.54 05:31:11 INFO - PROCESS | 10918 | Values: 86.0 89.0 154.0 85.0 85.0 85.0 142.0 85.0 85.0 143.0 05:31:11 INFO - PROCESS | 10918 | 05:31:11 INFO - PROCESS | 10918 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:31:11 INFO - PROCESS | 10918 | Values: 117.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 117.0 118.0 05:31:11 INFO - PROCESS | 10918 | 05:31:11 INFO - PROCESS | 10918 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 05:31:11 INFO - PROCESS | 10918 | Values: 148.0 147.0 148.0 149.0 147.0 147.0 148.0 148.0 146.0 147.0 05:31:11 INFO - PROCESS | 10918 | 05:31:11 INFO - PROCESS | 10918 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:31:11 INFO - PROCESS | 10918 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 05:31:11 INFO - PROCESS | 10918 | 05:31:11 INFO - PROCESS | 10918 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:0.67 (1.2%) stddev-sans-first:0.67 05:31:11 INFO - PROCESS | 10918 | Values: 55.0 56.0 56.0 56.0 55.0 56.0 57.0 55.0 56.0 55.0 05:31:11 INFO - PROCESS | 10918 | 05:31:11 INFO - PROCESS | 10918 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.50 stddev:0.67 (1.1%) stddev-sans-first:0.53 05:31:11 INFO - PROCESS | 10918 | Values: 61.0 63.0 62.0 63.0 62.0 62.0 62.0 63.0 62.0 63.0 05:31:11 INFO - PROCESS | 10918 | 05:31:11 INFO - PROCESS | 10918 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:80.00 stddev:6.84 (8.6%) stddev-sans-first:7.18 05:31:11 INFO - PROCESS | 10918 | Values: 79.0 78.0 78.0 80.0 79.0 81.0 81.0 81.0 101.0 80.0 05:31:11 INFO - PROCESS | 10918 | 05:31:11 INFO - PROCESS | 10918 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:128.00 stddev:8.88 (6.9%) stddev-sans-first:9.22 05:31:11 INFO - PROCESS | 10918 | Values: 134.0 126.0 125.0 119.0 121.0 122.0 130.0 143.0 144.0 124.0 05:31:11 INFO - PROCESS | 10918 | 05:31:11 INFO - PROCESS | 10918 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:161.00 stddev:2.91 (1.8%) stddev-sans-first:2.64 05:31:11 INFO - PROCESS | 10918 | Values: 165.0 164.0 161.0 158.0 158.0 158.0 161.0 157.0 161.0 164.0 05:31:11 INFO - PROCESS | 10918 | 05:31:11 INFO - PROCESS | 10918 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.37 (2.1%) stddev-sans-first:1.45 05:31:11 INFO - PROCESS | 10918 | Values: 64.0 67.0 63.0 63.0 63.0 62.0 64.0 64.0 64.0 65.0 05:31:11 INFO - PROCESS | 10918 | -------- Summary: end -------- 05:31:11 INFO - PROCESS | 10918 | 05:31:12 INFO - TEST-INFO | 10918: exit 0 05:31:12 INFO - TEST-OK | kraken | took 62502ms 05:31:12 INFO - SUITE-END | took 1174s 05:31:12 INFO - Completed test suite (00:19:35) 05:31:12 INFO - javascript benchmark 05:31:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7340.73842060204, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3126.6248050233976, 3131.9843400782993, 3134.7022032906866, 3167.192365946684, 3173.143251322143, 5417.810376636814, 5496.0931446311415, 5532.6680399176075, 5552.056150454422, 5569.498745112939, 5382.8923421531545, 5509.779608815653, 5539.529140023093, 5548.7225638718, 5568.331800183973, 5004.499550045003, 5063.31645227895, 5104.66819656723, 5116.641835071547, 5151.896962060757, 4996.900061998758, 5150.948490515084, 5160.0, 5184.040952423795, 5201.557867581241, 4922.990786888679, 4965.031818795336, 5022.321986531808, 5087.771050302746, 5121.180611102243, 5018.598512119058, 5020.59835213182, 5022.17134172861, 5028.7988480460735, 5080.923786143211, 4955.1080805455, 4995.125852975715, 4996.225585034325, 5003.974980125076, 5045.47022562633, 5366.221897824833, 5402.35171779385, 5457.126859702468, 5506.476884695948, 5509.559235261169, 5899.203607513016, 5913.0, 5927.911081333784, 5936.436038576328, 5964.463198312129, 5765.740541675635, 5971.731272092767, 5971.820845374646, 5972.522198224175, 5980.790672326491, 5473.917891231635, 5483.204935284361, 5488.368837583649, 5502.394736578973, 5528.723563821793, 6015.54883383748, 6046.63720176782, 6050.878982420327, 6053.182820319201, 6054.182685337511, 5600.971995139998, 5754.251947246831, 5754.9424505754405, 5767.0, 5769.480746732815, 5838.416158384128, 5935.406459354116, 5935.643861368331, 5939.881202376015, 6000.789972350947, 5710.685912274782, 5886.94113058864, 5905.822825315247, 5910.231669882974, 5912.940870591325, 5689.601727879009, 5892.823215303548, 5944.167816505693, 5962.433568810956, 5981.342052374235, 4382.23310920594, 4433.379326894237, 4440.955590444119, 4441.866743997685, 4465.843695470643, 3985.92028159441, 4009.6190861868076, 4017.598240175959, 4033.3748269018347, 4046.251443482965, 5671.716414179275, 5676.801311954062, 5697.173909783141, 5703.971480142573, 5726.4559866813415, 5776.393478684678, 5920.082387229986, 5957.940420595825, 5970.641761494324, 5984.162217289583, 5672.0, 5676.545876329884, 5690.800821971294, 5712.228849105318, 5754.798582049608, 5107.336046313955, 5120.462351453119, 5124.871878203075, 5172.870678232999, 5174.922376164361, 5959.67221802805, 6118.95422233728, 6158.630482171084, 6178.598391104564, 6225.470834979077, 6041.758329666764, 6048.455638992512, 6058.3335833057445, 6060.272767267956, 6088.391160883876, 6186.628802271878, 6235.064740288993, 6282.151909492343, 6290.465310448663, 6296.590721603081, 5636.323641163087, 5840.678762667924, 5867.618604790675, 5902.2327097477055, 5944.613600115978, 6011.939880601138, 6020.337762846171, 6024.608400453956, 6029.8191054268445, 6049.697515124314, 5601.579881508822, 5869.911951320648, 5896.528277737685, 5898.879212949526, 5900.911486327623, 5576.804811831566, 5745.1382292656435, 5770.50950669181, 5817.680027598522, 5846.649201047951, 5613.522850557748, 5644.8024319148635, 5697.544196464356, 5700.743466543932, 5726.713664316684, 5623.971880140573, 5783.334916484489, 5784.190213370048, 5834.649921004753, 5847.356790752929, 5503.752331145188, 5587.832365029056, 5589.049861523632, 5620.213170156099, 5629.577781666473], "value": 5457.232699118731, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.991180132298, 627.2253766598251, 646.5894157210173, 648.5589798936727, 649.8180509457353, 39191.0, 42758.78620606893, 43092.35361469576, 43139.56860431395, 43176.13647727043, 43585.128297434036, 43856.56143438564, 43954.780226098825, 43994.34008489875, 44215.11569768611, 8729.214370706652, 8859.822803543926, 8884.0, 8922.955385223066, 8924.152205540495, 8847.601857916377, 8890.911090889073, 8900.955495222548, 8913.28693704502, 8935.151160639729, 8889.111088891124, 8901.599428025755, 8926.910730892705, 8927.151920567536, 8934.821303573957, 8877.979032411291, 8883.067277935788, 8927.821443571158, 8929.151730585583, 8947.418417802823, 8861.689840855604, 8931.687390941352, 8937.597808098652, 8939.955300223522, 8957.059508751618, 41556.29884057557, 41680.791596041825, 41704.37443438321, 41783.582164178275, 41899.58100419018, 3581.2837432513343, 3644.234710710754, 3724.478572999782, 3788.242351529705, 3841.2125514269505, 32551.6744832551, 32929.341413171845, 33483.0, 33533.66466335354, 33664.15839604005, 4480.529544397824, 4522.728636281834, 4527.207738645724, 4537.727736335831, 4542.659300552472, 337516.0, 339098.99999999756, 340035.0, 341128.0, 344161.0, 60862.0, 61219.10247180215, 61461.0, 61510.69244653838, 61913.690431547555, 35514.8224258877, 36623.0, 36665.0, 64995.0, 65065.67467162634, 17081.743773843402, 17085.060321682176, 17115.74326385105, 17133.91433042827, 17241.482755517354, 12822.487100515875, 12850.807237891438, 12943.288119153349, 12979.41592628334, 13029.543965961146, 19746.30887918916, 19809.30667426662, 19816.70274945877, 20045.699314510293, 20063.598728025358, 7031.683574239171, 7135.323199048219, 7224.385927196142, 7242.13094428672, 7552.962235188789, 943.7923656795494, 989.4459102902398, 1049.5906596427399, 1075.3977772447454, 1102.4950941964162, 31576.684233157375, 31832.840835795672, 32169.0, 32598.511022334686, 32968.0, 1036.233187441288, 1090.1605763562013, 1099.3294090604725, 1201.0, 1215.9392030398444, 16280.918595406947, 16926.06906620148, 16934.49196524106, 17021.31914723397, 17064.0, 565376.0, 566032.0, 570996.0, 572350.0, 573777.0, 59615.40384596099, 59928.0, 59929.101063484086, 60019.399806001384, 60366.0, 1337.5987203838808, 1357.151780137414, 1376.029898921258, 1379.9379027943967, 1385.9792103118461, 30861.691383085883, 31100.22249443782, 31461.0, 31496.37007259888, 32752.181195470304, 51526.0, 51941.0, 52072.47927520828, 52135.47864521458, 52158.0, 403449.0, 412635.0, 412967.0, 413632.0, 414685.0, 28689.28276793097, 28974.710252897203, 29037.0, 29069.127926161404, 29108.563371549866, 48679.026419472124, 49112.263316049575, 49492.75253623853, 49517.0, 50088.49911500984, 39420.60579394169, 40245.0, 40572.39141412822, 41320.0, 42359.0, 40102.59897400989, 40903.7954810236, 41304.58695413128, 41855.162896742506, 42078.579214207464, 40239.597604024755, 41279.58720412757, 41492.79253603713, 41513.792431037655, 41954.0, 36203.45694814527, 36667.44998824967, 36902.63097368992, 37057.25885482221, 37497.81251093727, 27556.586651199847, 28292.15123546297, 28494.287642808267, 28638.570421443277, 28694.426111477234], "value": 20215.825599650794, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.8824352694192, 393.8818354493652, 395.359517581518, 399.76014391365186, 414.4612004394287, 18044.90977545112, 19303.13135908884, 19615.705764413546, 19654.606907861835, 20390.184392624313, 18164.364247251317, 18488.260469581233, 18822.153003114858, 18832.811671883275, 18858.24567017321, 5484.7531861066245, 5596.832095037155, 5625.0, 5631.8028868989595, 5690.630109042899, 5544.0575102232515, 5577.8605534861545, 5655.604107712462, 5676.829695109132, 5678.6024978251535, 5485.862853428656, 5541.972290138544, 5649.519790817785, 5658.971705141489, 5666.546676265889, 5544.279243698334, 5578.135389014689, 5595.4124816894255, 5612.915806262909, 5615.0, 4861.465238823726, 5023.799048038074, 5056.544910957995, 5057.418396884369, 5067.467915868818, 21858.672119918214, 21970.670439943413, 22758.203462878886, 23026.0, 23077.7692223079, 2142.7750086240876, 2272.7613600571867, 2374.6794182785447, 2399.8680072596, 2726.2775364528416, 9468.810623787555, 9664.0, 9761.267904907161, 9840.901590984071, 9859.457729824857, 1918.4532408263717, 1969.2910552201197, 1991.8434012717896, 2028.8376929845724, 2057.146284292017, 72122.63938680326, 82462.58768706118, 83318.58340708258, 83750.58124709337, 85212.14787852103, 10390.740231494274, 10830.241883068109, 11084.33493990347, 11226.775464490664, 11288.492017859217, 15264.542063738105, 15397.846021539865, 15492.84507154914, 15519.22403879824, 15522.223888805514, 7752.26353496417, 7801.0, 7995.0, 7996.320312773363, 8095.3523718102415, 7491.325780679765, 7560.6219689016425, 7597.278258565428, 7643.783302842114, 7801.219878012267, 4703.365045718784, 4748.358971538867, 4768.546988036131, 4803.1114243864995, 4825.5898248648555, 1899.3352326685826, 1908.9236430542624, 1924.259160223324, 1965.508622844289, 2023.190723710498, 957.2724729205714, 981.896900825403, 989.4953573677333, 1028.28534168752, 1042.0829669890447, 18612.534686632942, 18754.437366879014, 18849.81150188508, 18937.33719319817, 19792.01039947997, 967.970960871175, 974.9366291191192, 975.3465178330536, 977.5454413697522, 984.8473486609587, 10588.735281618021, 10798.352098873935, 10872.836907446395, 10892.727681807859, 10909.509072091774, 292311.53844230645, 476642.0, 486324.0, 490652.0, 492891.0, 91254.0, 92815.0, 93650.53174734219, 94224.0, 96166.51916740372, 1012.964546240878, 1016.5425558498705, 1023.3297190340339, 1024.9743756406149, 1034.4103860799423, 17180.91409542944, 17412.73880891813, 17525.386611468537, 17677.0, 17687.204075816877, 30927.536086958262, 31764.982326678928, 40068.79965600153, 41196.588034119275, 41409.58590414178, 56933.0, 57055.71472142779, 57280.42719572918, 57697.84604307806, 57857.371410286236, 7779.455438119504, 7801.102873169431, 7822.491538050009, 8176.591170441335, 8448.23965843077, 11754.471048802654, 12880.806787898377, 12889.355532223539, 12899.613011609667, 13074.411651475517, 11117.555297788322, 11328.207025508465, 11360.772784544428, 11398.259113157617, 11502.0, 11207.831882521605, 11218.775624487302, 11232.157588181082, 11336.376499292619, 11439.0, 10844.945775271073, 10934.945325273322, 10942.0, 11056.502457389597, 11174.720631984266, 7760.068791745027, 7811.765647030598, 7857.9214207857185, 7861.842763144591, 8179.182081791773, 9415.293852960918, 11183.384913829817, 11219.270747401393, 11236.381998990135, 11489.712757181138], "value": 9001.870247505834, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.0390893964454, 1517.3475405575603, 1595.1545680789186, 1699.6005938604433, 1748.8163742807012, 8093.352531797457, 8589.699360522383, 8721.389502734803, 9232.076792320773, 9246.90753092469, 8773.736787896358, 9020.278377729783, 9066.863997040049, 9075.455472671645, 9091.18179363857, 2342.121704360869, 2395.185636883459, 2401.927942161738, 2402.7116745990506, 2411.3489357873364, 2403.615421532555, 2412.9155479558217, 2447.412620970963, 2451.2891261534223, 2452.91414800482, 2354.988225058872, 2381.654660074288, 2388.462595915914, 2407.963880541793, 2420.092465325503, 2308.042162502559, 2310.1221535816367, 2328.5342931413616, 2331.6036273833406, 2344.0, 2283.862968221912, 2304.6427803690453, 2329.2429960262984, 2335.089315167086, 2335.859848409084, 9113.0, 9199.126083022102, 9217.893852737647, 9271.258299336037, 9287.489188094652, 5179.922301165486, 5315.123004704219, 5320.068987927098, 5331.0, 5360.437154098841, 3356.6475520070285, 3385.6783605557434, 3387.136280248521, 3452.87914922979, 3477.2871561329866, 1156.6703489505535, 1182.131133616791, 1186.9703257418635, 1192.0999645267768, 1192.6720151958282, 11953.521859125625, 12024.939875300568, 12036.39818009096, 12038.0, 12065.095117866107, 4700.0, 4719.5752382285755, 4784.569388754959, 4790.137775200497, 4794.352762377034, 10199.592016319413, 10210.489475526194, 10218.0, 10232.795344093225, 10238.897611023944, 5244.685318880803, 5270.552003079782, 5278.9472105278455, 5284.788608455696, 5293.338332708411, 4276.294411422081, 4820.25286080658, 4846.75766211688, 4984.327115839388, 5007.12375334315, 4005.539362973237, 4006.859759908389, 4105.89735256615, 4124.711270211056, 4162.41726158338, 1252.8997680185564, 1304.5108084468325, 1319.8020296955342, 1335.7929520924272, 1343.9260840653662, 985.280745056113, 995.5121990224883, 996.4071377530358, 996.8155891160159, 1002.6089824968268, 5970.164177015221, 5989.79035733756, 6072.666003369769, 6128.540359473057, 6205.472534834499, 940.8400571902793, 959.0821494196148, 975.9560819763128, 987.1411871671548, 1004.6182450668699, 3950.4074388841905, 3963.0, 4041.8513709159815, 4200.474940632421, 4267.0, 11178.217524773188, 11325.943370283096, 11433.828492572618, 11447.713807154887, 11666.941665291619, 10778.245522813328, 11264.267822591506, 11442.313461192354, 11537.250078744855, 11549.36478493691, 8279.917200828035, 8524.786880327918, 8578.699745509002, 8612.956935215283, 8643.740687779376, 6005.939940600713, 6055.939440605537, 6133.202683651097, 6177.0, 6181.474574661024, 10247.692569222936, 10467.685969420929, 10505.054545090978, 10610.681679549625, 10825.188110891871, 10712.73218169552, 10754.784904301714, 10789.730256743644, 10919.962603552649, 10932.125429965425, 7837.216278372117, 8056.274935255855, 8139.75580732579, 8196.918030819854, 8357.707480238405, 8907.421017633833, 8934.50860202695, 8948.910510895068, 8965.462072275684, 9012.2339601132, 7649.770506884803, 7825.491343062683, 7850.0, 7894.0, 8020.197980201933, 7823.217678232131, 7853.450258481851, 7863.252990965849, 7919.12889582157, 7922.445428819928, 7178.533395329287, 7188.5327453715345, 7257.782266532013, 7261.128664560287, 7317.853642927005, 5202.4797520249185, 5273.762680679302, 5277.076511610376, 5283.0, 5320.388155362028, 5143.151380022255, 5256.264123022856, 5283.788648454019, 5291.867703307448, 5312.521873031291], "value": 4759.48149513226, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.3893685187587, 319.74739955435206, 325.8549945274352, 329.42186462757854, 330.60327606871743, 5509.393966663663, 5541.9168712469345, 5667.744951477183, 5728.25532680752, 5736.770529178833, 5592.7762889484375, 5598.328200615922, 5605.943940560594, 5620.747066382012, 5631.774729010845, 4343.218220720261, 4385.10105428388, 4400.471943366801, 4401.845935392262, 4404.361367601696, 4115.54728979812, 4344.175446312556, 4361.280388735855, 4414.690971631987, 4430.091831174617, 4240.469941257343, 4273.423087883127, 4289.485261768592, 4291.399204111427, 4300.612944834964, 4170.540310891164, 4299.6345310648785, 4304.225239456897, 4323.935140972888, 4329.571241490301, 3765.811709414518, 3771.679407250387, 3787.5833658297565, 3788.583255841855, 3813.733038687293, 5428.647137936061, 5569.443055694439, 5597.0, 5603.411641777596, 5603.719814009324, 4833.830815921426, 4924.975375123137, 4938.777755001033, 4944.87637809054, 5019.598432125421, 5854.76580936762, 5870.148828419898, 5879.353271140171, 5890.793822216202, 5907.822765317047, 4072.67857321327, 4130.731502452331, 4137.441445404862, 4138.79306034697, 4161.523893283492, 5829.621074630136, 6083.452489275986, 6088.238970128734, 6135.846603834895, 6200.906986395207, 4090.118545469058, 4158.584141585818, 4179.958200418017, 4192.287311157111, 4202.285611446062, 4206.41110244566, 4246.554111818276, 4248.383984322256, 4249.851255206115, 4261.680373971903, 4745.082776996095, 4946.653734238569, 4957.950420495821, 4972.055309491185, 4985.8005679772405, 5644.306707987587, 5914.4381283777975, 5931.139984702194, 5955.34491205967, 6006.969965150233, 1458.4968185975822, 1467.6350993576077, 1468.9706205875823, 1472.374240947593, 1477.6601381682274, 901.8466860633708, 906.6962567539948, 926.3700683535126, 934.9018353072829, 936.279065119854, 5133.332666753373, 5143.331366922351, 5151.7681704323395, 5169.25045868347, 5174.120399532013, 5343.0, 5343.679379237258, 5359.946400535945, 5395.973020134874, 5410.675359478444, 5094.898102038012, 5099.847004589868, 5135.151345515611, 5323.52088312046, 5756.856078598069, 3234.8706051757667, 3245.221146924768, 3247.6427592964756, 3249.2201871550656, 3261.967380326214, 6013.909791353133, 6337.0, 6338.683065846689, 6348.968255158695, 6356.0, 6140.938590614126, 6190.659513726789, 6218.844528886814, 6231.376862313823, 6252.718627661675, 6188.566800324024, 6198.8532121557655, 6211.863009180335, 6276.426665067301, 6311.715972781236, 5736.799212027559, 6014.165679467629, 6113.908291375722, 6119.785807496716, 6124.479419249414, 6023.698815059317, 6075.0, 6103.7253323601435, 6114.318562395199, 6157.384261573807, 5961.612495187799, 6210.254769427697, 6264.812055638338, 6304.05439184126, 6361.809145725636, 4297.290946993711, 4300.053988122608, 4302.182585308781, 4308.612224899774, 4367.388565600755, 5784.248047753765, 5931.466168044896, 6100.572959892765, 6110.847228819137, 6138.232720909887, 5879.265091863517, 5888.882222355443, 5894.528437724886, 5913.408659134052, 5924.081767326072, 5855.151003104611, 5862.94137058624, 5865.794697185578, 5877.823665290048, 5892.558058145571, 5619.775208991595, 5845.684720937925, 5875.882482350415, 5889.646621202742, 5896.941030589811, 5887.852803679943, 5924.11138329254, 5979.222701048836, 6021.0, 6062.90905636407, 5656.60403771732, 5790.0, 5795.449432303924, 5805.187273781589, 5806.5064469518875], "value": 4426.322853364966, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.864522772832, 670.7719375412358, 731.8609464201801, 818.918108189181, 846.6063280574533, 14688.779668304984, 15577.688446231068, 15625.531234062997, 15636.530904072868, 15642.0, 14755.55733328002, 15050.322735476902, 15077.246137693126, 15203.467878624251, 15216.69566608667, 826.1243082332732, 827.0117209934131, 834.511810590802, 837.351052933975, 837.5351679817699, 787.6613056385752, 795.9721409750659, 816.4040250617053, 817.0481389181597, 825.1830687619274, 856.9357298202628, 858.1547176031604, 860.5611138319471, 863.0290922711949, 865.1521508921261, 846.8391005708926, 847.474565769224, 848.1094850407079, 850.3069997951711, 853.5561508015797, 629.4775336470718, 630.6562923206864, 630.8927482328015, 632.2097378277153, 633.8763941031501, 15325.770113448307, 15360.615984600363, 15378.461753838674, 15407.691846163127, 15432.768508472382, 11968.222065565711, 12060.0, 12152.21010634306, 12360.938195308965, 12585.559505417266, 11957.0, 12065.095117866107, 12603.936980315131, 12701.174423662433, 12707.936460317731, 3859.8842034739005, 3875.8837234883, 3901.4147877818273, 3941.5270167580074, 4026.778527181004, 76398.61800690962, 76737.61631191864, 76884.0, 77073.61463192705, 77731.0, 10969.670909872717, 11038.282511636718, 11231.71920701989, 11354.205205635692, 11537.653870383901, 21764.673529897063, 21774.346769596938, 21778.34664960054, 21787.34637960832, 21910.780892191193, 8069.677212911418, 8329.916700833035, 8373.204545568162, 8630.913690863137, 8704.434211776213, 4490.550944905483, 4618.399608050999, 4657.67396282257, 4686.27362758773, 4921.680090794087, 3373.5614370132216, 3524.753267271318, 3527.9118022049142, 3537.8761743339373, 3546.04256850654, 582.5892745614332, 594.3580932592789, 596.6509591888707, 610.0452791381474, 615.9538034647419, 621.9098230756515, 710.4210068793916, 719.3274288540232, 721.3039416962656, 753.9821241324169, 8760.8685869712, 9083.227925626396, 9309.581068851918, 9346.672866449642, 9439.716808495756, 623.6975067092457, 637.8724255148989, 652.2108249018646, 652.3704625036862, 690.9827254318682, 4250.53244143144, 4720.881977950578, 4786.7845946931775, 4829.372181616367, 4842.975785121052, 74906.0, 110363.0, 117363.54500502383, 118012.0, 129054.0, 83656.58171709103, 108322.45838770756, 111309.0, 113392.29911551333, 113408.0, 77686.6115669418, 87117.89087720701, 87196.56401718078, 90446.54776726206, 91194.0, 9524.333296669167, 9720.75698107553, 9803.16673082796, 9961.49138780261, 10053.246006549392, 49562.0, 49796.0, 49925.50074499209, 49947.75026124846, 50874.0, 68025.0, 72791.0, 74851.62574187313, 75071.0, 75414.0, 12674.619761407173, 12826.102172847812, 12864.983534577686, 12878.613641590393, 12927.0, 13977.543720190455, 14222.217778022308, 14308.353183897803, 14334.126040427896, 14415.207163606103, 13681.17912925188, 13741.312934353042, 13781.379837907518, 13826.239556824472, 13951.930240348733, 12970.0, 13315.866841331463, 13496.46014159462, 13517.932410337886, 13588.796168057685, 13703.520376786764, 13757.17456952586, 13819.861801381858, 13829.654258643614, 13870.306484675928, 10406.791864162826, 10412.739681507719, 10534.26260161812, 10661.987111224422, 10741.731456713645, 10276.845847312446, 10383.948080259852, 10444.843327349943, 10546.314489558154, 10595.47022648849], "value": 7478.203751006405, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 105.0, 110.0, 114.0, 115.0, 112.0, 112.0, 112.0, 113.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 128.0, 155.0, 182.0, 127.0, 159.0, 161.0, 126.0, 198.0, 129.0], "value": 152.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 165.0, 165.0, 169.0, 163.0, 163.0, 167.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 169.0, 76.0, 77.0, 75.0, 77.0, 169.0, 74.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 89.0, 154.0, 85.0, 85.0, 85.0, 142.0, 85.0, 85.0, 143.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 149.0, 147.0, 147.0, 148.0, 148.0, 146.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 56.0, 55.0, 56.0, 57.0, 55.0, 56.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 63.0, 62.0, 62.0, 62.0, 63.0, 62.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 80.0, 79.0, 81.0, 81.0, 81.0, 101.0, 80.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 126.0, 125.0, 119.0, 121.0, 122.0, 130.0, 143.0, 144.0, 124.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 161.0, 158.0, 158.0, 158.0, 161.0, 157.0, 161.0, 164.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 63.0, 63.0, 63.0, 62.0, 64.0, 64.0, 64.0, 65.0], "value": 63.9, "unit": "score"}]}]} 05:31:12 INFO - Return code: 0 05:31:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:31:12 ERROR - # TBPL SUCCESS # 05:31:12 INFO - Running post-action listener: _resource_record_post_action 05:31:12 INFO - ##### 05:31:12 INFO - ##### Finished run-tests step (success) 05:31:12 INFO - ##### 05:31:12 INFO - Running post-run listener: _resource_record_post_run 05:31:12 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 552316928; Read time: 0; Write time: 529668 05:31:12 INFO - TinderboxPrint: CPU usage
13.5% 05:31:12 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:31:12 INFO - TinderboxPrint: I/O write bytes / time
552,316,928 / 529,668 05:31:12 INFO - TinderboxPrint: CPU idle
8,233.9 (86.5%) 05:31:12 INFO - TinderboxPrint: CPU user
1,220.8 (12.8%) 05:31:12 INFO - TinderboxPrint: Swap in / out
0 / 0 05:31:12 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 230625280; Read time: 0; Write time: 293068 05:31:12 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 294989824; Read time: 0; Write time: 233044 05:31:13 INFO - Running post-run listener: _upload_blobber_files 05:31:13 INFO - Blob upload gear active. 05:31:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:31:13 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 05:31:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:31:13 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:31:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:31:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:17 INFO - (blobuploader) - INFO - Done attempting. 05:31:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:31:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:31:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:18 INFO - (blobuploader) - INFO - Done attempting. 05:31:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:31:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:31:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:19 INFO - (blobuploader) - INFO - Done attempting. 05:31:19 INFO - (blobuploader) - INFO - Iteration through files over. 05:31:19 INFO - Return code: 0 05:31:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:31:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:31:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c9e43ab224d378c7f7b1e403320f00e9a6978d20d4064bcf09c6b9e743e4603c959d89335f83dd2df834ffe5b75a5a437d04f1e0109a1e34fd6d9a831626dd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1048b1191e6ee0b1b282ebbc5c9210f32a446654e5ffa4e4ead28d9d5ac299b193618d8b24aba1a9874300f14ce5c5d08aa2da3ef374a419f66cea9dc60cb744", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ec564d680eb5c8e0a66334ae61a0563ed55fe5f5a9e8d882d3e16a07180eb10b1216642e14dcfc47b2669c78db4a5372abb67678fef2f854204c92e94b7200a"} 05:31:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:31:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:31:19 INFO - Contents: 05:31:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c9e43ab224d378c7f7b1e403320f00e9a6978d20d4064bcf09c6b9e743e4603c959d89335f83dd2df834ffe5b75a5a437d04f1e0109a1e34fd6d9a831626dd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1048b1191e6ee0b1b282ebbc5c9210f32a446654e5ffa4e4ead28d9d5ac299b193618d8b24aba1a9874300f14ce5c5d08aa2da3ef374a419f66cea9dc60cb744", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ec564d680eb5c8e0a66334ae61a0563ed55fe5f5a9e8d882d3e16a07180eb10b1216642e14dcfc47b2669c78db4a5372abb67678fef2f854204c92e94b7200a"} 05:31:19 INFO - Running post-run listener: copy_logs_to_upload_dir 05:31:19 INFO - Copying logs to upload dir... 05:31:19 INFO - mkdir: /builds/slave/test/build/upload/logs 05:31:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.659468 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-24 05:31:18.632362) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 05:31:18.635683) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c9e43ab224d378c7f7b1e403320f00e9a6978d20d4064bcf09c6b9e743e4603c959d89335f83dd2df834ffe5b75a5a437d04f1e0109a1e34fd6d9a831626dd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1048b1191e6ee0b1b282ebbc5c9210f32a446654e5ffa4e4ead28d9d5ac299b193618d8b24aba1a9874300f14ce5c5d08aa2da3ef374a419f66cea9dc60cb744", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ec564d680eb5c8e0a66334ae61a0563ed55fe5f5a9e8d882d3e16a07180eb10b1216642e14dcfc47b2669c78db4a5372abb67678fef2f854204c92e94b7200a"} build_url:https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011156 build_url: 'https://queue.taskcluster.net/v1/task/H5xSstgaRQ6-mUGxW0l7yQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3c9e43ab224d378c7f7b1e403320f00e9a6978d20d4064bcf09c6b9e743e4603c959d89335f83dd2df834ffe5b75a5a437d04f1e0109a1e34fd6d9a831626dd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1048b1191e6ee0b1b282ebbc5c9210f32a446654e5ffa4e4ead28d9d5ac299b193618d8b24aba1a9874300f14ce5c5d08aa2da3ef374a419f66cea9dc60cb744", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ec564d680eb5c8e0a66334ae61a0563ed55fe5f5a9e8d882d3e16a07180eb10b1216642e14dcfc47b2669c78db4a5372abb67678fef2f854204c92e94b7200a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 05:31:18.661216) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:31:18.661557) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1466770229.106882-1307484846 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:31:18.744500) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 05:31:18.744810) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 05:31:18.745091) ========= ========= Total master_lag: 0.17 =========