builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1465484913.32 results: success (0) buildid: 20160609053030 builduid: 79d78e7ccab64da69e60f325998e2187 revision: 1c86ba5d7a5b9cb16ef3ad77ff740688a923108a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 08:08:33.323664) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 08:08:33.324716) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 08:08:33.325405) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 08:08:33.342002) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 08:08:33.342624) ========= 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=33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 08:08:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2016-06-09 08:08:33 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115012 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 08:08:33.476869) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 08:08:33.477433) ========= 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=33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020873 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 08:08:33.530960) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 08:08:33.531796) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1c86ba5d7a5b9cb16ef3ad77ff740688a923108a --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 1c86ba5d7a5b9cb16ef3ad77ff740688a923108a --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=33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 08:08:33,872 truncating revision to first 12 chars 2016-06-09 08:08:33,872 Setting DEBUG logging. 2016-06-09 08:08:33,872 attempt 1/10 2016-06-09 08:08:33,872 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1c86ba5d7a5b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 08:08:34,233 unpacking tar archive at: fx-team-1c86ba5d7a5b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.737445 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 08:08:34.288625) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 08:08:34.289732) ========= script_repo_revision: 1c86ba5d7a5b9cb16ef3ad77ff740688a923108a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 08:08:34.290638) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 08:08:34.290958) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 08:08:34.302107) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-09 08:08:34.302756) ========= /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=33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:08:34 INFO - MultiFileLogger online at 20160609 08:08:34 in /builds/slave/test 08:08:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:08:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:08:34 INFO - {'append_to_log': False, 08:08:34 INFO - 'base_work_dir': '/builds/slave/test', 08:08:34 INFO - 'blob_upload_branch': 'Fx-Team', 08:08:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:08:34 INFO - 'branch': 'Fx-Team', 08:08:34 INFO - 'buildbot_json_path': 'buildprops.json', 08:08:34 INFO - 'config_files': ('talos/linux_config.py',), 08:08:34 INFO - 'default_actions': ('clobber', 08:08:34 INFO - 'read-buildbot-config', 08:08:34 INFO - 'download-and-extract', 08:08:34 INFO - 'populate-webroot', 08:08:34 INFO - 'create-virtualenv', 08:08:34 INFO - 'install', 08:08:34 INFO - 'run-tests'), 08:08:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:08:34 INFO - 'download_minidump_stackwalk': True, 08:08:34 INFO - 'download_symbols': 'ondemand', 08:08:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:08:34 INFO - 'tooltool.py': '/tools/tooltool.py', 08:08:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:08:34 INFO - '/tools/misc-python/virtualenv.py')}, 08:08:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:08:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:08:34 INFO - 'installer_path': 'installer.exe', 08:08:34 INFO - 'log_level': 'info', 08:08:34 INFO - 'log_name': 'talos', 08:08:34 INFO - 'log_to_console': True, 08:08:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:08:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:08:34 INFO - 'opt_config_files': (), 08:08:34 INFO - 'pip_index': False, 08:08:34 INFO - 'sps_profile': False, 08:08:34 INFO - 'sps_profile_interval': 0, 08:08:34 INFO - 'suite': 'dromaeojs-e10s', 08:08:34 INFO - 'system_bits': '32', 08:08:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:08:34 INFO - 'title': 'talos-linux64-ix-063', 08:08:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:08:34 INFO - 'use_talos_json': True, 08:08:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:08:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:08:34 INFO - 'work_dir': 'build'} 08:08:34 INFO - ##### 08:08:34 INFO - ##### Running clobber step. 08:08:34 INFO - ##### 08:08:34 INFO - Running pre-action listener: _resource_record_pre_action 08:08:34 INFO - Running main action method: clobber 08:08:34 INFO - rmtree: /builds/slave/test/build 08:08:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:08:35 INFO - Running post-action listener: _resource_record_post_action 08:08:35 INFO - ##### 08:08:35 INFO - ##### Finished clobber step (success) 08:08:35 INFO - ##### 08:08:35 INFO - ##### 08:08:35 INFO - ##### Running read-buildbot-config step. 08:08:35 INFO - ##### 08:08:35 INFO - Running pre-action listener: _resource_record_pre_action 08:08:35 INFO - Running main action method: read_buildbot_config 08:08:35 INFO - Using buildbot properties: 08:08:35 INFO - { 08:08:35 INFO - "project": "", 08:08:35 INFO - "product": "firefox", 08:08:35 INFO - "script_repo_revision": "production", 08:08:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:08:35 INFO - "repository": "", 08:08:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:08:35 INFO - "buildid": "20160609053030", 08:08:35 INFO - "pgo_build": "True", 08:08:35 INFO - "basedir": "/builds/slave/test", 08:08:35 INFO - "buildnumber": 446, 08:08:35 INFO - "slavename": "talos-linux64-ix-063", 08:08:35 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:08:35 INFO - "platform": "ubuntu64_hw", 08:08:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:08:35 INFO - "branch": "fx-team", 08:08:35 INFO - "repo_path": "integration/fx-team", 08:08:35 INFO - "revision": "1c86ba5d7a5b9cb16ef3ad77ff740688a923108a", 08:08:35 INFO - "stage_platform": "linux64-pgo", 08:08:35 INFO - "builduid": "79d78e7ccab64da69e60f325998e2187", 08:08:35 INFO - "slavebuilddir": "test" 08:08:35 INFO - } 08:08:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:08:35 INFO - Running post-action listener: _resource_record_post_action 08:08:35 INFO - ##### 08:08:35 INFO - ##### Finished read-buildbot-config step (success) 08:08:35 INFO - ##### 08:08:35 INFO - ##### 08:08:35 INFO - ##### Running download-and-extract step. 08:08:35 INFO - ##### 08:08:35 INFO - Running pre-action listener: _resource_record_pre_action 08:08:35 INFO - Running main action method: download_and_extract 08:08:35 INFO - mkdir: /builds/slave/test/build/tests 08:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:35 INFO - https://queue.taskcluster.net/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:08:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:08:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:08:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:08:35 INFO - Downloaded 1361 bytes. 08:08:35 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:08:35 INFO - Using the following test package requirements: 08:08:35 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:35 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:08:35 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:08:35 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:35 INFO - u'jsshell-linux-x86_64.zip'], 08:08:35 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:08:35 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:35 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:08:35 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:08:35 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:08:35 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:08:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:35 INFO - https://queue.taskcluster.net/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:08:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:08:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:08:37 INFO - Downloaded 24452537 bytes. 08:08:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:08:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:08:38 INFO - Return code: 0 08:08:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:08: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')]} 08:08:38 INFO - https://queue.taskcluster.net/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:08:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:08:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:08:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:08:39 INFO - Downloaded 24452537 bytes. 08:08:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:08:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:08:43 INFO - Return code: 0 08:08: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')]} 08:08:43 INFO - https://queue.taskcluster.net/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:08:44 INFO - Downloaded 10833377 bytes. 08:08:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:08:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:08:44 INFO - Return code: 0 08:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:44 INFO - https://queue.taskcluster.net/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:08:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:08:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:08:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:08:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:08:47 INFO - Downloaded 59353238 bytes. 08:08:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:08:47 INFO - mkdir: /builds/slave/test/properties 08:08:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:08:47 INFO - Writing to file /builds/slave/test/properties/build_url 08:08:47 INFO - Contents: 08:08:47 INFO - build_url:https://queue.taskcluster.net/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:08:48 INFO - Running post-action listener: _resource_record_post_action 08:08:48 INFO - Running post-action listener: set_extra_try_arguments 08:08:48 INFO - ##### 08:08:48 INFO - ##### Finished download-and-extract step (success) 08:08:48 INFO - ##### 08:08:48 INFO - ##### 08:08:48 INFO - ##### Running populate-webroot step. 08:08:48 INFO - ##### 08:08:48 INFO - Running pre-action listener: _resource_record_pre_action 08:08:48 INFO - Running main action method: populate_webroot 08:08:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:08:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:08:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:08:48 INFO - '--tppagecycles', 08:08:48 INFO - '7'], 08:08:48 INFO - 'tests': ['tsvgm']}}, 08:08:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:08:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:08:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:08:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:08:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:08:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:08:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:48 INFO - 'talos_options': ['--disable-e10s'], 08:08:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:48 INFO - 'talos_options': ['--disable-e10s'], 08:08:48 INFO - 'tests': ['damp', 'tps']}, 08:08:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:48 INFO - 'tests': ['damp', 'tps']}, 08:08:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:08:48 INFO - 'tests': ['dromaeo_dom']}, 08:08:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:08:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:08:48 INFO - 'tests': ['a11yr', 08:08:48 INFO - 'ts_paint', 08:08:48 INFO - 'tpaint', 08:08:48 INFO - 'sessionrestore', 08:08:48 INFO - 'sessionrestore_no_auto_restore', 08:08:48 INFO - 'tabpaint']}, 08:08:48 INFO - 'other-e10s': {'tests': ['a11yr', 08:08:48 INFO - 'ts_paint', 08:08:48 INFO - 'tpaint', 08:08:48 INFO - 'sessionrestore', 08:08:48 INFO - 'sessionrestore_no_auto_restore', 08:08:48 INFO - 'tabpaint']}, 08:08:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:08:48 INFO - 'ts_paint', 08:08:48 INFO - 'tpaint', 08:08:48 INFO - 'sessionrestore', 08:08:48 INFO - 'sessionrestore_no_auto_restore', 08:08:48 INFO - 'tabpaint']}, 08:08:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:08:48 INFO - 'ts_paint', 08:08:48 INFO - 'tpaint', 08:08:48 INFO - 'sessionrestore', 08:08:48 INFO - 'sessionrestore_no_auto_restore', 08:08:48 INFO - 'tabpaint']}, 08:08:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:08:48 INFO - 'tests': ['a11yr', 08:08:48 INFO - 'ts_paint', 08:08:48 INFO - 'tpaint', 08:08:48 INFO - 'sessionrestore', 08:08:48 INFO - 'sessionrestore_no_auto_restore', 08:08:48 INFO - 'tabpaint']}, 08:08:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:08:48 INFO - 'tests': ['a11yr', 08:08:48 INFO - 'ts_paint', 08:08:48 INFO - 'tpaint', 08:08:48 INFO - 'sessionrestore', 08:08:48 INFO - 'sessionrestore_no_auto_restore', 08:08:48 INFO - 'tabpaint']}, 08:08:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:08:48 INFO - 'tests': ['tsvgx', 08:08:48 INFO - 'tsvgr_opacity', 08:08:48 INFO - 'tart', 08:08:48 INFO - 'tscrollx', 08:08:48 INFO - 'cart']}, 08:08:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:08:48 INFO - 'tsvgr_opacity', 08:08:48 INFO - 'tart', 08:08:48 INFO - 'tscrollx', 08:08:48 INFO - 'cart']}, 08:08:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:48 INFO - 'talos_options': ['--disable-e10s'], 08:08:48 INFO - 'tests': ['tp5o']}, 08:08:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:48 INFO - 'tests': ['tp5o']}, 08:08:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:48 INFO - 'talos_options': ['--disable-e10s', 08:08:48 INFO - '--xperf_path', 08:08:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:48 INFO - 'tests': ['tp5n']}, 08:08:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:48 INFO - 'talos_options': ['--xperf_path', 08:08:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:48 INFO - 'tests': ['tp5n']}}, 08:08:48 INFO - 'talos.zip': {'path': '', 08:08:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:08:48 INFO - Running post-action listener: _resource_record_post_action 08:08:48 INFO - ##### 08:08:48 INFO - ##### Finished populate-webroot step (success) 08:08:48 INFO - ##### 08:08:48 INFO - ##### 08:08:48 INFO - ##### Running create-virtualenv step. 08:08:48 INFO - ##### 08:08:48 INFO - Running pre-action listener: _resource_record_pre_action 08:08:48 INFO - Running main action method: create_virtualenv 08:08:48 INFO - Creating virtualenv /builds/slave/test/build/venv 08:08:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:08:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:08:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:08:48 INFO - Using real prefix '/usr' 08:08:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:08:48 INFO - Installing distribute.............................................................................................................................................................................................done. 08:08:50 INFO - Installing pip.................done. 08:08:50 INFO - Return code: 0 08:08:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:50 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 0x7faf10195f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b401c0>, '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 0x1b410c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b41550>, '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': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:08:50 INFO - Using env: {'DISPLAY': ':0', 08:08:50 INFO - 'HOME': '/home/cltbld', 08:08:50 INFO - 'LANG': 'en_US.UTF-8', 08:08:50 INFO - 'LANGUAGE': 'en_US:en', 08:08:50 INFO - 'LOGNAME': 'cltbld', 08:08:50 INFO - 'MAIL': '/var/mail/cltbld', 08:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:50 INFO - 'MOZ_NO_REMOTE': '1', 08:08:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:50 INFO - 'NO_EM_RESTART': '1', 08:08:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:50 INFO - 'PWD': '/builds/slave/test', 08:08:50 INFO - 'SHELL': '/bin/bash', 08:08:50 INFO - 'SHLVL': '1', 08:08:50 INFO - 'TERM': 'linux', 08:08:50 INFO - 'TMOUT': '86400', 08:08:50 INFO - 'USER': 'cltbld', 08:08:50 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 08:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:50 INFO - '_': '/tools/buildbot/bin/python'} 08:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:08:50 INFO - Cleaning up... 08:08:50 INFO - Return code: 0 08:08:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:50 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 0x7faf10195f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b401c0>, '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 0x1b410c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b41550>, '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': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:08:50 INFO - Using env: {'DISPLAY': ':0', 08:08:50 INFO - 'HOME': '/home/cltbld', 08:08:50 INFO - 'LANG': 'en_US.UTF-8', 08:08:50 INFO - 'LANGUAGE': 'en_US:en', 08:08:50 INFO - 'LOGNAME': 'cltbld', 08:08:50 INFO - 'MAIL': '/var/mail/cltbld', 08:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:50 INFO - 'MOZ_NO_REMOTE': '1', 08:08:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:50 INFO - 'NO_EM_RESTART': '1', 08:08:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:50 INFO - 'PWD': '/builds/slave/test', 08:08:50 INFO - 'SHELL': '/bin/bash', 08:08:50 INFO - 'SHLVL': '1', 08:08:50 INFO - 'TERM': 'linux', 08:08:50 INFO - 'TMOUT': '86400', 08:08:50 INFO - 'USER': 'cltbld', 08:08:50 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 08:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:50 INFO - '_': '/tools/buildbot/bin/python'} 08:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:51 INFO - Downloading/unpacking psutil>=3.1.1 08:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:08:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:53 INFO - Installing collected packages: psutil 08:08:53 INFO - Running setup.py install for psutil 08:08:53 INFO - building 'psutil._psutil_linux' extension 08:08:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:08:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:08:53 INFO - building 'psutil._psutil_posix' extension 08:08:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:08:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:08:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:53 INFO - Successfully installed psutil 08:08:53 INFO - Cleaning up... 08:08:53 INFO - Return code: 0 08:08:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:53 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 0x7faf10195f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b401c0>, '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 0x1b410c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b41550>, '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': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:08:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:08:53 INFO - Using env: {'DISPLAY': ':0', 08:08:53 INFO - 'HOME': '/home/cltbld', 08:08:53 INFO - 'LANG': 'en_US.UTF-8', 08:08:53 INFO - 'LANGUAGE': 'en_US:en', 08:08:53 INFO - 'LOGNAME': 'cltbld', 08:08:53 INFO - 'MAIL': '/var/mail/cltbld', 08:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:53 INFO - 'MOZ_NO_REMOTE': '1', 08:08:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:53 INFO - 'NO_EM_RESTART': '1', 08:08:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:53 INFO - 'PWD': '/builds/slave/test', 08:08:53 INFO - 'SHELL': '/bin/bash', 08:08:53 INFO - 'SHLVL': '1', 08:08:53 INFO - 'TERM': 'linux', 08:08:53 INFO - 'TMOUT': '86400', 08:08:53 INFO - 'USER': 'cltbld', 08:08:53 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 08:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:53 INFO - '_': '/tools/buildbot/bin/python'} 08:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:08:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:08:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:08:55 INFO - Installing collected packages: mozsystemmonitor 08:08:55 INFO - Running setup.py install for mozsystemmonitor 08:08:55 INFO - Successfully installed mozsystemmonitor 08:08:55 INFO - Cleaning up... 08:08:55 INFO - Return code: 0 08:08:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf10195f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b401c0>, '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 0x1b410c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b41550>, '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': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:08:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:08:55 INFO - Using env: {'DISPLAY': ':0', 08:08:55 INFO - 'HOME': '/home/cltbld', 08:08:55 INFO - 'LANG': 'en_US.UTF-8', 08:08:55 INFO - 'LANGUAGE': 'en_US:en', 08:08:55 INFO - 'LOGNAME': 'cltbld', 08:08:55 INFO - 'MAIL': '/var/mail/cltbld', 08:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:55 INFO - 'MOZ_NO_REMOTE': '1', 08:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:55 INFO - 'NO_EM_RESTART': '1', 08:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:55 INFO - 'PWD': '/builds/slave/test', 08:08:55 INFO - 'SHELL': '/bin/bash', 08:08:55 INFO - 'SHLVL': '1', 08:08:55 INFO - 'TERM': 'linux', 08:08:55 INFO - 'TMOUT': '86400', 08:08:55 INFO - 'USER': 'cltbld', 08:08:55 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 08:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:55 INFO - '_': '/tools/buildbot/bin/python'} 08:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:56 INFO - Downloading/unpacking jsonschema==2.5.1 08:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:08:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:58 INFO - Downloading functools32-3.2.3-2.tar.gz 08:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:08:58 INFO - warning: no files found matching '*.txt' 08:08:58 INFO - no previously-included directories found matching 'build' 08:08:58 INFO - no previously-included directories found matching 'dist' 08:08:58 INFO - no previously-included directories found matching '.git*' 08:08:58 INFO - Installing collected packages: jsonschema, functools32 08:08:58 INFO - Running setup.py install for functools32 08:08:58 INFO - warning: no files found matching '*.txt' 08:08:58 INFO - no previously-included directories found matching 'build' 08:08:58 INFO - no previously-included directories found matching 'dist' 08:08:58 INFO - no previously-included directories found matching '.git*' 08:08:58 INFO - Successfully installed jsonschema functools32 08:08:58 INFO - Cleaning up... 08:08:58 INFO - Return code: 0 08:08:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:58 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 0x7faf10195f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b401c0>, '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 0x1b410c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b41550>, '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': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:08:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:08:58 INFO - Using env: {'DISPLAY': ':0', 08:08:58 INFO - 'HOME': '/home/cltbld', 08:08:58 INFO - 'LANG': 'en_US.UTF-8', 08:08:58 INFO - 'LANGUAGE': 'en_US:en', 08:08:58 INFO - 'LOGNAME': 'cltbld', 08:08:58 INFO - 'MAIL': '/var/mail/cltbld', 08:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:58 INFO - 'MOZ_NO_REMOTE': '1', 08:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:58 INFO - 'NO_EM_RESTART': '1', 08:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:58 INFO - 'PWD': '/builds/slave/test', 08:08:58 INFO - 'SHELL': '/bin/bash', 08:08:58 INFO - 'SHLVL': '1', 08:08:58 INFO - 'TERM': 'linux', 08:08:58 INFO - 'TMOUT': '86400', 08:08:58 INFO - 'USER': 'cltbld', 08:08:58 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 08:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:58 INFO - '_': '/tools/buildbot/bin/python'} 08:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:58 INFO - Downloading/unpacking blobuploader==1.2.4 08:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:00 INFO - Downloading blobuploader-1.2.4.tar.gz 08:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:09:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:09:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:01 INFO - Downloading docopt-0.6.1.tar.gz 08:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:09:01 INFO - Installing collected packages: blobuploader, requests, docopt 08:09:01 INFO - Running setup.py install for blobuploader 08:09:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:09:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:09:01 INFO - Running setup.py install for requests 08:09:01 INFO - Running setup.py install for docopt 08:09:01 INFO - Successfully installed blobuploader requests docopt 08:09:01 INFO - Cleaning up... 08:09:01 INFO - Return code: 0 08:09:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:01 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 0x7faf10195f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b401c0>, '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 0x1b410c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b41550>, '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': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:09:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:01 INFO - Using env: {'DISPLAY': ':0', 08:09:01 INFO - 'HOME': '/home/cltbld', 08:09:01 INFO - 'LANG': 'en_US.UTF-8', 08:09:01 INFO - 'LANGUAGE': 'en_US:en', 08:09:01 INFO - 'LOGNAME': 'cltbld', 08:09:01 INFO - 'MAIL': '/var/mail/cltbld', 08:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:01 INFO - 'MOZ_NO_REMOTE': '1', 08:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:01 INFO - 'NO_EM_RESTART': '1', 08:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:01 INFO - 'PWD': '/builds/slave/test', 08:09:01 INFO - 'SHELL': '/bin/bash', 08:09:01 INFO - 'SHLVL': '1', 08:09:01 INFO - 'TERM': 'linux', 08:09:01 INFO - 'TMOUT': '86400', 08:09:01 INFO - 'USER': 'cltbld', 08:09:01 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 08:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:01 INFO - '_': '/tools/buildbot/bin/python'} 08:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:02 INFO - Running setup.py (path:/tmp/pip-tJ3HIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:02 INFO - Running setup.py (path:/tmp/pip-ffCYFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:02 INFO - Running setup.py (path:/tmp/pip-R5JC6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:02 INFO - Running setup.py (path:/tmp/pip-Q2P197-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:02 INFO - Running setup.py (path:/tmp/pip-utrGo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:02 INFO - Running setup.py (path:/tmp/pip-DMYDhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:02 INFO - Running setup.py (path:/tmp/pip-7FereA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:02 INFO - Running setup.py (path:/tmp/pip-WFVsGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:02 INFO - Running setup.py (path:/tmp/pip-3akMBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:02 INFO - Running setup.py (path:/tmp/pip-vRqM75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:02 INFO - Running setup.py (path:/tmp/pip-QUMQGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:02 INFO - Running setup.py (path:/tmp/pip-FdtyzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:03 INFO - Running setup.py (path:/tmp/pip-WvHJ5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:03 INFO - Running setup.py (path:/tmp/pip-yzs6oG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:03 INFO - Running setup.py (path:/tmp/pip-zicjDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:03 INFO - Running setup.py (path:/tmp/pip-Dg_XjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:03 INFO - Running setup.py (path:/tmp/pip-4Bmsif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:09:03 INFO - Running setup.py install for manifestparser 08:09:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:09:03 INFO - Running setup.py install for mozcrash 08:09:03 INFO - Running setup.py install for mozdebug 08:09:03 INFO - Running setup.py install for mozdevice 08:09:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:09:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:09:03 INFO - Running setup.py install for mozfile 08:09:03 INFO - Running setup.py install for mozhttpd 08:09:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:09:04 INFO - Running setup.py install for mozinfo 08:09:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:09:04 INFO - Running setup.py install for mozInstall 08:09:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:09:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:09:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:09:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:09:04 INFO - Running setup.py install for mozleak 08:09:04 INFO - Running setup.py install for mozlog 08:09:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:09:04 INFO - Running setup.py install for moznetwork 08:09:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:09:04 INFO - Running setup.py install for mozprocess 08:09:04 INFO - Running setup.py install for mozprofile 08:09:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:09:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:09:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:09:04 INFO - Running setup.py install for mozrunner 08:09:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:09:04 INFO - Running setup.py install for mozscreenshot 08:09:04 INFO - Running setup.py install for moztest 08:09:05 INFO - Running setup.py install for mozversion 08:09:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:09:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:09:05 INFO - Cleaning up... 08:09:05 INFO - Return code: 0 08:09:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:05 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 0x7faf10195f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b401c0>, '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 0x1b410c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b41550>, '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': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:09:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:05 INFO - Using env: {'DISPLAY': ':0', 08:09:05 INFO - 'HOME': '/home/cltbld', 08:09:05 INFO - 'LANG': 'en_US.UTF-8', 08:09:05 INFO - 'LANGUAGE': 'en_US:en', 08:09:05 INFO - 'LOGNAME': 'cltbld', 08:09:05 INFO - 'MAIL': '/var/mail/cltbld', 08:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:05 INFO - 'MOZ_NO_REMOTE': '1', 08:09:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:05 INFO - 'NO_EM_RESTART': '1', 08:09:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:05 INFO - 'PWD': '/builds/slave/test', 08:09:05 INFO - 'SHELL': '/bin/bash', 08:09:05 INFO - 'SHLVL': '1', 08:09:05 INFO - 'TERM': 'linux', 08:09:05 INFO - 'TMOUT': '86400', 08:09:05 INFO - 'USER': 'cltbld', 08:09:05 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 08:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:05 INFO - '_': '/tools/buildbot/bin/python'} 08:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:05 INFO - Running setup.py (path:/tmp/pip-7d33jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:05 INFO - Running setup.py (path:/tmp/pip-zR7PTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:05 INFO - Running setup.py (path:/tmp/pip-_fMXZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:05 INFO - Running setup.py (path:/tmp/pip-b5uaqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:05 INFO - Running setup.py (path:/tmp/pip-bM3tFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:05 INFO - Running setup.py (path:/tmp/pip-dOpLaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:05 INFO - Running setup.py (path:/tmp/pip-DADhzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:06 INFO - Running setup.py (path:/tmp/pip-CLDeVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:06 INFO - Running setup.py (path:/tmp/pip-2TgDml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:06 INFO - Running setup.py (path:/tmp/pip-_8IePa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:06 INFO - Running setup.py (path:/tmp/pip-HWVQhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:06 INFO - Running setup.py (path:/tmp/pip-C3Po9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:06 INFO - Running setup.py (path:/tmp/pip-m2Sc9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:06 INFO - Running setup.py (path:/tmp/pip-XumxcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:06 INFO - Running setup.py (path:/tmp/pip-1Xmcvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:06 INFO - Running setup.py (path:/tmp/pip-YL3khk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:06 INFO - Running setup.py (path:/tmp/pip-XB2iXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:09:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09: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 08:09:08 INFO - Downloading blessings-1.6.tar.gz 08:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:09:08 INFO - Installing collected packages: blessings 08:09:08 INFO - Running setup.py install for blessings 08:09:08 INFO - Successfully installed blessings 08:09:08 INFO - Cleaning up... 08:09:08 INFO - Return code: 0 08:09:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:09:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:09 INFO - Reading from file tmpfile_stdout 08:09:09 INFO - Current package versions: 08:09:09 INFO - argparse == 1.2.1 08:09:09 INFO - blessings == 1.6 08:09:09 INFO - blobuploader == 1.2.4 08:09:09 INFO - docopt == 0.6.1 08:09:09 INFO - functools32 == 3.2.3-2 08:09:09 INFO - jsonschema == 2.5.1 08:09:09 INFO - manifestparser == 1.1 08:09:09 INFO - mozInstall == 1.12 08:09:09 INFO - mozcrash == 0.17 08:09:09 INFO - mozdebug == 0.1 08:09:09 INFO - mozdevice == 0.48 08:09:09 INFO - mozfile == 1.2 08:09:09 INFO - mozhttpd == 0.7 08:09:09 INFO - mozinfo == 0.9 08:09:09 INFO - mozleak == 0.1 08:09:09 INFO - mozlog == 3.2 08:09:09 INFO - moznetwork == 0.27 08:09:09 INFO - mozprocess == 0.22 08:09:09 INFO - mozprofile == 0.28 08:09:09 INFO - mozrunner == 6.11 08:09:09 INFO - mozscreenshot == 0.1 08:09:09 INFO - mozsystemmonitor == 0.3 08:09:09 INFO - moztest == 0.7 08:09:09 INFO - mozversion == 1.4 08:09:09 INFO - psutil == 3.1.1 08:09:09 INFO - requests == 1.2.3 08:09:09 INFO - wsgiref == 0.1.2 08:09:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:09 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 0x7faf10195f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b401c0>, '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 0x1b410c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b41550>, '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': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:09:09 INFO - Using env: {'DISPLAY': ':0', 08:09:09 INFO - 'HOME': '/home/cltbld', 08:09:09 INFO - 'LANG': 'en_US.UTF-8', 08:09:09 INFO - 'LANGUAGE': 'en_US:en', 08:09:09 INFO - 'LOGNAME': 'cltbld', 08:09:09 INFO - 'MAIL': '/var/mail/cltbld', 08:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:09 INFO - 'MOZ_NO_REMOTE': '1', 08:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:09 INFO - 'NO_EM_RESTART': '1', 08:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:09 INFO - 'PWD': '/builds/slave/test', 08:09:09 INFO - 'SHELL': '/bin/bash', 08:09:09 INFO - 'SHLVL': '1', 08:09:09 INFO - 'TERM': 'linux', 08:09:09 INFO - 'TMOUT': '86400', 08:09:09 INFO - 'USER': 'cltbld', 08:09:09 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 08:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:09 INFO - '_': '/tools/buildbot/bin/python'} 08:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:09:09 INFO - Cleaning up... 08:09:09 INFO - Return code: 0 08:09:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:09 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 0x7faf10195f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b401c0>, '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 0x1b410c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b41550>, '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': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:09:09 INFO - Using env: {'DISPLAY': ':0', 08:09:09 INFO - 'HOME': '/home/cltbld', 08:09:09 INFO - 'LANG': 'en_US.UTF-8', 08:09:09 INFO - 'LANGUAGE': 'en_US:en', 08:09:09 INFO - 'LOGNAME': 'cltbld', 08:09:09 INFO - 'MAIL': '/var/mail/cltbld', 08:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:09 INFO - 'MOZ_NO_REMOTE': '1', 08:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:09 INFO - 'NO_EM_RESTART': '1', 08:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:09 INFO - 'PWD': '/builds/slave/test', 08:09:09 INFO - 'SHELL': '/bin/bash', 08:09:09 INFO - 'SHLVL': '1', 08:09:09 INFO - 'TERM': 'linux', 08:09:09 INFO - 'TMOUT': '86400', 08:09:09 INFO - 'USER': 'cltbld', 08:09:09 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 08:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:09 INFO - '_': '/tools/buildbot/bin/python'} 08:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:09:09 INFO - Cleaning up... 08:09:09 INFO - Return code: 0 08:09:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:09 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 0x7faf10195f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab1350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b401c0>, '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 0x1b410c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b41550>, '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': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:09:09 INFO - Using env: {'DISPLAY': ':0', 08:09:09 INFO - 'HOME': '/home/cltbld', 08:09:09 INFO - 'LANG': 'en_US.UTF-8', 08:09:09 INFO - 'LANGUAGE': 'en_US:en', 08:09:09 INFO - 'LOGNAME': 'cltbld', 08:09:09 INFO - 'MAIL': '/var/mail/cltbld', 08:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:09 INFO - 'MOZ_NO_REMOTE': '1', 08:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:09 INFO - 'NO_EM_RESTART': '1', 08:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:09 INFO - 'PWD': '/builds/slave/test', 08:09:09 INFO - 'SHELL': '/bin/bash', 08:09:09 INFO - 'SHLVL': '1', 08:09:09 INFO - 'TERM': 'linux', 08:09:09 INFO - 'TMOUT': '86400', 08:09:09 INFO - 'USER': 'cltbld', 08:09:09 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 08:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:09 INFO - '_': '/tools/buildbot/bin/python'} 08:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:09 INFO - Downloading/unpacking flake8 08:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:09:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:09:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:09:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:09:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:09:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:09:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:09:12 INFO - no previously-included directories found matching 'docs/_build' 08:09:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:09:12 INFO - Running setup.py install for pep8 08:09:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:09:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:09:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:09:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:09:12 INFO - no previously-included directories found matching 'docs/_build' 08:09:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:09:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:09:12 INFO - Cleaning up... 08:09:12 INFO - Return code: 0 08:09:12 INFO - Running post-action listener: _resource_record_post_action 08:09:12 INFO - Running post-action listener: _start_resource_monitoring 08:09:12 INFO - Starting resource monitoring. 08:09:12 INFO - ##### 08:09:12 INFO - ##### Finished create-virtualenv step (success) 08:09:12 INFO - ##### 08:09:12 INFO - ##### 08:09:12 INFO - ##### Running install step. 08:09:12 INFO - ##### 08:09:12 INFO - Running pre-action listener: _resource_record_pre_action 08:09:12 INFO - Running main action method: install 08:09:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:12 INFO - Reading from file tmpfile_stdout 08:09:12 INFO - Detecting whether we're running mozinstall >=1.0... 08:09:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:09:12 INFO - Reading from file tmpfile_stdout 08:09:12 INFO - Output received: 08:09:12 INFO - Usage: mozinstall [options] installer 08:09:12 INFO - Options: 08:09:12 INFO - -h, --help show this help message and exit 08:09:12 INFO - -d DEST, --destination=DEST 08:09:12 INFO - Directory to install application into. [default: 08:09:12 INFO - "/builds/slave/test"] 08:09:12 INFO - --app=APP Application being installed. [default: firefox] 08:09:12 INFO - mkdir: /builds/slave/test/build/application 08:09:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:09:29 INFO - Reading from file tmpfile_stdout 08:09:29 INFO - Output received: 08:09:29 INFO - /builds/slave/test/build/application/firefox/firefox 08:09:36 INFO - Running post-action listener: _resource_record_post_action 08:09:36 INFO - ##### 08:09:36 INFO - ##### Finished install step (success) 08:09:36 INFO - ##### 08:09:36 INFO - ##### 08:09:36 INFO - ##### Running run-tests step. 08:09:36 INFO - ##### 08:09:36 INFO - Running pre-action listener: _resource_record_pre_action 08:09:36 INFO - Running main action method: run_tests 08:09:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:09:36 INFO - Python 2.7.3 08:09:36 INFO - Return code: 0 08:09:36 INFO - grabbing minidump binary from tooltool 08:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:36 INFO - 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 0x1b401c0>, '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 0x1b410c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b41550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:09: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 08:09: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 08:09: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 08:09:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:09:36 INFO - Return code: 0 08:09:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:09:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:09:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:09:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:09:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:09:40 INFO - Return code: 0 08:09:40 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/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:09:40 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/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:09:40 INFO - Using env: {'DISPLAY': ':0', 08:09:40 INFO - 'HOME': '/home/cltbld', 08:09:40 INFO - 'LANG': 'en_US.UTF-8', 08:09:40 INFO - 'LANGUAGE': 'en_US:en', 08:09:40 INFO - 'LOGNAME': 'cltbld', 08:09:40 INFO - 'MAIL': '/var/mail/cltbld', 08:09:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:09:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:40 INFO - 'MOZ_NO_REMOTE': '1', 08:09:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:40 INFO - 'NO_EM_RESTART': '1', 08:09:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:40 INFO - 'PWD': '/builds/slave/test', 08:09:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:09:40 INFO - 'SHELL': '/bin/bash', 08:09:40 INFO - 'SHLVL': '1', 08:09:40 INFO - 'TERM': 'linux', 08:09:40 INFO - 'TMOUT': '86400', 08:09:40 INFO - 'USER': 'cltbld', 08:09:40 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714', 08:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:40 INFO - '_': '/tools/buildbot/bin/python'} 08:09:40 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/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:09:40 INFO - mozversion application_buildid: 20160609053030 08:09:40 INFO - mozversion application_changeset: 1c86ba5d7a5b9cb16ef3ad77ff740688a923108a 08:09:40 INFO - mozversion application_display_name: Nightly 08:09:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:09:40 INFO - mozversion application_name: Firefox 08:09:40 INFO - mozversion application_remotingname: firefox 08:09:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:09:40 INFO - mozversion application_vendor: Mozilla 08:09:40 INFO - mozversion application_version: 50.0a1 08:09:40 INFO - mozversion platform_buildid: 20160609053030 08:09:40 INFO - mozversion platform_changeset: 1c86ba5d7a5b9cb16ef3ad77ff740688a923108a 08:09:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:09:40 INFO - mozversion platform_version: 50.0a1 08:09:40 INFO - using testdate: 1465484980 08:09:40 INFO - actual date: 1465484980 08:09:40 INFO - starting webserver on 'localhost:42736' 08:09:40 INFO - SUITE-START | Running 2 tests 08:09:40 INFO - TEST-START | dromaeo_css 08:09:40 INFO - operating with platform_type : linux_ 08:09:40 INFO - Initialising browser for dromaeo_css test... 08:09:40 INFO - TEST-INFO | started process 5763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp01Bk2j/profile http://localhost:42736/getInfo.html) 08:09:47 INFO - PROCESS | 5763 | __metrics Screen width/height:1600/1200 08:09:47 INFO - PROCESS | 5763 | colorDepth:24 08:09:47 INFO - PROCESS | 5763 | Browser inner width/height: 1024/697 08:09:47 INFO - PROCESS | 5763 | __metrics 08:09:49 ERROR - PROCESS | 5763 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 08:09:50 INFO - TEST-INFO | 5763: exit 0 08:09:50 INFO - Browser initialized. 08:09:50 INFO - Running cycle 1/1 for dromaeo_css test... 08:09:50 INFO - TEST-INFO | started process 5887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp01Bk2j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:10:02 INFO - PROCESS | 5887 | RSS: Main: 184762368 08:10:02 INFO - PROCESS | 5887 | 08:10:51 INFO - PROCESS | 5887 | 1465485051783 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:12:59 INFO - PROCESS | 5887 | Cycle 1(1): loaded http://localhost:42736/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42736/tests/dromaeo/cssquery-ext.html) 08:13:00 INFO - PROCESS | 5887 | RSS: Main: 188272640 08:13:00 INFO - PROCESS | 5887 | 08:16:03 INFO - PROCESS | 5887 | Cycle 1(1): loaded http://localhost:42736/tests/dromaeo/cssquery-ext.html (next: http://localhost:42736/tests/dromaeo/cssquery-jquery.html) 08:16:03 INFO - PROCESS | 5887 | RSS: Main: 186785792 08:16:03 INFO - PROCESS | 5887 | 08:19:05 INFO - PROCESS | 5887 | Cycle 1(1): loaded http://localhost:42736/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42736/tests/dromaeo/cssquery-mootools.html) 08:19:06 INFO - PROCESS | 5887 | RSS: Main: 187650048 08:19:06 INFO - PROCESS | 5887 | 08:22:07 INFO - PROCESS | 5887 | Cycle 1(1): loaded http://localhost:42736/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42736/tests/dromaeo/cssquery-prototype.html) 08:22:08 INFO - PROCESS | 5887 | RSS: Main: 185278464 08:22:08 INFO - PROCESS | 5887 | 08:25:10 INFO - PROCESS | 5887 | Cycle 1(1): loaded http://localhost:42736/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42736/tests/dromaeo/cssquery-yui.html) 08:25:11 INFO - PROCESS | 5887 | RSS: Main: 187707392 08:25:11 INFO - PROCESS | 5887 | 08:28:14 INFO - PROCESS | 5887 | Cycle 1(1): loaded http://localhost:42736/tests/dromaeo/cssquery-yui.html (next: http://localhost:42736/tests/dromaeo/cssquery-dojo.html) 08:28:14 INFO - PROCESS | 5887 | RSS: Main: 189042688 08:28:14 INFO - PROCESS | 5887 | 08:28:14 INFO - PROCESS | 5887 | __start_tp_report 08:28:14 INFO - PROCESS | 5887 | _x_x_mozilla_page_load 08:28:14 INFO - PROCESS | 5887 | _x_x_mozilla_page_load_details 08:28:14 INFO - PROCESS | 5887 | |i|pagename|runs| 08:28:14 INFO - PROCESS | 5887 | |0;dojo.html;3082.1061892051302;3085.6760040195777;3130.9217269568258;3133.7336326412255;3136.827474488903;5224.503672151144;5263.710495922723;5306.946930530698;5350.5184533392085;5366.973165134169;5183.222516622509;5275.235090911816;5307.25698402223;5351.625386222966;5379.596530260226;4802.08760335536;4821.059893320804;4865.586425153866;4952.158133117361;4998.8500344989525;4760.404949381327;4900.411950565937;4932.309476673268;4941.085899108676;4953.826616068438;4668.579827815479;4771.045790841846;4784.545468180518;4840.1529732296885;4855.32025516428;4717.693349932243;4719;4736.881577960544;4762.618990480788;4811.542903424169;4778.402699662543;4783.593394561466;4784.521547845223;4816.686915350491;4828.8652166740785;5160.019596276696;5170.715610641413;5241.056609810233;5247.711375874325;5255;5564.4713752193475;5569.916451253234;5578.967890940189;5583.078791999315;5593.664380137205;5530.944690553083;5623.273523629412;5625.80309689163;5628.521575666074;5651.632643878176;5138.152204886189;5190.065788158167;5195.818146364859;5197.116490196676;5219.634625576249;5655.4910058094965;5675.517581005578;5679.545636349082;5701.629394089371;5712.371639119693;5401.7299135043095;5441.075017247077;5446.8910621787345;5502.679356954302;5502.944970550243;5628.240187574707;5702.201691763156;5715.399883012307;5723.084306510938;5732.885342293131;5488.7530061147345;5552.944470555323;5621.747021384048;5671.858203544944;5689.0328644130595;5377.300950876439;5570.832875013756;5657.773689052392;5668.26312579362;5673.262475878109;4333.609975102256;4367.148406060787;4369.213541562549;4397.450318710161;4403.163398954189;3893.980530097331;3919.529656441245;3925.685945124383;3930.253251882133;3964.781936993493;5269.762860671279;5407;5437.293151890229;5481.177823326533;5501.092319767274;5764.279465066867;5768.971155144198;5785.537157027427;5795.333536643256;5836.037053886062;5480.506754392124;5509.614326997152;5518.392976772552;5531.197976293415;5532.3914369419335;4852.563269305709;4891.633127515451;4893.510648935078;4938.43208031081;4952.851414457572;5859.44335288147;5870.295564532284;5872.853178670482;5877.823665290048;5879.735411906475;5701.201831743642;5722.742476588647;5724.341700704389;5729.255196824386;5746.9712651436475;5674;5806.796762113306;5815.854603634943;5828.125781132694;5842.211301474246;5581.413951535031;5627.690477023803;5628.071368224197;5632.5212356950115;5636.577256705681;5570.498655121059;5693.174489699053;5733.942660573341;5739;5746.224259724883;5442.673439593637;5557;5567.47109024642;5622.32532096151;5653.858653533694;5448.210009548672;5450.31871016123;5474.863128421821;5492;5529.834104976857;5432.511074003359;5451.563874890078;5454.59090568201;5455.208994695668;5457.645253058538;5352.759125839269;5536.2249285100925;5570.944290557205;5641.40765219646;5679.091345384883;5429.321334833146;5471.9179212311055;5513.724313784214;5522.0336441121835;5525.11598144295 08:28:14 INFO - PROCESS | 5887 | |1;ext.html;584.678426865224;625.612120485299;632.9493640508757;646.0180525601087;662.8210383196534;38023.61976380235;42654.14691706172;42695.35956960648;42828.785856070754;43130.56869431305;43557;44334.33498497525;44392.778036109776;44431.77784111075;44599;8901.688440904585;8986.505742184178;9004.279657627374;9035.41269817463;9098.226650734696;8881.378303518724;9001.864972025392;9019.909800901973;9039;9063.682771103013;9017.774555636095;9025.774355641095;9070.365074444791;9077.546122693871;9152.8627070594;8984.41601295917;9088.591013404413;9090.954545227265;9109.908900910972;9115.544222788834;8869.73390798277;8874.86687699685;8914.197722204968;8988.146126118008;8999.865002024975;34650.82674586611;41891.790541047405;41915.7904210477;42125.789371052946;42230;3327.5175099610665;3387.627360990289;3558.2349794794245;3707.7589956653;3989.162275922031;31300.37399252002;31575.36849263002;31586;32768.5084723727;34691;4478.171538265431;4555.863324100283;4566.337881007235;4633.397658304432;4663.417072865892;353913;361123;361498;363164;363225;34348.82825585856;35842.10394740153;63994;64465.67767161134;65140.34859651438;37187.25625487529;37425.625743742756;37597;37672.811635941645;37725.245495090494;15575.143367114692;16006.759898601531;16043;16107.275172617261;16110.75833862493;13287.06990510655;13437.798433023512;13437.798433023512;13466.730665386638;13498.32508374597;8390.664373424994;8441.15588441151;8456.492610443393;8531.616077276538;8537.487750734976;3300.339932013607;3350.9832450838076;3375.5443015192636;3401.7788843725575;3428.9485657715154;986.7237173591406;1003.7089244119123;1038.6676263595728;1078.8813230544633;1152.3143729480946;32471;32633.673663263064;32706.67293327084;32808.3438331232;32818.17954551155;996.2478328861663;1055.5039131608132;1075.499892549968;1119.082352470966;1181.6041626055196;17047.744283835753;17156.313747449964;17158.142092895305;17227.138643068047;17265;553392;556781;557240;559261;559845;60265;60979.69510152421;60986.695066524386;61020.08469872955;61152.38847611467;1340.8189894364332;1342.9462821487227;1360.340234986031;1363.8977076719286;1369.1511263016794;29809.10572682823;31078.37843243077;31134.377312453173;31443.528347074356;31841;50459.495405046946;50648.24027639515;51198.48801512086;51282.23076653779;51302.23046654378;436123;437833;439213;439259;441236;28798.568021480114;28929.940745904663;29110.12669619915;29184.7081529182;29245.122646320644;48609.5139048605;49853.50146498489;50088.248676269155;50506.74746626243;50963;41061.58938410578;42165.57834421616;42238.57761422346;43222.567774321855;43319;41189;41195;41408.1718365625;41512.377314339705;41662.58337416587;41800.79099604482;41807;42049;43102;43114.56885431105;36082.27835443329;38004.429933551575;38376;38887.894339021754;39010;28611.14166575006;28652;28681;28910.132696019155;29182.416351673273 08:28:14 INFO - PROCESS | 5887 | |2;jquery.html;384.204696278703;386.7118996347721;392.09426225419264;396.16804710108767;408.5220292258058;13553.254570998592;15298.082115073103;18573.442796716085;19444.805551944475;19507.41477755666;17581.94508329498;17802.376916807916;17993.92036477809;19132.808671913277;19437.31969381072;5664.943350566504;5698.601097923147;5792.768289268424;5912.645241285515;5913.438223368773;5688.829335119953;5715.228444160027;5756.366799652056;5764.077747560391;5789.39211382805;5199.220116982445;5497.780088796443;5700.458456446631;5718.7426565804435;5720.227769251161;5457.754401051962;5500.697461639628;5513.696746678931;5542.362628297757;5594.58040646951;5556.611037227396;5557.6109672322955;5645.971770141164;5658.915116273218;5661.150827375926;12946.223226606433;12979;13362.930965522832;13528.25594592297;13623.25072121033;2209.933701988943;2238.832087593437;2247.2471721973156;2320.0951628864755;2402.303332033708;9782.266330025206;10188.59245630174;10204.387736735745;10230.744231394201;10643.84034239487;1894.4222012286248;1956.334846152315;1967.8130577595248;1983.978251200633;1984.6526857799972;53305;74731.25268747297;77799.22200778034;79031;79051.6047419765;10448.634297799692;10495.632652857113;10583.682489525327;10881.347119172875;10894.67315980522;15124.773128403083;15188;15192.544223673307;15237.466688665843;15292.235388230543;7737.419693523008;7789.610519474004;7967.482113662593;8034.875117483557;8113;7505.174430812606;7587.165411804697;7609.391248700091;7661.348785353307;7753.8449231015065;4538.364628951949;4545.159145558082;4605;4613.2008516678525;4641.489436162019;1883.4349695091419;1924.6343194792944;1943.815337542931;1969.891655958936;1994.4614953962348;968.3850754770631;972.8492083726892;1005.6379703306803;1042.2339580408393;1068.1721665709138;18587.16357763904;18626.53433664142;19299.228030878607;19422.90288548548;19427;957.1863915671623;978.0903759503587;1005.6681295172575;1021.5556233038652;1039.443897514826;10465.319754215952;10716.35701857891;10803.405812680221;10863.945680271549;10881.673549793519;502664;519044;525776;536538;545389;73872.63063684647;82937.58531207305;87026.56486717526;88430;90819.54590227007;959.8944116147218;971.8007808399261;994.4480813148772;994.7463396833762;997.0478193325357;16961.745573816155;17177.828221717624;17228.91385543064;17566;18010.459686209433;29418.55872161962;38154;39160.80419597884;39372.40941385939;40016.19967600574;54786;56150.7192464035;56931;57166.7141664289;57215.713921431794;7203.351698347174;7948.085970113511;8045.919540804517;8129.715459958873;8176.223258790405;7784.065912090359;11183.72040698989;12679.746405071663;13491.527796527074;13604.04771665974;11774.175807693378;11883;12097.818532722193;12155.45300461499;12158.574449894211;11558.42207889619;11628.244164129304;11974.461149248478;12015.399230038638;12084.75830483403;11762.94118529402;12090.939545302217;12401.813972790596;12506.562270320495;12849.35753212317;8267.255946964802;8458.577071146541;8571.100034496289;8581.442206256574;8589.312854971713;8876.378653494194;11398.829017564909;11907.345096019802;11958.58144964922;11994.880051199376 08:28:14 INFO - PROCESS | 5887 | |3;mootools.html;1432.7564314066608;1438.1155589312573;1560.6722588256466;1706.9402570910006;1712.3749831311568;7541;8266.504009759403;8317.168283171679;8759.605817738202;8881.200691937733;8216.342692584594;8538.48769073856;8546.316294696426;8555.61499732512;8659.870101948476;2205.625043742564;2257.2099765082253;2262.9434264143365;2264.2641141628956;2267.1724820440504;2157.7842215778455;2169.652855543113;2207.1171531387413;2221.700070490487;2231.207921187979;2212.8008479236946;2229.721284839395;2243.7083179186684;2249.707538020055;2251.0320562158267;2114.048678094848;2126.11766117062;2129.7976692214215;2131.79747923947;2132.445564153316;2144.7426308843037;2149.613069647463;2154.332157031325;2160.2655097266847;2161.189553917281;8611.440256383377;8619.482831030158;8679.913200868037;8687.869681954775;8712.303015758724;5001.749912504397;5081.517255860725;5115.616328775357;5119.539241468286;5159.767810448501;3016.2096946817232;3119.142235885127;3196.4246435641576;3205.439048166585;3232.660570640096;1076.8815430302739;1084.6637542361814;1098.4946924414778;1133.7222380516826;1135.4720055174384;11041.558337666484;11397.658070257905;11408.372539510323;11519.654410367702;11850.466728997217;4302.139572085595;4344.674149438804;4451.933221001687;4460.397846290774;4470.798814053375;9297.953510232406;9355.251579873593;9356.532173391302;9385.249180065579;9420.24638028956;5063.594912406998;5095.439501654815;5097.541221290102;5100.387953445536;5121.180611102206;4054.3107671695884;4516.81932722694;4705.5059218781535;4740.099381117577;4779.02030083832;3650.178709790276;3674.926501469956;3741.345264578688;3749.8312575934146;3897.512810898638;1122.5734220995969;1129.8474705914762;1141.57191053355;1146.7133216695827;1156.9016633586239;955.3312681123242;964.9662261820803;976.1995163965622;987.4075554667143;1000.1698590170141;5664.433556644302;5724.971375143181;5843.912341314884;5884.440978107073;5890.823275301748;437.2217452933783;443.07839693438217;449.53922229714806;450.3222649911927;455.71973236459337;3834.079820842978;3876.8449262029767;3902.512185976753;3924.3917192835156;3957.3668213086344;9715.70852874415;10098.192144628412;10311.381317120997;10394.48027598617;10464.790704186025;10402.11582015522;10459.790804184026;10502.05481506668;10506.684799456028;10569.312994655324;7710.421718371144;8078.272955434039;8126.228008339198;8200.384971127189;8221.630026648816;5802.796902108406;5827.921834460638;5869.236999190078;5893.941060589511;5970.492508136857;9565.569549370155;9764.560594773111;9772.657956971472;9847.556859941464;9856.655017074369;9485.430874147572;9503;9819.06718861707;9832.31173817826;9977.850332244878;7349.412047036118;7854.528728276322;7967.760967170994;8146.470479418819;8225.71210007647;8178.67285308581;8343.207395297437;8448.281896038905;8507.95746021266;8557.187067228604;7365.116186057493;7686.3466605336935;7700.807479813049;7708.190639982945;7781.105172905189;7451.627418628938;7520.699172033057;7690.538567685957;7723.073231212291;7767.184445633127;6994.755183568551;7181.461390395846;7194.928050719426;7203.783886483414;7249.202587715453;4790.760461976817;5008.298838162587;5056.949430505648;5144;5153.974230128975;5108.59131269505;5127.820526281712;5180.507851754077;5192.909489007351;5210.348706411699 08:28:14 INFO - PROCESS | 5887 | |4;prototype.html;302.75930635145073;317.99682003179964;318.5969748268441;320.20748647098446;321.42144140547015;5430.67415955043;5497.340319161696;5519.282493275873;5601.635893666919;5617.932592807364;5606.719664016803;5609.915851262224;5613.747381367838;5621.213030175779;5631.4087020862735;4319.4600674915555;4336.739795612258;4340.500842403117;4342.609165175134;4347.804348804296;4096.406021126935;4294.49692607588;4317.43873296471;4360.563943605645;4386.363977223301;4179.958200418003;4182.456280683522;4238.131183107455;4249.553796851333;4264.78676066197;4263.529082466544;4275.273203555403;4276.935845962313;4278.486581610196;4291.120320334355;3495.3358861816173;3719.163188282642;3720.8697695580795;3727.7576957497945;3749.362608356586;5351.678899266057;5368.248445217672;5388.676679399248;5393.703346315951;5411.458854114597;4846.36997190363;4865.7323847188745;4876.60987121033;4879.707217566922;4881.4630390657;5533.501984821345;5814.127880817869;5822.446867547618;5822.854428639318;5873.471387575096;4078.877633670995;4083.224187404384;4097.242010228118;4106.938395924063;4114.5679703630985;6032.27612686476;6088.082254089947;6099.634021958696;6109.755609775603;6109.969450152766;4039.3940908863906;4119.958800412018;4144.854930077433;4162.62536371728;4167.937480937789;4183.226103170923;4187.706860519735;4192.4759405074365;4198.6011328923705;4210.736778966359;4819.373481447389;4852.902941941142;4857.615579559879;4875.585575226146;4891.26631005352;5301.469853014668;5882.911756323659;5925.555583331267;5935.970320148458;5946.583739138218;1450.0936914428482;1450.5285782120852;1458.2125652147722;1462.1227263641942;1462.3127130248765;882.9735107946772;907.4373888189365;917.8623206518942;921.2860033474111;922.6078916460477;5029.673071250357;5056.443791182967;5081.669691470117;5088.618353623419;5095.286659867622;5335.733213339317;5351.752264049109;5388.272583201296;5411.945880541223;5421.918671219935;5076.873078173001;5112.105381558213;5137.306463627438;5365.041759757738;5869.354371019184;3199.2161920329204;3218.4045951499047;3220.162757683019;3251.170951407376;3283.195617073832;6055.636661800306;6320.905186422207;6324.3043265240785;6356.491480681627;6361.395667411589;6133.662648554372;6141.907871381933;6154.5384096192965;6191.164192834;6208.099825525273;6281.214848143982;6321.1150438938585;6337.397947195009;6341.904871426932;6383.648584493086;5878.147668588116;6076.572005578597;6083.878322433615;6087.391260873877;6099.237595300588;5983.880322393615;5987.491063259672;5992.310884248367;6036.9698151508965;6043.969780151247;5983.640981541122;6196.876062478635;6240;6310.495160387066;6328.46208072319;4216.367544868294;4222.535521092739;4236.152769446185;4249.192653395845;4251.893702657459;5837.795677151279;5858.5898987072205;6114;6121.602095863755;6179.3202747698615;5866.765329386777;5872.150272664097;5877.23595932526;5882.970480165868;5910.704464776658;5815.273090863642;5838.32859221178;5840.445157710011;5844.649321040752;5866.061430171152;5564.944350556604;5688.800891968761;5727.599068065362;5743.684097374685;5765;5845.590808643354;5906.911396329145;5937.376575459514;5969.880602388015;5987.6108052976415;5503.889922201613;5735.54115670737;5740.712964351849;5799.811038736964;5871.6770577618645 08:28:14 INFO - PROCESS | 5887 | |5;yui.html;596.5168213746865;601.3625556909674;632.8955722305818;675.0043685563793;723.4827098624482;14434.927825360885;14683.559493215207;15103.62240943977;15115.546533603982;15129.394824207046;14323;14413.567592972202;14415.567532974;14429.422823087063;14431.567052988426;661.7816120680188;774.2296415066988;784.051297929506;787.0516028186022;798.321426787232;781.945263831532;785.426638553856;788.388998526144;789.0531362365156;790.4111436979458;842.963155318958;845.4335595151264;846.4328899637258;846.8010017645848;847.4533925617973;838.6771093129158;839.7480755773244;842.6039761312173;843.8185790055168;844.269706703703;609.7073404765692;609.8201030695956;613.4172536090687;613.7391608566342;615.5198944823045;11481.138914581355;11663.59177428786;11675.532978680927;11697.3566453845;11704.53181872724;14529;14701.55895323142;14815.18516481593;14925.776113358308;14981.70036599262;11366.204365694404;11372.431378431045;11480.253783504046;11541.538338466451;11893;3763.435484677293;3830.7701537907815;3905.1408690088133;3942.5860284669984;4023.919521609581;75579.62210188969;75668;76528.61735691341;76809.61595192044;76925.61537192334;10729.83905241422;10759.085477734323;10892.891071089347;10961.725956850983;11069.778604427866;21778.128874845144;22019.11923523041;22046.11815527393;22108.336749897528;22831;8041;8112.716054938167;8153.836923261501;8161;8457.534835584102;4438.245498265238;4500.077484115748;4521.443906335826;4526.140033393644;4580.221362368406;3594.964050359463;3673.430618254175;3683.723720720957;3714.721395895265;3721.7953012584567;536.0752701589727;547.0454057669392;557.2059814763945;565.2115299157653;579.3684883477031;613.187526527353;638.1608185236399;640.3052687833659;660.0264609700653;661.83784972682;8622.698205562776;8964.551772411354;8985.865212021825;9007.189352958265;9263.722088337361;502.5828562293288;503.69778133119837;510.2397427832503;511.3914441814229;574.0986650957956;4192.413062171298;4216.198922204771;4236.682248831288;4276.593723596254;4418.558144185556;72692.27307726961;74528.62735686396;76498;81030;86068;63994.040089398695;91267;95385.52307238558;96173.15307387627;101785;90427;90577.47112644342;91459;92104;93148;8192.467489613156;8291.95854020726;8293.129221431664;8338.04112527067;8357.456765310235;48734.75632621814;53084.73457632842;53318.46681533135;53911.73044134754;56249.718751405984;69408;78270.56429639175;79206.20793791988;80655;82097;11072.280301780358;11177.618931713276;11311.208215424842;11477.483513241757;11614.361210133524;11573.652790416301;12114.878851211375;12126.75746485083;12139.271643701053;12142.575009874612;10776.892231077902;10842.674719758419;10935.28920620157;11159.38623375722;11372.574495410066;10340.793184136426;11181.273217240854;11317.547298107984;11779.823302650295;12140.757184856076;10866.348019118877;11294.435278235891;11664.94167529157;12298.631041068424;12393.194442361219;10159.44123073238;10264.948675256575;10297.639582614873;10357.274990750575;10651.254412191072;9911.091386884355;10331;10337.534810933677;10397.688069357931;10461.110805581611 08:28:14 INFO - PROCESS | 5887 | __end_tp_report 08:28:14 INFO - PROCESS | 5887 | __start_cc_report 08:28:14 INFO - PROCESS | 5887 | _x_x_mozilla_cycle_collect,362 08:28:14 INFO - PROCESS | 5887 | __end_cc_report 08:28:14 INFO - PROCESS | 5887 | __startTimestamp1465486094564__endTimestamp 08:28:14 INFO - PROCESS | 5887 | 08:28:14 INFO - PROCESS | 5887 | ------- Summary: start ------- 08:28:14 INFO - PROCESS | 5887 | Number of tests: 6 08:28:14 INFO - PROCESS | 5887 | 08:28:14 INFO - PROCESS | 5887 | [#0] dojo.html Cycles:165 Average:5262.13 Median:5471.92 stddev:582.23 (10.6%) stddev-sans-first:558.34 08:28:14 INFO - PROCESS | 5887 | Values: 3082.1 3085.7 3130.9 3133.7 3136.8 5224.5 5263.7 5306.9 5350.5 5367.0 5183.2 5275.2 5307.3 5351.6 5379.6 4802.1 4821.1 4865.6 4952.2 4998.9 4760.4 4900.4 4932.3 4941.1 4953.8 4668.6 4771.0 4784.5 4840.2 4855.3 4717.7 4719.0 4736.9 4762.6 4811.5 4778.4 4783.6 4784.5 4816.7 4828.9 5160.0 5170.7 5241.1 5247.7 5255.0 5564.5 5569.9 5579.0 5583.1 5593.7 5530.9 5623.3 5625.8 5628.5 5651.6 5138.2 5190.1 5195.8 5197.1 5219.6 5655.5 5675.5 5679.5 5701.6 5712.4 5401.7 5441.1 5446.9 5502.7 5502.9 5628.2 5702.2 5715.4 5723.1 5732.9 5488.8 5552.9 5621.7 5671.9 5689.0 5377.3 5570.8 5657.8 5668.3 5673.3 4333.6 4367.1 4369.2 4397.5 4403.2 3894.0 3919.5 3925.7 3930.3 3964.8 5269.8 5407.0 5437.3 5481.2 5501.1 5764.3 5769.0 5785.5 5795.3 5836.0 5480.5 5509.6 5518.4 5531.2 5532.4 4852.6 4891.6 4893.5 4938.4 4952.9 5859.4 5870.3 5872.9 5877.8 5879.7 5701.2 5722.7 5724.3 5729.3 5747.0 5674.0 5806.8 5815.9 5828.1 5842.2 5581.4 5627.7 5628.1 5632.5 5636.6 5570.5 5693.2 5733.9 5739.0 5746.2 5442.7 5557.0 5567.5 5622.3 5653.9 5448.2 5450.3 5474.9 5492.0 5529.8 5432.5 5451.6 5454.6 5455.2 5457.6 5352.8 5536.2 5570.9 5641.4 5679.1 5429.3 5471.9 5513.7 5522.0 5525.1 08:28:14 INFO - PROCESS | 5887 | 08:28:14 INFO - PROCESS | 5887 | [#1] ext.html Cycles:180 Average:60263.33 Median:41903.79 stddev:122100.59 (291.4%) stddev-sans-first:122360.90 08:28:14 INFO - PROCESS | 5887 | Values: 584.7 625.6 632.9 646.0 662.8 38023.6 42654.1 42695.4 42828.8 43130.6 43557.0 44334.3 44392.8 44431.8 44599.0 8901.7 8986.5 9004.3 9035.4 9098.2 8881.4 9001.9 9019.9 9039.0 9063.7 9017.8 9025.8 9070.4 9077.5 9152.9 8984.4 9088.6 9091.0 9109.9 9115.5 8869.7 8874.9 8914.2 8988.1 8999.9 34650.8 41891.8 41915.8 42125.8 42230.0 3327.5 3387.6 3558.2 3707.8 3989.2 31300.4 31575.4 31586.0 32768.5 34691.0 4478.2 4555.9 4566.3 4633.4 4663.4 353913.0 361123.0 361498.0 363164.0 363225.0 34348.8 35842.1 63994.0 64465.7 65140.3 37187.3 37425.6 37597.0 37672.8 37725.2 15575.1 16006.8 16043.0 16107.3 16110.8 13287.1 13437.8 13437.8 13466.7 13498.3 8390.7 8441.2 8456.5 8531.6 8537.5 3300.3 3351.0 3375.5 3401.8 3428.9 986.7 1003.7 1038.7 1078.9 1152.3 32471.0 32633.7 32706.7 32808.3 32818.2 996.2 1055.5 1075.5 1119.1 1181.6 17047.7 17156.3 17158.1 17227.1 17265.0 553392.0 556781.0 557240.0 559261.0 559845.0 60265.0 60979.7 60986.7 61020.1 61152.4 1340.8 1342.9 1360.3 1363.9 1369.2 29809.1 31078.4 31134.4 31443.5 31841.0 50459.5 50648.2 51198.5 51282.2 51302.2 436123.0 437833.0 439213.0 439259.0 441236.0 28798.6 28929.9 29110.1 29184.7 29245.1 48609.5 49853.5 50088.2 50506.7 50963.0 41061.6 42165.6 42238.6 43222.6 43319.0 41189.0 41195.0 41408.2 41512.4 41662.6 41800.8 41807.0 42049.0 43102.0 43114.6 36082.3 38004.4 38376.0 38887.9 39010.0 28611.1 28652.0 28681.0 28910.1 29182.4 08:28:14 INFO - PROCESS | 5887 | 08:28:14 INFO - PROCESS | 5887 | [#2] jquery.html Cycles:180 Average:28964.24 Median:385.46 stddev:86353.17 (22402.7%) stddev-sans-first:86568.75 08:28:14 INFO - PROCESS | 5887 | Values: 384.2 386.7 392.1 396.2 408.5 13553.3 15298.1 18573.4 19444.8 19507.4 17581.9 17802.4 17993.9 19132.8 19437.3 5664.9 5698.6 5792.8 5912.6 5913.4 5688.8 5715.2 5756.4 5764.1 5789.4 5199.2 5497.8 5700.5 5718.7 5720.2 5457.8 5500.7 5513.7 5542.4 5594.6 5556.6 5557.6 5646.0 5658.9 5661.2 12946.2 12979.0 13362.9 13528.3 13623.3 2209.9 2238.8 2247.2 2320.1 2402.3 9782.3 10188.6 10204.4 10230.7 10643.8 1894.4 1956.3 1967.8 1984.0 1984.7 53305.0 74731.3 77799.2 79031.0 79051.6 10448.6 10495.6 10583.7 10881.3 10894.7 15124.8 15188.0 15192.5 15237.5 15292.2 7737.4 7789.6 7967.5 8034.9 8113.0 7505.2 7587.2 7609.4 7661.3 7753.8 4538.4 4545.2 4605.0 4613.2 4641.5 1883.4 1924.6 1943.8 1969.9 1994.5 968.4 972.8 1005.6 1042.2 1068.2 18587.2 18626.5 19299.2 19422.9 19427.0 957.2 978.1 1005.7 1021.6 1039.4 10465.3 10716.4 10803.4 10863.9 10881.7 502664.0 519044.0 525776.0 536538.0 545389.0 73872.6 82937.6 87026.6 88430.0 90819.5 959.9 971.8 994.4 994.7 997.0 16961.7 17177.8 17228.9 17566.0 18010.5 29418.6 38154.0 39160.8 39372.4 40016.2 54786.0 56150.7 56931.0 57166.7 57215.7 7203.4 7948.1 8045.9 8129.7 8176.2 7784.1 11183.7 12679.7 13491.5 13604.0 11774.2 11883.0 12097.8 12155.5 12158.6 11558.4 11628.2 11974.5 12015.4 12084.8 11762.9 12090.9 12401.8 12506.6 12849.4 8267.3 8458.6 8571.1 8581.4 8589.3 8876.4 11398.8 11907.3 11958.6 11994.9 08:28:14 INFO - PROCESS | 5887 | 08:28:14 INFO - PROCESS | 5887 | [#3] mootools.html Cycles:180 Average:5593.07 Median:5088.48 stddev:3180.53 (62.5%) stddev-sans-first:3174.08 08:28:14 INFO - PROCESS | 5887 | Values: 1432.8 1438.1 1560.7 1706.9 1712.4 7541.0 8266.5 8317.2 8759.6 8881.2 8216.3 8538.5 8546.3 8555.6 8659.9 2205.6 2257.2 2262.9 2264.3 2267.2 2157.8 2169.7 2207.1 2221.7 2231.2 2212.8 2229.7 2243.7 2249.7 2251.0 2114.0 2126.1 2129.8 2131.8 2132.4 2144.7 2149.6 2154.3 2160.3 2161.2 8611.4 8619.5 8679.9 8687.9 8712.3 5001.7 5081.5 5115.6 5119.5 5159.8 3016.2 3119.1 3196.4 3205.4 3232.7 1076.9 1084.7 1098.5 1133.7 1135.5 11041.6 11397.7 11408.4 11519.7 11850.5 4302.1 4344.7 4451.9 4460.4 4470.8 9298.0 9355.3 9356.5 9385.2 9420.2 5063.6 5095.4 5097.5 5100.4 5121.2 4054.3 4516.8 4705.5 4740.1 4779.0 3650.2 3674.9 3741.3 3749.8 3897.5 1122.6 1129.8 1141.6 1146.7 1156.9 955.3 965.0 976.2 987.4 1000.2 5664.4 5725.0 5843.9 5884.4 5890.8 437.2 443.1 449.5 450.3 455.7 3834.1 3876.8 3902.5 3924.4 3957.4 9715.7 10098.2 10311.4 10394.5 10464.8 10402.1 10459.8 10502.1 10506.7 10569.3 7710.4 8078.3 8126.2 8200.4 8221.6 5802.8 5827.9 5869.2 5893.9 5970.5 9565.6 9764.6 9772.7 9847.6 9856.7 9485.4 9503.0 9819.1 9832.3 9977.9 7349.4 7854.5 7967.8 8146.5 8225.7 8178.7 8343.2 8448.3 8508.0 8557.2 7365.1 7686.3 7700.8 7708.2 7781.1 7451.6 7520.7 7690.5 7723.1 7767.2 6994.8 7181.5 7194.9 7203.8 7249.2 4790.8 5008.3 5056.9 5144.0 5154.0 5108.6 5127.8 5180.5 5192.9 5210.3 08:28:14 INFO - PROCESS | 5887 | 08:28:14 INFO - PROCESS | 5887 | [#4] prototype.html Cycles:180 Average:4867.20 Median:5464.01 stddev:1465.53 (26.8%) stddev-sans-first:1429.03 08:28:14 INFO - PROCESS | 5887 | Values: 302.8 318.0 318.6 320.2 321.4 5430.7 5497.3 5519.3 5601.6 5617.9 5606.7 5609.9 5613.7 5621.2 5631.4 4319.5 4336.7 4340.5 4342.6 4347.8 4096.4 4294.5 4317.4 4360.6 4386.4 4180.0 4182.5 4238.1 4249.6 4264.8 4263.5 4275.3 4276.9 4278.5 4291.1 3495.3 3719.2 3720.9 3727.8 3749.4 5351.7 5368.2 5388.7 5393.7 5411.5 4846.4 4865.7 4876.6 4879.7 4881.5 5533.5 5814.1 5822.4 5822.9 5873.5 4078.9 4083.2 4097.2 4106.9 4114.6 6032.3 6088.1 6099.6 6109.8 6110.0 4039.4 4120.0 4144.9 4162.6 4167.9 4183.2 4187.7 4192.5 4198.6 4210.7 4819.4 4852.9 4857.6 4875.6 4891.3 5301.5 5882.9 5925.6 5936.0 5946.6 1450.1 1450.5 1458.2 1462.1 1462.3 883.0 907.4 917.9 921.3 922.6 5029.7 5056.4 5081.7 5088.6 5095.3 5335.7 5351.8 5388.3 5411.9 5421.9 5076.9 5112.1 5137.3 5365.0 5869.4 3199.2 3218.4 3220.2 3251.2 3283.2 6055.6 6320.9 6324.3 6356.5 6361.4 6133.7 6141.9 6154.5 6191.2 6208.1 6281.2 6321.1 6337.4 6341.9 6383.6 5878.1 6076.6 6083.9 6087.4 6099.2 5983.9 5987.5 5992.3 6037.0 6044.0 5983.6 6196.9 6240.0 6310.5 6328.5 4216.4 4222.5 4236.2 4249.2 4251.9 5837.8 5858.6 6114.0 6121.6 6179.3 5866.8 5872.2 5877.2 5883.0 5910.7 5815.3 5838.3 5840.4 5844.6 5866.1 5564.9 5688.8 5727.6 5743.7 5765.0 5845.6 5906.9 5937.4 5969.9 5987.6 5503.9 5735.5 5740.7 5799.8 5871.7 08:28:14 INFO - PROCESS | 5887 | 08:28:14 INFO - PROCESS | 5887 | [#5] yui.html Cycles:180 Average:19252.49 Median:24618.67 stddev:27371.37 (111.2%) stddev-sans-first:27412.31 08:28:14 INFO - PROCESS | 5887 | Values: 596.5 601.4 632.9 675.0 723.5 14434.9 14683.6 15103.6 15115.5 15129.4 14323.0 14413.6 14415.6 14429.4 14431.6 661.8 774.2 784.1 787.1 798.3 781.9 785.4 788.4 789.1 790.4 843.0 845.4 846.4 846.8 847.5 838.7 839.7 842.6 843.8 844.3 609.7 609.8 613.4 613.7 615.5 11481.1 11663.6 11675.5 11697.4 11704.5 14529.0 14701.6 14815.2 14925.8 14981.7 11366.2 11372.4 11480.3 11541.5 11893.0 3763.4 3830.8 3905.1 3942.6 4023.9 75579.6 75668.0 76528.6 76809.6 76925.6 10729.8 10759.1 10892.9 10961.7 11069.8 21778.1 22019.1 22046.1 22108.3 22831.0 8041.0 8112.7 8153.8 8161.0 8457.5 4438.2 4500.1 4521.4 4526.1 4580.2 3595.0 3673.4 3683.7 3714.7 3721.8 536.1 547.0 557.2 565.2 579.4 613.2 638.2 640.3 660.0 661.8 8622.7 8964.6 8985.9 9007.2 9263.7 502.6 503.7 510.2 511.4 574.1 4192.4 4216.2 4236.7 4276.6 4418.6 72692.3 74528.6 76498.0 81030.0 86068.0 63994.0 91267.0 95385.5 96173.2 101785.0 90427.0 90577.5 91459.0 92104.0 93148.0 8192.5 8292.0 8293.1 8338.0 8357.5 48734.8 53084.7 53318.5 53911.7 56249.7 69408.0 78270.6 79206.2 80655.0 82097.0 11072.3 11177.6 11311.2 11477.5 11614.4 11573.7 12114.9 12126.8 12139.3 12142.6 10776.9 10842.7 10935.3 11159.4 11372.6 10340.8 11181.3 11317.5 11779.8 12140.8 10866.3 11294.4 11664.9 12298.6 12393.2 10159.4 10264.9 10297.6 10357.3 10651.3 9911.1 10331.0 10337.5 10397.7 10461.1 08:28:14 INFO - PROCESS | 5887 | -------- Summary: end -------- 08:28:14 INFO - PROCESS | 5887 | 08:28:15 INFO - TEST-INFO | 5887: exit 0 08:28:15 INFO - TEST-OK | dromaeo_css | took 1114957ms 08:28:15 INFO - TEST-START | kraken 08:28:15 INFO - operating with platform_type : linux_ 08:28:15 INFO - Initialising browser for kraken test... 08:28:15 INFO - TEST-INFO | started process 6128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYxAugg/profile http://localhost:42736/getInfo.html) 08:28:22 INFO - PROCESS | 6128 | __metrics Screen width/height:1600/1200 08:28:22 INFO - PROCESS | 6128 | colorDepth:24 08:28:22 INFO - PROCESS | 6128 | Browser inner width/height: 1024/697 08:28:22 INFO - PROCESS | 6128 | __metrics 08:28:24 ERROR - PROCESS | 6128 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 08:28:25 INFO - TEST-INFO | 6128: exit 0 08:28:25 INFO - Browser initialized. 08:28:25 INFO - Running cycle 1/1 for kraken test... 08:28:25 INFO - TEST-INFO | started process 6251 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYxAugg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:28:37 INFO - PROCESS | 6251 | RSS: Main: 184471552 08:28:37 INFO - PROCESS | 6251 | 08:28:39 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:42736/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42736/tests/kraken/driver.html?testName=audio-beat-detection) 08:28:40 INFO - PROCESS | 6251 | RSS: Main: 190001152 08:28:40 INFO - PROCESS | 6251 | 08:28:43 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:42736/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42736/tests/kraken/driver.html?testName=audio-dft) 08:28:44 INFO - PROCESS | 6251 | RSS: Main: 188948480 08:28:44 INFO - PROCESS | 6251 | 08:28:46 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:42736/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42736/tests/kraken/driver.html?testName=audio-fft) 08:28:47 INFO - PROCESS | 6251 | RSS: Main: 184156160 08:28:47 INFO - PROCESS | 6251 | 08:28:49 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:42736/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42736/tests/kraken/driver.html?testName=audio-oscillator) 08:28:50 INFO - PROCESS | 6251 | RSS: Main: 184709120 08:28:50 INFO - PROCESS | 6251 | 08:28:52 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:42736/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42736/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:28:53 INFO - PROCESS | 6251 | RSS: Main: 185352192 08:28:53 INFO - PROCESS | 6251 | 08:28:56 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:42736/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42736/tests/kraken/driver.html?testName=imaging-darkroom) 08:28:57 INFO - PROCESS | 6251 | RSS: Main: 185729024 08:28:57 INFO - PROCESS | 6251 | 08:29:00 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:42736/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42736/tests/kraken/driver.html?testName=imaging-desaturate) 08:29:01 INFO - PROCESS | 6251 | RSS: Main: 182628352 08:29:01 INFO - PROCESS | 6251 | 08:29:03 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:42736/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42736/tests/kraken/driver.html?testName=json-parse-financial) 08:29:04 INFO - PROCESS | 6251 | RSS: Main: 184373248 08:29:04 INFO - PROCESS | 6251 | 08:29:06 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:42736/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42736/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:29:06 INFO - PROCESS | 6251 | RSS: Main: 184754176 08:29:06 INFO - PROCESS | 6251 | 08:29:08 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:42736/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42736/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:29:09 INFO - PROCESS | 6251 | RSS: Main: 184827904 08:29:09 INFO - PROCESS | 6251 | 08:29:11 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:42736/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42736/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:29:11 INFO - PROCESS | 6251 | RSS: Main: 185659392 08:29:11 INFO - PROCESS | 6251 | 08:29:14 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:42736/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42736/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:29:15 INFO - PROCESS | 6251 | RSS: Main: 185352192 08:29:15 INFO - PROCESS | 6251 | 08:29:17 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:42736/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42736/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:29:18 INFO - PROCESS | 6251 | RSS: Main: 185335808 08:29:18 INFO - PROCESS | 6251 | 08:29:20 INFO - PROCESS | 6251 | Cycle 1(1): loaded http://localhost:42736/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42736/tests/kraken/driver.html?testName=ai-astar) 08:29:20 INFO - PROCESS | 6251 | RSS: Main: 186060800 08:29:20 INFO - PROCESS | 6251 | 08:29:20 INFO - PROCESS | 6251 | __start_tp_report 08:29:20 INFO - PROCESS | 6251 | _x_x_mozilla_page_load 08:29:20 INFO - PROCESS | 6251 | _x_x_mozilla_page_load_details 08:29:20 INFO - PROCESS | 6251 | |i|pagename|runs| 08:29:20 INFO - PROCESS | 6251 | |0;ai-astar;110;106;112;111;112;112;111;111;111;109 08:29:20 INFO - PROCESS | 6251 | |1;audio-beat-detection;154;130;156;186;127;156;156;129;193;132 08:29:20 INFO - PROCESS | 6251 | |2;audio-dft;164;165;163;165;170;176;163;162;163;163 08:29:20 INFO - PROCESS | 6251 | |3;audio-fft;74;76;77;169;76;76;75;76;183;75 08:29:20 INFO - PROCESS | 6251 | |4;audio-oscillator;86;85;148;85;89;86;144;86;86;155 08:29:20 INFO - PROCESS | 6251 | |5;imaging-gaussian-blur;118;117;118;122;120;118;119;118;117;117 08:29:20 INFO - PROCESS | 6251 | |6;imaging-darkroom;149;148;147;148;149;149;152;148;147;147 08:29:20 INFO - PROCESS | 6251 | |7;imaging-desaturate;96;96;99;96;99;96;96;95;96;96 08:29:20 INFO - PROCESS | 6251 | |8;json-parse-financial;53;59;55;59;58;53;54;54;56;53 08:29:20 INFO - PROCESS | 6251 | |9;json-stringify-tinderbox;61;61;60;60;60;60;62;62;61;61 08:29:20 INFO - PROCESS | 6251 | |10;stanford-crypto-aes;82;77;79;80;80;80;85;80;103;80 08:29:20 INFO - PROCESS | 6251 | |11;stanford-crypto-ccm;124;130;130;130;122;123;125;130;133;134 08:29:20 INFO - PROCESS | 6251 | |12;stanford-crypto-pbkdf2;168;157;162;160;160;160;164;157;156;159 08:29:20 INFO - PROCESS | 6251 | |13;stanford-crypto-sha256-iterative;64;64;68;67;63;64;63;64;62;63 08:29:20 INFO - PROCESS | 6251 | __end_tp_report 08:29:20 INFO - PROCESS | 6251 | __start_cc_report 08:29:20 INFO - PROCESS | 6251 | _x_x_mozilla_cycle_collect,889 08:29:20 INFO - PROCESS | 6251 | __end_cc_report 08:29:20 INFO - PROCESS | 6251 | __startTimestamp1465486160359__endTimestamp 08:29:20 INFO - PROCESS | 6251 | 08:29:20 INFO - PROCESS | 6251 | ------- Summary: start ------- 08:29:20 INFO - PROCESS | 6251 | Number of tests: 14 08:29:20 INFO - PROCESS | 6251 | 08:29:20 INFO - PROCESS | 6251 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.84 (1.7%) stddev-sans-first:1.94 08:29:20 INFO - PROCESS | 6251 | Values: 110.0 106.0 112.0 111.0 112.0 112.0 111.0 111.0 111.0 109.0 08:29:20 INFO - PROCESS | 6251 | 08:29:20 INFO - PROCESS | 6251 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:156.00 stddev:23.40 (15.0%) stddev-sans-first:24.80 08:29:20 INFO - PROCESS | 6251 | Values: 154.0 130.0 156.0 186.0 127.0 156.0 156.0 129.0 193.0 132.0 08:29:20 INFO - PROCESS | 6251 | 08:29:20 INFO - PROCESS | 6251 | [#2] audio-dft Cycles:10 Average:165.40 Median:164.50 stddev:4.35 (2.6%) stddev-sans-first:4.59 08:29:20 INFO - PROCESS | 6251 | Values: 164.0 165.0 163.0 165.0 170.0 176.0 163.0 162.0 163.0 163.0 08:29:20 INFO - PROCESS | 6251 | 08:29:20 INFO - PROCESS | 6251 | [#3] audio-fft Cycles:10 Average:95.70 Median:76.00 stddev:42.46 (55.9%) stddev-sans-first:44.30 08:29:20 INFO - PROCESS | 6251 | Values: 74.0 76.0 77.0 169.0 76.0 76.0 75.0 76.0 183.0 75.0 08:29:20 INFO - PROCESS | 6251 | 08:29:20 INFO - PROCESS | 6251 | [#4] audio-oscillator Cycles:10 Average:105.00 Median:86.00 stddev:30.50 (35.5%) stddev-sans-first:31.56 08:29:20 INFO - PROCESS | 6251 | Values: 86.0 85.0 148.0 85.0 89.0 86.0 144.0 86.0 86.0 155.0 08:29:20 INFO - PROCESS | 6251 | 08:29:20 INFO - PROCESS | 6251 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.00 stddev:1.58 (1.3%) stddev-sans-first:1.67 08:29:20 INFO - PROCESS | 6251 | Values: 118.0 117.0 118.0 122.0 120.0 118.0 119.0 118.0 117.0 117.0 08:29:20 INFO - PROCESS | 6251 | 08:29:20 INFO - PROCESS | 6251 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:1.51 (1.0%) stddev-sans-first:1.58 08:29:20 INFO - PROCESS | 6251 | Values: 149.0 148.0 147.0 148.0 149.0 149.0 152.0 148.0 147.0 147.0 08:29:20 INFO - PROCESS | 6251 | 08:29:20 INFO - PROCESS | 6251 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 08:29:20 INFO - PROCESS | 6251 | Values: 96.0 96.0 99.0 96.0 99.0 96.0 96.0 95.0 96.0 96.0 08:29:20 INFO - PROCESS | 6251 | 08:29:20 INFO - PROCESS | 6251 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:2.46 (4.4%) stddev-sans-first:2.45 08:29:20 INFO - PROCESS | 6251 | Values: 53.0 59.0 55.0 59.0 58.0 53.0 54.0 54.0 56.0 53.0 08:29:20 INFO - PROCESS | 6251 | 08:29:20 INFO - PROCESS | 6251 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 08:29:20 INFO - PROCESS | 6251 | Values: 61.0 61.0 60.0 60.0 60.0 60.0 62.0 62.0 61.0 61.0 08:29:20 INFO - PROCESS | 6251 | 08:29:20 INFO - PROCESS | 6251 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:80.00 stddev:7.46 (9.3%) stddev-sans-first:7.91 08:29:20 INFO - PROCESS | 6251 | Values: 82.0 77.0 79.0 80.0 80.0 80.0 85.0 80.0 103.0 80.0 08:29:20 INFO - PROCESS | 6251 | 08:29:20 INFO - PROCESS | 6251 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:130.00 stddev:4.25 (3.3%) stddev-sans-first:4.25 08:29:20 INFO - PROCESS | 6251 | Values: 124.0 130.0 130.0 130.0 122.0 123.0 125.0 130.0 133.0 134.0 08:29:20 INFO - PROCESS | 6251 | 08:29:20 INFO - PROCESS | 6251 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:160.00 stddev:3.62 (2.3%) stddev-sans-first:2.55 08:29:20 INFO - PROCESS | 6251 | Values: 168.0 157.0 162.0 160.0 160.0 160.0 164.0 157.0 156.0 159.0 08:29:20 INFO - PROCESS | 6251 | 08:29:20 INFO - PROCESS | 6251 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:1.87 (2.9%) stddev-sans-first:1.99 08:29:20 INFO - PROCESS | 6251 | Values: 64.0 64.0 68.0 67.0 63.0 64.0 63.0 64.0 62.0 63.0 08:29:20 INFO - PROCESS | 6251 | -------- Summary: end -------- 08:29:20 INFO - PROCESS | 6251 | 08:29:21 INFO - TEST-INFO | 6251: exit 0 08:29:21 INFO - TEST-OK | kraken | took 66069ms 08:29:21 INFO - SUITE-END | took 1181s 08:29:22 INFO - Completed test suite (00:19:41) 08:29:22 INFO - javascript benchmark 08:29:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7023.026935137375, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3082.1061892051302, 3085.6760040195777, 3130.9217269568258, 3133.7336326412255, 3136.827474488903, 5224.503672151144, 5263.710495922723, 5306.946930530698, 5350.5184533392085, 5366.973165134169, 5183.222516622509, 5275.235090911816, 5307.25698402223, 5351.625386222966, 5379.596530260226, 4802.08760335536, 4821.059893320804, 4865.586425153866, 4952.158133117361, 4998.8500344989525, 4760.404949381327, 4900.411950565937, 4932.309476673268, 4941.085899108676, 4953.826616068438, 4668.579827815479, 4771.045790841846, 4784.545468180518, 4840.1529732296885, 4855.32025516428, 4717.693349932243, 4719.0, 4736.881577960544, 4762.618990480788, 4811.542903424169, 4778.402699662543, 4783.593394561466, 4784.521547845223, 4816.686915350491, 4828.8652166740785, 5160.019596276696, 5170.715610641413, 5241.056609810233, 5247.711375874325, 5255.0, 5564.4713752193475, 5569.916451253234, 5578.967890940189, 5583.078791999315, 5593.664380137205, 5530.944690553083, 5623.273523629412, 5625.80309689163, 5628.521575666074, 5651.632643878176, 5138.152204886189, 5190.065788158167, 5195.818146364859, 5197.116490196676, 5219.634625576249, 5655.4910058094965, 5675.517581005578, 5679.545636349082, 5701.629394089371, 5712.371639119693, 5401.7299135043095, 5441.075017247077, 5446.8910621787345, 5502.679356954302, 5502.944970550243, 5628.240187574707, 5702.201691763156, 5715.399883012307, 5723.084306510938, 5732.885342293131, 5488.7530061147345, 5552.944470555323, 5621.747021384048, 5671.858203544944, 5689.0328644130595, 5377.300950876439, 5570.832875013756, 5657.773689052392, 5668.26312579362, 5673.262475878109, 4333.609975102256, 4367.148406060787, 4369.213541562549, 4397.450318710161, 4403.163398954189, 3893.980530097331, 3919.529656441245, 3925.685945124383, 3930.253251882133, 3964.781936993493, 5269.762860671279, 5407.0, 5437.293151890229, 5481.177823326533, 5501.092319767274, 5764.279465066867, 5768.971155144198, 5785.537157027427, 5795.333536643256, 5836.037053886062, 5480.506754392124, 5509.614326997152, 5518.392976772552, 5531.197976293415, 5532.3914369419335, 4852.563269305709, 4891.633127515451, 4893.510648935078, 4938.43208031081, 4952.851414457572, 5859.44335288147, 5870.295564532284, 5872.853178670482, 5877.823665290048, 5879.735411906475, 5701.201831743642, 5722.742476588647, 5724.341700704389, 5729.255196824386, 5746.9712651436475, 5674.0, 5806.796762113306, 5815.854603634943, 5828.125781132694, 5842.211301474246, 5581.413951535031, 5627.690477023803, 5628.071368224197, 5632.5212356950115, 5636.577256705681, 5570.498655121059, 5693.174489699053, 5733.942660573341, 5739.0, 5746.224259724883, 5442.673439593637, 5557.0, 5567.47109024642, 5622.32532096151, 5653.858653533694, 5448.210009548672, 5450.31871016123, 5474.863128421821, 5492.0, 5529.834104976857, 5432.511074003359, 5451.563874890078, 5454.59090568201, 5455.208994695668, 5457.645253058538, 5352.759125839269, 5536.2249285100925, 5570.944290557205, 5641.40765219646, 5679.091345384883, 5429.321334833146, 5471.9179212311055, 5513.724313784214, 5522.0336441121835, 5525.11598144295], "value": 5224.081816983832, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.678426865224, 625.612120485299, 632.9493640508757, 646.0180525601087, 662.8210383196534, 38023.61976380235, 42654.14691706172, 42695.35956960648, 42828.785856070754, 43130.56869431305, 43557.0, 44334.33498497525, 44392.778036109776, 44431.77784111075, 44599.0, 8901.688440904585, 8986.505742184178, 9004.279657627374, 9035.41269817463, 9098.226650734696, 8881.378303518724, 9001.864972025392, 9019.909800901973, 9039.0, 9063.682771103013, 9017.774555636095, 9025.774355641095, 9070.365074444791, 9077.546122693871, 9152.8627070594, 8984.41601295917, 9088.591013404413, 9090.954545227265, 9109.908900910972, 9115.544222788834, 8869.73390798277, 8874.86687699685, 8914.197722204968, 8988.146126118008, 8999.865002024975, 34650.82674586611, 41891.790541047405, 41915.7904210477, 42125.789371052946, 42230.0, 3327.5175099610665, 3387.627360990289, 3558.2349794794245, 3707.7589956653, 3989.162275922031, 31300.37399252002, 31575.36849263002, 31586.0, 32768.5084723727, 34691.0, 4478.171538265431, 4555.863324100283, 4566.337881007235, 4633.397658304432, 4663.417072865892, 353913.0, 361123.0, 361498.0, 363164.0, 363225.0, 34348.82825585856, 35842.10394740153, 63994.0, 64465.67767161134, 65140.34859651438, 37187.25625487529, 37425.625743742756, 37597.0, 37672.811635941645, 37725.245495090494, 15575.143367114692, 16006.759898601531, 16043.0, 16107.275172617261, 16110.75833862493, 13287.06990510655, 13437.798433023512, 13437.798433023512, 13466.730665386638, 13498.32508374597, 8390.664373424994, 8441.15588441151, 8456.492610443393, 8531.616077276538, 8537.487750734976, 3300.339932013607, 3350.9832450838076, 3375.5443015192636, 3401.7788843725575, 3428.9485657715154, 986.7237173591406, 1003.7089244119123, 1038.6676263595728, 1078.8813230544633, 1152.3143729480946, 32471.0, 32633.673663263064, 32706.67293327084, 32808.3438331232, 32818.17954551155, 996.2478328861663, 1055.5039131608132, 1075.499892549968, 1119.082352470966, 1181.6041626055196, 17047.744283835753, 17156.313747449964, 17158.142092895305, 17227.138643068047, 17265.0, 553392.0, 556781.0, 557240.0, 559261.0, 559845.0, 60265.0, 60979.69510152421, 60986.695066524386, 61020.08469872955, 61152.38847611467, 1340.8189894364332, 1342.9462821487227, 1360.340234986031, 1363.8977076719286, 1369.1511263016794, 29809.10572682823, 31078.37843243077, 31134.377312453173, 31443.528347074356, 31841.0, 50459.495405046946, 50648.24027639515, 51198.48801512086, 51282.23076653779, 51302.23046654378, 436123.0, 437833.0, 439213.0, 439259.0, 441236.0, 28798.568021480114, 28929.940745904663, 29110.12669619915, 29184.7081529182, 29245.122646320644, 48609.5139048605, 49853.50146498489, 50088.248676269155, 50506.74746626243, 50963.0, 41061.58938410578, 42165.57834421616, 42238.57761422346, 43222.567774321855, 43319.0, 41189.0, 41195.0, 41408.1718365625, 41512.377314339705, 41662.58337416587, 41800.79099604482, 41807.0, 42049.0, 43102.0, 43114.56885431105, 36082.27835443329, 38004.429933551575, 38376.0, 38887.894339021754, 39010.0, 28611.14166575006, 28652.0, 28681.0, 28910.132696019155, 29182.416351673273], "value": 19207.679162054897, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.204696278703, 386.7118996347721, 392.09426225419264, 396.16804710108767, 408.5220292258058, 13553.254570998592, 15298.082115073103, 18573.442796716085, 19444.805551944475, 19507.41477755666, 17581.94508329498, 17802.376916807916, 17993.92036477809, 19132.808671913277, 19437.31969381072, 5664.943350566504, 5698.601097923147, 5792.768289268424, 5912.645241285515, 5913.438223368773, 5688.829335119953, 5715.228444160027, 5756.366799652056, 5764.077747560391, 5789.39211382805, 5199.220116982445, 5497.780088796443, 5700.458456446631, 5718.7426565804435, 5720.227769251161, 5457.754401051962, 5500.697461639628, 5513.696746678931, 5542.362628297757, 5594.58040646951, 5556.611037227396, 5557.6109672322955, 5645.971770141164, 5658.915116273218, 5661.150827375926, 12946.223226606433, 12979.0, 13362.930965522832, 13528.25594592297, 13623.25072121033, 2209.933701988943, 2238.832087593437, 2247.2471721973156, 2320.0951628864755, 2402.303332033708, 9782.266330025206, 10188.59245630174, 10204.387736735745, 10230.744231394201, 10643.84034239487, 1894.4222012286248, 1956.334846152315, 1967.8130577595248, 1983.978251200633, 1984.6526857799972, 53305.0, 74731.25268747297, 77799.22200778034, 79031.0, 79051.6047419765, 10448.634297799692, 10495.632652857113, 10583.682489525327, 10881.347119172875, 10894.67315980522, 15124.773128403083, 15188.0, 15192.544223673307, 15237.466688665843, 15292.235388230543, 7737.419693523008, 7789.610519474004, 7967.482113662593, 8034.875117483557, 8113.0, 7505.174430812606, 7587.165411804697, 7609.391248700091, 7661.348785353307, 7753.8449231015065, 4538.364628951949, 4545.159145558082, 4605.0, 4613.2008516678525, 4641.489436162019, 1883.4349695091419, 1924.6343194792944, 1943.815337542931, 1969.891655958936, 1994.4614953962348, 968.3850754770631, 972.8492083726892, 1005.6379703306803, 1042.2339580408393, 1068.1721665709138, 18587.16357763904, 18626.53433664142, 19299.228030878607, 19422.90288548548, 19427.0, 957.1863915671623, 978.0903759503587, 1005.6681295172575, 1021.5556233038652, 1039.443897514826, 10465.319754215952, 10716.35701857891, 10803.405812680221, 10863.945680271549, 10881.673549793519, 502664.0, 519044.0, 525776.0, 536538.0, 545389.0, 73872.63063684647, 82937.58531207305, 87026.56486717526, 88430.0, 90819.54590227007, 959.8944116147218, 971.8007808399261, 994.4480813148772, 994.7463396833762, 997.0478193325357, 16961.745573816155, 17177.828221717624, 17228.91385543064, 17566.0, 18010.459686209433, 29418.55872161962, 38154.0, 39160.80419597884, 39372.40941385939, 40016.19967600574, 54786.0, 56150.7192464035, 56931.0, 57166.7141664289, 57215.713921431794, 7203.351698347174, 7948.085970113511, 8045.919540804517, 8129.715459958873, 8176.223258790405, 7784.065912090359, 11183.72040698989, 12679.746405071663, 13491.527796527074, 13604.04771665974, 11774.175807693378, 11883.0, 12097.818532722193, 12155.45300461499, 12158.574449894211, 11558.42207889619, 11628.244164129304, 11974.461149248478, 12015.399230038638, 12084.75830483403, 11762.94118529402, 12090.939545302217, 12401.813972790596, 12506.562270320495, 12849.35753212317, 8267.255946964802, 8458.577071146541, 8571.100034496289, 8581.442206256574, 8589.312854971713, 8876.378653494194, 11398.829017564909, 11907.345096019802, 11958.58144964922, 11994.880051199376], "value": 8888.043414582058, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.7564314066608, 1438.1155589312573, 1560.6722588256466, 1706.9402570910006, 1712.3749831311568, 7541.0, 8266.504009759403, 8317.168283171679, 8759.605817738202, 8881.200691937733, 8216.342692584594, 8538.48769073856, 8546.316294696426, 8555.61499732512, 8659.870101948476, 2205.625043742564, 2257.2099765082253, 2262.9434264143365, 2264.2641141628956, 2267.1724820440504, 2157.7842215778455, 2169.652855543113, 2207.1171531387413, 2221.700070490487, 2231.207921187979, 2212.8008479236946, 2229.721284839395, 2243.7083179186684, 2249.707538020055, 2251.0320562158267, 2114.048678094848, 2126.11766117062, 2129.7976692214215, 2131.79747923947, 2132.445564153316, 2144.7426308843037, 2149.613069647463, 2154.332157031325, 2160.2655097266847, 2161.189553917281, 8611.440256383377, 8619.482831030158, 8679.913200868037, 8687.869681954775, 8712.303015758724, 5001.749912504397, 5081.517255860725, 5115.616328775357, 5119.539241468286, 5159.767810448501, 3016.2096946817232, 3119.142235885127, 3196.4246435641576, 3205.439048166585, 3232.660570640096, 1076.8815430302739, 1084.6637542361814, 1098.4946924414778, 1133.7222380516826, 1135.4720055174384, 11041.558337666484, 11397.658070257905, 11408.372539510323, 11519.654410367702, 11850.466728997217, 4302.139572085595, 4344.674149438804, 4451.933221001687, 4460.397846290774, 4470.798814053375, 9297.953510232406, 9355.251579873593, 9356.532173391302, 9385.249180065579, 9420.24638028956, 5063.594912406998, 5095.439501654815, 5097.541221290102, 5100.387953445536, 5121.180611102206, 4054.3107671695884, 4516.81932722694, 4705.5059218781535, 4740.099381117577, 4779.02030083832, 3650.178709790276, 3674.926501469956, 3741.345264578688, 3749.8312575934146, 3897.512810898638, 1122.5734220995969, 1129.8474705914762, 1141.57191053355, 1146.7133216695827, 1156.9016633586239, 955.3312681123242, 964.9662261820803, 976.1995163965622, 987.4075554667143, 1000.1698590170141, 5664.433556644302, 5724.971375143181, 5843.912341314884, 5884.440978107073, 5890.823275301748, 437.2217452933783, 443.07839693438217, 449.53922229714806, 450.3222649911927, 455.71973236459337, 3834.079820842978, 3876.8449262029767, 3902.512185976753, 3924.3917192835156, 3957.3668213086344, 9715.70852874415, 10098.192144628412, 10311.381317120997, 10394.48027598617, 10464.790704186025, 10402.11582015522, 10459.790804184026, 10502.05481506668, 10506.684799456028, 10569.312994655324, 7710.421718371144, 8078.272955434039, 8126.228008339198, 8200.384971127189, 8221.630026648816, 5802.796902108406, 5827.921834460638, 5869.236999190078, 5893.941060589511, 5970.492508136857, 9565.569549370155, 9764.560594773111, 9772.657956971472, 9847.556859941464, 9856.655017074369, 9485.430874147572, 9503.0, 9819.06718861707, 9832.31173817826, 9977.850332244878, 7349.412047036118, 7854.528728276322, 7967.760967170994, 8146.470479418819, 8225.71210007647, 8178.67285308581, 8343.207395297437, 8448.281896038905, 8507.95746021266, 8557.187067228604, 7365.116186057493, 7686.3466605336935, 7700.807479813049, 7708.190639982945, 7781.105172905189, 7451.627418628938, 7520.699172033057, 7690.538567685957, 7723.073231212291, 7767.184445633127, 6994.755183568551, 7181.461390395846, 7194.928050719426, 7203.783886483414, 7249.202587715453, 4790.760461976817, 5008.298838162587, 5056.949430505648, 5144.0, 5153.974230128975, 5108.59131269505, 5127.820526281712, 5180.507851754077, 5192.909489007351, 5210.348706411699], "value": 4395.187617157643, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.75930635145073, 317.99682003179964, 318.5969748268441, 320.20748647098446, 321.42144140547015, 5430.67415955043, 5497.340319161696, 5519.282493275873, 5601.635893666919, 5617.932592807364, 5606.719664016803, 5609.915851262224, 5613.747381367838, 5621.213030175779, 5631.4087020862735, 4319.4600674915555, 4336.739795612258, 4340.500842403117, 4342.609165175134, 4347.804348804296, 4096.406021126935, 4294.49692607588, 4317.43873296471, 4360.563943605645, 4386.363977223301, 4179.958200418003, 4182.456280683522, 4238.131183107455, 4249.553796851333, 4264.78676066197, 4263.529082466544, 4275.273203555403, 4276.935845962313, 4278.486581610196, 4291.120320334355, 3495.3358861816173, 3719.163188282642, 3720.8697695580795, 3727.7576957497945, 3749.362608356586, 5351.678899266057, 5368.248445217672, 5388.676679399248, 5393.703346315951, 5411.458854114597, 4846.36997190363, 4865.7323847188745, 4876.60987121033, 4879.707217566922, 4881.4630390657, 5533.501984821345, 5814.127880817869, 5822.446867547618, 5822.854428639318, 5873.471387575096, 4078.877633670995, 4083.224187404384, 4097.242010228118, 4106.938395924063, 4114.5679703630985, 6032.27612686476, 6088.082254089947, 6099.634021958696, 6109.755609775603, 6109.969450152766, 4039.3940908863906, 4119.958800412018, 4144.854930077433, 4162.62536371728, 4167.937480937789, 4183.226103170923, 4187.706860519735, 4192.4759405074365, 4198.6011328923705, 4210.736778966359, 4819.373481447389, 4852.902941941142, 4857.615579559879, 4875.585575226146, 4891.26631005352, 5301.469853014668, 5882.911756323659, 5925.555583331267, 5935.970320148458, 5946.583739138218, 1450.0936914428482, 1450.5285782120852, 1458.2125652147722, 1462.1227263641942, 1462.3127130248765, 882.9735107946772, 907.4373888189365, 917.8623206518942, 921.2860033474111, 922.6078916460477, 5029.673071250357, 5056.443791182967, 5081.669691470117, 5088.618353623419, 5095.286659867622, 5335.733213339317, 5351.752264049109, 5388.272583201296, 5411.945880541223, 5421.918671219935, 5076.873078173001, 5112.105381558213, 5137.306463627438, 5365.041759757738, 5869.354371019184, 3199.2161920329204, 3218.4045951499047, 3220.162757683019, 3251.170951407376, 3283.195617073832, 6055.636661800306, 6320.905186422207, 6324.3043265240785, 6356.491480681627, 6361.395667411589, 6133.662648554372, 6141.907871381933, 6154.5384096192965, 6191.164192834, 6208.099825525273, 6281.214848143982, 6321.1150438938585, 6337.397947195009, 6341.904871426932, 6383.648584493086, 5878.147668588116, 6076.572005578597, 6083.878322433615, 6087.391260873877, 6099.237595300588, 5983.880322393615, 5987.491063259672, 5992.310884248367, 6036.9698151508965, 6043.969780151247, 5983.640981541122, 6196.876062478635, 6240.0, 6310.495160387066, 6328.46208072319, 4216.367544868294, 4222.535521092739, 4236.152769446185, 4249.192653395845, 4251.893702657459, 5837.795677151279, 5858.5898987072205, 6114.0, 6121.602095863755, 6179.3202747698615, 5866.765329386777, 5872.150272664097, 5877.23595932526, 5882.970480165868, 5910.704464776658, 5815.273090863642, 5838.32859221178, 5840.445157710011, 5844.649321040752, 5866.061430171152, 5564.944350556604, 5688.800891968761, 5727.599068065362, 5743.684097374685, 5765.0, 5845.590808643354, 5906.911396329145, 5937.376575459514, 5969.880602388015, 5987.6108052976415, 5503.889922201613, 5735.54115670737, 5740.712964351849, 5799.811038736964, 5871.6770577618645], "value": 4386.989926721106, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.5168213746865, 601.3625556909674, 632.8955722305818, 675.0043685563793, 723.4827098624482, 14434.927825360885, 14683.559493215207, 15103.62240943977, 15115.546533603982, 15129.394824207046, 14323.0, 14413.567592972202, 14415.567532974, 14429.422823087063, 14431.567052988426, 661.7816120680188, 774.2296415066988, 784.051297929506, 787.0516028186022, 798.321426787232, 781.945263831532, 785.426638553856, 788.388998526144, 789.0531362365156, 790.4111436979458, 842.963155318958, 845.4335595151264, 846.4328899637258, 846.8010017645848, 847.4533925617973, 838.6771093129158, 839.7480755773244, 842.6039761312173, 843.8185790055168, 844.269706703703, 609.7073404765692, 609.8201030695956, 613.4172536090687, 613.7391608566342, 615.5198944823045, 11481.138914581355, 11663.59177428786, 11675.532978680927, 11697.3566453845, 11704.53181872724, 14529.0, 14701.55895323142, 14815.18516481593, 14925.776113358308, 14981.70036599262, 11366.204365694404, 11372.431378431045, 11480.253783504046, 11541.538338466451, 11893.0, 3763.435484677293, 3830.7701537907815, 3905.1408690088133, 3942.5860284669984, 4023.919521609581, 75579.62210188969, 75668.0, 76528.61735691341, 76809.61595192044, 76925.61537192334, 10729.83905241422, 10759.085477734323, 10892.891071089347, 10961.725956850983, 11069.778604427866, 21778.128874845144, 22019.11923523041, 22046.11815527393, 22108.336749897528, 22831.0, 8041.0, 8112.716054938167, 8153.836923261501, 8161.0, 8457.534835584102, 4438.245498265238, 4500.077484115748, 4521.443906335826, 4526.140033393644, 4580.221362368406, 3594.964050359463, 3673.430618254175, 3683.723720720957, 3714.721395895265, 3721.7953012584567, 536.0752701589727, 547.0454057669392, 557.2059814763945, 565.2115299157653, 579.3684883477031, 613.187526527353, 638.1608185236399, 640.3052687833659, 660.0264609700653, 661.83784972682, 8622.698205562776, 8964.551772411354, 8985.865212021825, 9007.189352958265, 9263.722088337361, 502.5828562293288, 503.69778133119837, 510.2397427832503, 511.3914441814229, 574.0986650957956, 4192.413062171298, 4216.198922204771, 4236.682248831288, 4276.593723596254, 4418.558144185556, 72692.27307726961, 74528.62735686396, 76498.0, 81030.0, 86068.0, 63994.040089398695, 91267.0, 95385.52307238558, 96173.15307387627, 101785.0, 90427.0, 90577.47112644342, 91459.0, 92104.0, 93148.0, 8192.467489613156, 8291.95854020726, 8293.129221431664, 8338.04112527067, 8357.456765310235, 48734.75632621814, 53084.73457632842, 53318.46681533135, 53911.73044134754, 56249.718751405984, 69408.0, 78270.56429639175, 79206.20793791988, 80655.0, 82097.0, 11072.280301780358, 11177.618931713276, 11311.208215424842, 11477.483513241757, 11614.361210133524, 11573.652790416301, 12114.878851211375, 12126.75746485083, 12139.271643701053, 12142.575009874612, 10776.892231077902, 10842.674719758419, 10935.28920620157, 11159.38623375722, 11372.574495410066, 10340.793184136426, 11181.273217240854, 11317.547298107984, 11779.823302650295, 12140.757184856076, 10866.348019118877, 11294.435278235891, 11664.94167529157, 12298.631041068424, 12393.194442361219, 10159.44123073238, 10264.948675256575, 10297.639582614873, 10357.274990750575, 10651.254412191072, 9911.091386884355, 10331.0, 10337.534810933677, 10397.688069357931, 10461.110805581611], "value": 6976.97716599053, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 112.0, 111.0, 112.0, 112.0, 111.0, 111.0, 111.0, 109.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 130.0, 156.0, 186.0, 127.0, 156.0, 156.0, 129.0, 193.0, 132.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 163.0, 165.0, 170.0, 176.0, 163.0, 162.0, 163.0, 163.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 77.0, 169.0, 76.0, 76.0, 75.0, 76.0, 183.0, 75.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 148.0, 85.0, 89.0, 86.0, 144.0, 86.0, 86.0, 155.0], "value": 105.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 122.0, 120.0, 118.0, 119.0, 118.0, 117.0, 117.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 148.0, 149.0, 149.0, 152.0, 148.0, 147.0, 147.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 99.0, 96.0, 99.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 59.0, 55.0, 59.0, 58.0, 53.0, 54.0, 54.0, 56.0, 53.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 60.0, 60.0, 60.0, 62.0, 62.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 79.0, 80.0, 80.0, 80.0, 85.0, 80.0, 103.0, 80.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 130.0, 130.0, 130.0, 122.0, 123.0, 125.0, 130.0, 133.0, 134.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 157.0, 162.0, 160.0, 160.0, 160.0, 164.0, 157.0, 156.0, 159.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 68.0, 67.0, 63.0, 64.0, 63.0, 64.0, 62.0, 63.0], "value": 64.2, "unit": "score"}]}]} 08:29:22 INFO - Return code: 0 08:29:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:29:22 ERROR - # TBPL SUCCESS # 08:29:22 INFO - Running post-action listener: _resource_record_post_action 08:29:22 INFO - ##### 08:29:22 INFO - ##### Finished run-tests step (success) 08:29:22 INFO - ##### 08:29:22 INFO - Running post-run listener: _resource_record_post_run 08:29:22 INFO - Total resource usage - Wall time: 1209s; CPU: 14.0%; Read bytes: 4096; Write bytes: 535683072; Read time: 36; Write time: 4223692 08:29:22 INFO - TinderboxPrint: CPU usage
14.1% 08:29:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 36 08:29:22 INFO - TinderboxPrint: I/O write bytes / time
535,683,072 / 4,223,692 08:29:22 INFO - TinderboxPrint: CPU idle
8,282.1 (85.9%) 08:29:22 INFO - TinderboxPrint: CPU user
1,225.5 (12.7%) 08:29:22 INFO - TinderboxPrint: Swap in / out
0 / 0 08:29:22 INFO - install - Wall time: 24s; CPU: 30.0%; Read bytes: 0; Write bytes: 219668480; Read time: 0; Write time: 2257252 08:29:22 INFO - run-tests - Wall time: 1186s; CPU: 14.0%; Read bytes: 4096; Write bytes: 310009856; Read time: 36; Write time: 1629520 08:29:22 INFO - Running post-run listener: _upload_blobber_files 08:29:22 INFO - Blob upload gear active. 08:29:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:29:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:29:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:29:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:29:23 INFO - (blobuploader) - INFO - Open directory for files ... 08:29:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:29:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:29:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:27 INFO - (blobuploader) - INFO - Done attempting. 08:29:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:29:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:29:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:27 INFO - (blobuploader) - INFO - Done attempting. 08:29:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:29:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:29:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:28 INFO - (blobuploader) - INFO - Done attempting. 08:29:28 INFO - (blobuploader) - INFO - Iteration through files over. 08:29:28 INFO - Return code: 0 08:29:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:29:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:29:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/36829f11ef161d6c3a47e4ae06dd2b8a2a2c346d16f96ebc2824c9476f9f6b612c1797516ab292e633e6c46a7eab3c2eabfa9fb955af6b004417642853ca0d28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d467919a4f3cbb923695a8e0f8d59b0dd6c9991e6a7e0a461f4056a42e216701cb61a06a5444509910bc705d7c5915b0056f8c2ccad134240b9867cf079cb9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f9b9785afd6bee0eda2cf4e59df90c6bb348b851c6ae547bd9d888812aa35cab560d9a4283b71a2872137a40195d4e9a549f8315d4980eee1469f312c31ace6d"} 08:29:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:29:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:29:28 INFO - Contents: 08:29:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/36829f11ef161d6c3a47e4ae06dd2b8a2a2c346d16f96ebc2824c9476f9f6b612c1797516ab292e633e6c46a7eab3c2eabfa9fb955af6b004417642853ca0d28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d467919a4f3cbb923695a8e0f8d59b0dd6c9991e6a7e0a461f4056a42e216701cb61a06a5444509910bc705d7c5915b0056f8c2ccad134240b9867cf079cb9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f9b9785afd6bee0eda2cf4e59df90c6bb348b851c6ae547bd9d888812aa35cab560d9a4283b71a2872137a40195d4e9a549f8315d4980eee1469f312c31ace6d"} 08:29:28 INFO - Running post-run listener: copy_logs_to_upload_dir 08:29:28 INFO - Copying logs to upload dir... 08:29:28 INFO - mkdir: /builds/slave/test/build/upload/logs 08:29:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.077187 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-09 08:29:28.384331) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 08:29:28.388144) ========= 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=33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714 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/36829f11ef161d6c3a47e4ae06dd2b8a2a2c346d16f96ebc2824c9476f9f6b612c1797516ab292e633e6c46a7eab3c2eabfa9fb955af6b004417642853ca0d28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d467919a4f3cbb923695a8e0f8d59b0dd6c9991e6a7e0a461f4056a42e216701cb61a06a5444509910bc705d7c5915b0056f8c2ccad134240b9867cf079cb9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f9b9785afd6bee0eda2cf4e59df90c6bb348b851c6ae547bd9d888812aa35cab560d9a4283b71a2872137a40195d4e9a549f8315d4980eee1469f312c31ace6d"} build_url:https://queue.taskcluster.net/v1/task/VPFKjuq9R5Sxxb19erkuqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/VPFKjuq9R5Sxxb19erkuqw/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/36829f11ef161d6c3a47e4ae06dd2b8a2a2c346d16f96ebc2824c9476f9f6b612c1797516ab292e633e6c46a7eab3c2eabfa9fb955af6b004417642853ca0d28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7d467919a4f3cbb923695a8e0f8d59b0dd6c9991e6a7e0a461f4056a42e216701cb61a06a5444509910bc705d7c5915b0056f8c2ccad134240b9867cf079cb9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f9b9785afd6bee0eda2cf4e59df90c6bb348b851c6ae547bd9d888812aa35cab560d9a4283b71a2872137a40195d4e9a549f8315d4980eee1469f312c31ace6d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 08:29:28.413491) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 08:29:28.413829) ========= 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=33d5923976266a1c518c4bf7000001ab-1465484912.683997-2027876714 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 08:29:28.496557) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 08:29:28.496876) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 08:29:28.497153) ========= ========= Total master_lag: 0.17 =========