builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1465874344.71 results: success (0) buildid: 20160613173002 builduid: 80fc03783fe5462ebf300e02e53d6767 revision: 79bcc05ef105fb5362888694307faa261615c34d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 20:19:04.710521) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 20:19:04.711046) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 20:19:04.711394) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 20:19:04.786102) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 20:19:04.786439) ========= 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=3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-13 20:19:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-06-13 20:19:05 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.213804 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 20:19:05.030027) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 20:19:05.030383) ========= 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=3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015125 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 20:19:05.083385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 20:19:05.084345) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 79bcc05ef105fb5362888694307faa261615c34d --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 79bcc05ef105fb5362888694307faa261615c34d --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=3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-13 20:19:06,068 truncating revision to first 12 chars 2016-06-13 20:19:06,068 Setting DEBUG logging. 2016-06-13 20:19:06,068 attempt 1/10 2016-06-13 20:19:06,068 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/79bcc05ef105?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-13 20:19:06,476 unpacking tar archive at: fx-team-79bcc05ef105/testing/mozharness/ program finished with exit code 0 elapsedTime=0.726608 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 20:19:05.822057) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 20:19:05.822411) ========= script_repo_revision: 79bcc05ef105fb5362888694307faa261615c34d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 20:19:05.822835) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 20:19:05.823154) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 20:19:05.830704) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-13 20:19:05.831044) ========= /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=3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:19:06 INFO - MultiFileLogger online at 20160613 20:19:06 in /builds/slave/test 20:19:06 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 20:19:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:19:06 INFO - {'append_to_log': False, 20:19:06 INFO - 'base_work_dir': '/builds/slave/test', 20:19:06 INFO - 'blob_upload_branch': 'Fx-Team', 20:19:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:19:06 INFO - 'branch': 'Fx-Team', 20:19:06 INFO - 'buildbot_json_path': 'buildprops.json', 20:19:06 INFO - 'config_files': ('talos/linux_config.py',), 20:19:06 INFO - 'default_actions': ('clobber', 20:19:06 INFO - 'read-buildbot-config', 20:19:06 INFO - 'download-and-extract', 20:19:06 INFO - 'populate-webroot', 20:19:06 INFO - 'create-virtualenv', 20:19:06 INFO - 'install', 20:19:06 INFO - 'run-tests'), 20:19:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:19:06 INFO - 'download_minidump_stackwalk': True, 20:19:06 INFO - 'download_symbols': 'ondemand', 20:19:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:19:06 INFO - 'tooltool.py': '/tools/tooltool.py', 20:19:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:19:06 INFO - '/tools/misc-python/virtualenv.py')}, 20:19:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:19:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:19:06 INFO - 'installer_path': 'installer.exe', 20:19:06 INFO - 'log_level': 'info', 20:19:06 INFO - 'log_name': 'talos', 20:19:06 INFO - 'log_to_console': True, 20:19:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:19:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:19:06 INFO - 'opt_config_files': (), 20:19:06 INFO - 'pip_index': False, 20:19:06 INFO - 'sps_profile': False, 20:19:06 INFO - 'sps_profile_interval': 0, 20:19:06 INFO - 'suite': 'dromaeojs-e10s', 20:19:06 INFO - 'system_bits': '32', 20:19:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:19:06 INFO - 'title': 'talos-linux64-ix-059', 20:19:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:19:06 INFO - 'use_talos_json': True, 20:19:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:19:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:19:06 INFO - 'work_dir': 'build'} 20:19:06 INFO - ##### 20:19:06 INFO - ##### Running clobber step. 20:19:06 INFO - ##### 20:19:06 INFO - Running pre-action listener: _resource_record_pre_action 20:19:06 INFO - Running main action method: clobber 20:19:06 INFO - rmtree: /builds/slave/test/build 20:19:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:19:07 INFO - Running post-action listener: _resource_record_post_action 20:19:07 INFO - ##### 20:19:07 INFO - ##### Finished clobber step (success) 20:19:07 INFO - ##### 20:19:07 INFO - ##### 20:19:07 INFO - ##### Running read-buildbot-config step. 20:19:07 INFO - ##### 20:19:07 INFO - Running pre-action listener: _resource_record_pre_action 20:19:07 INFO - Running main action method: read_buildbot_config 20:19:07 INFO - Using buildbot properties: 20:19:07 INFO - { 20:19:07 INFO - "project": "", 20:19:07 INFO - "product": "firefox", 20:19:07 INFO - "script_repo_revision": "production", 20:19:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:19:07 INFO - "repository": "", 20:19:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:19:07 INFO - "buildid": "20160613173002", 20:19:07 INFO - "pgo_build": "True", 20:19:07 INFO - "basedir": "/builds/slave/test", 20:19:07 INFO - "buildnumber": 556, 20:19:07 INFO - "slavename": "talos-linux64-ix-059", 20:19:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:19:07 INFO - "platform": "ubuntu64_hw", 20:19:07 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:19:07 INFO - "branch": "fx-team", 20:19:07 INFO - "repo_path": "integration/fx-team", 20:19:07 INFO - "revision": "79bcc05ef105fb5362888694307faa261615c34d", 20:19:07 INFO - "stage_platform": "linux64-pgo", 20:19:07 INFO - "builduid": "80fc03783fe5462ebf300e02e53d6767", 20:19:07 INFO - "slavebuilddir": "test" 20:19:07 INFO - } 20:19:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:19:07 INFO - Running post-action listener: _resource_record_post_action 20:19:07 INFO - ##### 20:19:07 INFO - ##### Finished read-buildbot-config step (success) 20:19:07 INFO - ##### 20:19:07 INFO - ##### 20:19:07 INFO - ##### Running download-and-extract step. 20:19:07 INFO - ##### 20:19:07 INFO - Running pre-action listener: _resource_record_pre_action 20:19:07 INFO - Running main action method: download_and_extract 20:19:07 INFO - mkdir: /builds/slave/test/build/tests 20:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:07 INFO - https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:19:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:19:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:19:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/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 20:19:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/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 20:19:15 INFO - Downloaded 1361 bytes. 20:19:15 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:19:15 INFO - Using the following test package requirements: 20:19:15 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:19:15 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:19:15 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:19:15 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:15 INFO - u'jsshell-linux-x86_64.zip'], 20:19:15 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:19:15 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:19:15 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:19:15 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:19:15 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:19:15 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:19:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:19:15 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:15 INFO - https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:19:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:19:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:19:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/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 20:19:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/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 20:19:17 INFO - Downloaded 24219727 bytes. 20:19:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:19:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:19:18 INFO - Return code: 0 20:19:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:18 INFO - https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:19:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:19:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:19:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/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 20:19:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/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 20:19:24 INFO - Downloaded 24219727 bytes. 20:19:24 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'] 20:19:24 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 20:19:25 INFO - Return code: 0 20:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:25 INFO - https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:19:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:19:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:19:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/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 20:19:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/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 20:19:27 INFO - Downloaded 14405384 bytes. 20:19:27 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'] 20:19:27 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 20:19:27 INFO - Return code: 0 20:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:27 INFO - https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:19:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:19:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:19:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/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 20:19:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VdRlrr5EToObkXHZ4mSutA/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 20:19:28 INFO - Downloaded 59358540 bytes. 20:19:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:19:28 INFO - mkdir: /builds/slave/test/properties 20:19:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:19:28 INFO - Writing to file /builds/slave/test/properties/build_url 20:19:28 INFO - Contents: 20:19:28 INFO - build_url:https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:19:29 INFO - Running post-action listener: _resource_record_post_action 20:19:29 INFO - Running post-action listener: set_extra_try_arguments 20:19:29 INFO - ##### 20:19:29 INFO - ##### Finished download-and-extract step (success) 20:19:29 INFO - ##### 20:19:29 INFO - ##### 20:19:29 INFO - ##### Running populate-webroot step. 20:19:29 INFO - ##### 20:19:29 INFO - Running pre-action listener: _resource_record_pre_action 20:19:29 INFO - Running main action method: populate_webroot 20:19:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:19:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:19:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:19:29 INFO - '--tppagecycles', 20:19:29 INFO - '7'], 20:19:29 INFO - 'tests': ['tsvgm']}}, 20:19:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:19:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:19:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:19:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:19:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:29 INFO - 'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:19:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:19:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:29 INFO - 'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['damp', 'tps']}, 20:19:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:29 INFO - 'tests': ['damp', 'tps']}, 20:19:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['dromaeo_dom']}, 20:19:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:19:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['basic_compositor_video']}, 20:19:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:19:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['a11yr', 20:19:29 INFO - 'ts_paint', 20:19:29 INFO - 'tpaint', 20:19:29 INFO - 'sessionrestore', 20:19:29 INFO - 'sessionrestore_no_auto_restore', 20:19:29 INFO - 'tabpaint']}, 20:19:29 INFO - 'other-e10s': {'tests': ['a11yr', 20:19:29 INFO - 'ts_paint', 20:19:29 INFO - 'tpaint', 20:19:29 INFO - 'sessionrestore', 20:19:29 INFO - 'sessionrestore_no_auto_restore', 20:19:29 INFO - 'tabpaint']}, 20:19:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:19:29 INFO - 'ts_paint', 20:19:29 INFO - 'tpaint', 20:19:29 INFO - 'sessionrestore', 20:19:29 INFO - 'sessionrestore_no_auto_restore', 20:19:29 INFO - 'tabpaint']}, 20:19:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:19:29 INFO - 'ts_paint', 20:19:29 INFO - 'tpaint', 20:19:29 INFO - 'sessionrestore', 20:19:29 INFO - 'sessionrestore_no_auto_restore', 20:19:29 INFO - 'tabpaint']}, 20:19:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['a11yr', 20:19:29 INFO - 'ts_paint', 20:19:29 INFO - 'tpaint', 20:19:29 INFO - 'sessionrestore', 20:19:29 INFO - 'sessionrestore_no_auto_restore', 20:19:29 INFO - 'tabpaint']}, 20:19:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['a11yr', 20:19:29 INFO - 'ts_paint', 20:19:29 INFO - 'tpaint', 20:19:29 INFO - 'sessionrestore', 20:19:29 INFO - 'sessionrestore_no_auto_restore', 20:19:29 INFO - 'tabpaint']}, 20:19:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['tsvgx', 20:19:29 INFO - 'tsvgr_opacity', 20:19:29 INFO - 'tart', 20:19:29 INFO - 'tscrollx', 20:19:29 INFO - 'cart']}, 20:19:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:19:29 INFO - 'tsvgr_opacity', 20:19:29 INFO - 'tart', 20:19:29 INFO - 'tscrollx', 20:19:29 INFO - 'cart']}, 20:19:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:29 INFO - 'talos_options': ['--disable-e10s'], 20:19:29 INFO - 'tests': ['tp5o']}, 20:19:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:29 INFO - 'tests': ['tp5o']}, 20:19:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:29 INFO - 'talos_options': ['--disable-e10s', 20:19:29 INFO - '--xperf_path', 20:19:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:19:29 INFO - 'tests': ['tp5n']}, 20:19:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:29 INFO - 'talos_options': ['--xperf_path', 20:19:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:19:29 INFO - 'tests': ['tp5n']}}, 20:19:29 INFO - 'talos.zip': {'path': '', 20:19:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:19:29 INFO - Running post-action listener: _resource_record_post_action 20:19:29 INFO - ##### 20:19:29 INFO - ##### Finished populate-webroot step (success) 20:19:29 INFO - ##### 20:19:29 INFO - ##### 20:19:29 INFO - ##### Running create-virtualenv step. 20:19:29 INFO - ##### 20:19:29 INFO - Running pre-action listener: _resource_record_pre_action 20:19:29 INFO - Running main action method: create_virtualenv 20:19:29 INFO - Creating virtualenv /builds/slave/test/build/venv 20:19:29 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 20:19:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:19:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:19:29 INFO - Using real prefix '/usr' 20:19:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:19:30 INFO - Installing distribute.............................................................................................................................................................................................done. 20:19:32 INFO - Installing pip.................done. 20:19:32 INFO - Return code: 0 20:19:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:19:32 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')]} 20:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:32 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')]} 20:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:32 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 0x7f97af758f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2569350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f81c0>, '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 0x25f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9550>, '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': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', '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 20:19:32 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 20:19:32 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 20:19:32 INFO - Using env: {'DISPLAY': ':0', 20:19:32 INFO - 'HOME': '/home/cltbld', 20:19:32 INFO - 'LANG': 'en_US.UTF-8', 20:19:32 INFO - 'LANGUAGE': 'en_US:en', 20:19:32 INFO - 'LOGNAME': 'cltbld', 20:19:32 INFO - 'MAIL': '/var/mail/cltbld', 20:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:32 INFO - 'MOZ_NO_REMOTE': '1', 20:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:32 INFO - 'NO_EM_RESTART': '1', 20:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:32 INFO - 'PWD': '/builds/slave/test', 20:19:32 INFO - 'SHELL': '/bin/bash', 20:19:32 INFO - 'SHLVL': '1', 20:19:32 INFO - 'TERM': 'linux', 20:19:32 INFO - 'TMOUT': '86400', 20:19:32 INFO - 'USER': 'cltbld', 20:19:32 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', 20:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:32 INFO - '_': '/tools/buildbot/bin/python'} 20:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:32 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 20:19:32 INFO - Cleaning up... 20:19:32 INFO - Return code: 0 20:19:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:19:32 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')]} 20:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:32 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')]} 20:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:32 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 0x7f97af758f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2569350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f81c0>, '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 0x25f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9550>, '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': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', '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 20:19:32 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 20:19:32 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 20:19:32 INFO - Using env: {'DISPLAY': ':0', 20:19:32 INFO - 'HOME': '/home/cltbld', 20:19:32 INFO - 'LANG': 'en_US.UTF-8', 20:19:32 INFO - 'LANGUAGE': 'en_US:en', 20:19:32 INFO - 'LOGNAME': 'cltbld', 20:19:32 INFO - 'MAIL': '/var/mail/cltbld', 20:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:32 INFO - 'MOZ_NO_REMOTE': '1', 20:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:32 INFO - 'NO_EM_RESTART': '1', 20:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:32 INFO - 'PWD': '/builds/slave/test', 20:19:32 INFO - 'SHELL': '/bin/bash', 20:19:32 INFO - 'SHLVL': '1', 20:19:32 INFO - 'TERM': 'linux', 20:19:32 INFO - 'TMOUT': '86400', 20:19:32 INFO - 'USER': 'cltbld', 20:19:32 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', 20:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:32 INFO - '_': '/tools/buildbot/bin/python'} 20:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:32 INFO - Downloading/unpacking psutil>=3.1.1 20:19:32 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 20:19:32 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 20:19:32 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 20:19:32 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 20:19:32 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 20:19:32 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 20:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:19:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:19:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:19:34 INFO - Installing collected packages: psutil 20:19:34 INFO - Running setup.py install for psutil 20:19:34 INFO - building 'psutil._psutil_linux' extension 20:19:34 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 20:19:34 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 20:19:34 INFO - building 'psutil._psutil_posix' extension 20:19:34 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 20:19:34 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 20:19:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:19:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:19:35 INFO - Successfully installed psutil 20:19:35 INFO - Cleaning up... 20:19:35 INFO - Return code: 0 20:19:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:19: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')]} 20:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19: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')]} 20:19:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:35 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 0x7f97af758f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2569350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f81c0>, '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 0x25f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9550>, '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': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', '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 20:19:35 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 20:19:35 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 20:19:35 INFO - Using env: {'DISPLAY': ':0', 20:19:35 INFO - 'HOME': '/home/cltbld', 20:19:35 INFO - 'LANG': 'en_US.UTF-8', 20:19:35 INFO - 'LANGUAGE': 'en_US:en', 20:19:35 INFO - 'LOGNAME': 'cltbld', 20:19:35 INFO - 'MAIL': '/var/mail/cltbld', 20:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:35 INFO - 'MOZ_NO_REMOTE': '1', 20:19:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:35 INFO - 'NO_EM_RESTART': '1', 20:19:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:35 INFO - 'PWD': '/builds/slave/test', 20:19:35 INFO - 'SHELL': '/bin/bash', 20:19:35 INFO - 'SHLVL': '1', 20:19:35 INFO - 'TERM': 'linux', 20:19:35 INFO - 'TMOUT': '86400', 20:19:35 INFO - 'USER': 'cltbld', 20:19:35 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', 20:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:35 INFO - '_': '/tools/buildbot/bin/python'} 20:19:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:19:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:19:37 INFO - Installing collected packages: mozsystemmonitor 20:19:37 INFO - Running setup.py install for mozsystemmonitor 20:19:37 INFO - Successfully installed mozsystemmonitor 20:19:37 INFO - Cleaning up... 20:19:37 INFO - Return code: 0 20:19:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:19:37 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')]} 20:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:37 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')]} 20:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:37 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 0x7f97af758f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2569350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f81c0>, '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 0x25f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9550>, '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': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', '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 20:19:37 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 20:19:37 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 20:19:37 INFO - Using env: {'DISPLAY': ':0', 20:19:37 INFO - 'HOME': '/home/cltbld', 20:19:37 INFO - 'LANG': 'en_US.UTF-8', 20:19:37 INFO - 'LANGUAGE': 'en_US:en', 20:19:37 INFO - 'LOGNAME': 'cltbld', 20:19:37 INFO - 'MAIL': '/var/mail/cltbld', 20:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:37 INFO - 'MOZ_NO_REMOTE': '1', 20:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:37 INFO - 'NO_EM_RESTART': '1', 20:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:37 INFO - 'PWD': '/builds/slave/test', 20:19:37 INFO - 'SHELL': '/bin/bash', 20:19:37 INFO - 'SHLVL': '1', 20:19:37 INFO - 'TERM': 'linux', 20:19:37 INFO - 'TMOUT': '86400', 20:19:37 INFO - 'USER': 'cltbld', 20:19:37 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', 20:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:37 INFO - '_': '/tools/buildbot/bin/python'} 20:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:37 INFO - Downloading/unpacking jsonschema==2.5.1 20:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:19:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:39 INFO - Downloading functools32-3.2.3-2.tar.gz 20:19:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:19:39 INFO - warning: no files found matching '*.txt' 20:19:39 INFO - no previously-included directories found matching 'build' 20:19:39 INFO - no previously-included directories found matching 'dist' 20:19:39 INFO - no previously-included directories found matching '.git*' 20:19:39 INFO - Installing collected packages: jsonschema, functools32 20:19:39 INFO - Running setup.py install for functools32 20:19:39 INFO - warning: no files found matching '*.txt' 20:19:39 INFO - no previously-included directories found matching 'build' 20:19:39 INFO - no previously-included directories found matching 'dist' 20:19:39 INFO - no previously-included directories found matching '.git*' 20:19:39 INFO - Successfully installed jsonschema functools32 20:19:39 INFO - Cleaning up... 20:19:40 INFO - Return code: 0 20:19:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:19:40 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')]} 20:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:40 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')]} 20:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:40 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 0x7f97af758f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2569350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f81c0>, '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 0x25f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9550>, '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': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', '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 20:19:40 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 20:19:40 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 20:19:40 INFO - Using env: {'DISPLAY': ':0', 20:19:40 INFO - 'HOME': '/home/cltbld', 20:19:40 INFO - 'LANG': 'en_US.UTF-8', 20:19:40 INFO - 'LANGUAGE': 'en_US:en', 20:19:40 INFO - 'LOGNAME': 'cltbld', 20:19:40 INFO - 'MAIL': '/var/mail/cltbld', 20:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:40 INFO - 'MOZ_NO_REMOTE': '1', 20:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:40 INFO - 'NO_EM_RESTART': '1', 20:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:40 INFO - 'PWD': '/builds/slave/test', 20:19:40 INFO - 'SHELL': '/bin/bash', 20:19:40 INFO - 'SHLVL': '1', 20:19:40 INFO - 'TERM': 'linux', 20:19:40 INFO - 'TMOUT': '86400', 20:19:40 INFO - 'USER': 'cltbld', 20:19:40 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', 20:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:40 INFO - '_': '/tools/buildbot/bin/python'} 20:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:40 INFO - Downloading/unpacking blobuploader==1.2.4 20:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:42 INFO - Downloading blobuploader-1.2.4.tar.gz 20:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:19:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:19:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:42 INFO - Downloading docopt-0.6.1.tar.gz 20:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:19:42 INFO - Installing collected packages: blobuploader, requests, docopt 20:19:42 INFO - Running setup.py install for blobuploader 20:19:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:19:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:19:42 INFO - Running setup.py install for requests 20:19:43 INFO - Running setup.py install for docopt 20:19:43 INFO - Successfully installed blobuploader requests docopt 20:19:43 INFO - Cleaning up... 20:19:43 INFO - Return code: 0 20:19:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:19: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')]} 20:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19: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')]} 20:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:43 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 0x7f97af758f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2569350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f81c0>, '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 0x25f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9550>, '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': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', '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 20:19:43 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 20:19:43 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 20:19:43 INFO - Using env: {'DISPLAY': ':0', 20:19:43 INFO - 'HOME': '/home/cltbld', 20:19:43 INFO - 'LANG': 'en_US.UTF-8', 20:19:43 INFO - 'LANGUAGE': 'en_US:en', 20:19:43 INFO - 'LOGNAME': 'cltbld', 20:19:43 INFO - 'MAIL': '/var/mail/cltbld', 20:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:43 INFO - 'MOZ_NO_REMOTE': '1', 20:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:43 INFO - 'NO_EM_RESTART': '1', 20:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:43 INFO - 'PWD': '/builds/slave/test', 20:19:43 INFO - 'SHELL': '/bin/bash', 20:19:43 INFO - 'SHLVL': '1', 20:19:43 INFO - 'TERM': 'linux', 20:19:43 INFO - 'TMOUT': '86400', 20:19:43 INFO - 'USER': 'cltbld', 20:19:43 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', 20:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:43 INFO - '_': '/tools/buildbot/bin/python'} 20:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:19:43 INFO - Running setup.py (path:/tmp/pip-Tw9BxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:19:43 INFO - Running setup.py (path:/tmp/pip-uIT3_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:19:43 INFO - Running setup.py (path:/tmp/pip-3YsnfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:19:43 INFO - Running setup.py (path:/tmp/pip-ifo15h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:19:44 INFO - Running setup.py (path:/tmp/pip-tdHDy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:19:44 INFO - Running setup.py (path:/tmp/pip-xtaawi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:19:44 INFO - Running setup.py (path:/tmp/pip-es8AuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:19:44 INFO - Running setup.py (path:/tmp/pip-k1Q7HN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:19:44 INFO - Running setup.py (path:/tmp/pip-kneBt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:19:44 INFO - Running setup.py (path:/tmp/pip-HkHorU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:19:44 INFO - Running setup.py (path:/tmp/pip-cG31x6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:19:44 INFO - Running setup.py (path:/tmp/pip-rooSgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:19:44 INFO - Running setup.py (path:/tmp/pip-kAPhpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:19:44 INFO - Running setup.py (path:/tmp/pip-UCgy48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:44 INFO - Running setup.py (path:/tmp/pip-sFKOhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:19:44 INFO - Running setup.py (path:/tmp/pip-VZ41yI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:19:44 INFO - Running setup.py (path:/tmp/pip-bNebhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:19:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:19:44 INFO - Running setup.py install for manifestparser 20:19:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:19:45 INFO - Running setup.py install for mozcrash 20:19:45 INFO - Running setup.py install for mozdebug 20:19:45 INFO - Running setup.py install for mozdevice 20:19:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:19:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:19:45 INFO - Running setup.py install for mozfile 20:19:45 INFO - Running setup.py install for mozhttpd 20:19:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:19:45 INFO - Running setup.py install for mozinfo 20:19:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:19:45 INFO - Running setup.py install for mozInstall 20:19:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:19:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:19:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:19:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:19:45 INFO - Running setup.py install for mozleak 20:19:45 INFO - Running setup.py install for mozlog 20:19:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:19:45 INFO - Running setup.py install for moznetwork 20:19:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:19:46 INFO - Running setup.py install for mozprocess 20:19:46 INFO - Running setup.py install for mozprofile 20:19:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:19:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:19:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:19:46 INFO - Running setup.py install for mozrunner 20:19:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:19:46 INFO - Running setup.py install for mozscreenshot 20:19:46 INFO - Running setup.py install for moztest 20:19:46 INFO - Running setup.py install for mozversion 20:19:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:19:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:19:46 INFO - Cleaning up... 20:19:46 INFO - Return code: 0 20:19:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:46 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 0x7f97af758f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2569350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f81c0>, '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 0x25f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9550>, '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': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', '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 20:19:46 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 20:19:46 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 20:19:46 INFO - Using env: {'DISPLAY': ':0', 20:19:46 INFO - 'HOME': '/home/cltbld', 20:19:46 INFO - 'LANG': 'en_US.UTF-8', 20:19:46 INFO - 'LANGUAGE': 'en_US:en', 20:19:46 INFO - 'LOGNAME': 'cltbld', 20:19:46 INFO - 'MAIL': '/var/mail/cltbld', 20:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:46 INFO - 'MOZ_NO_REMOTE': '1', 20:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:46 INFO - 'NO_EM_RESTART': '1', 20:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:46 INFO - 'PWD': '/builds/slave/test', 20:19:46 INFO - 'SHELL': '/bin/bash', 20:19:46 INFO - 'SHLVL': '1', 20:19:46 INFO - 'TERM': 'linux', 20:19:46 INFO - 'TMOUT': '86400', 20:19:46 INFO - 'USER': 'cltbld', 20:19:46 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', 20:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:46 INFO - '_': '/tools/buildbot/bin/python'} 20:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:19:46 INFO - Running setup.py (path:/tmp/pip-8uc9CV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:19:47 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)) 20:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:19:47 INFO - Running setup.py (path:/tmp/pip-s4XOjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:19:47 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)) 20:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:19:47 INFO - Running setup.py (path:/tmp/pip-a3sFk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:19:47 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)) 20:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:19:47 INFO - Running setup.py (path:/tmp/pip-SyQXUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:19:47 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)) 20:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:19:47 INFO - Running setup.py (path:/tmp/pip-s45RD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:19:47 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)) 20:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:19:47 INFO - Running setup.py (path:/tmp/pip-B4Ga5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:19:47 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)) 20:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:19:47 INFO - Running setup.py (path:/tmp/pip-L0QOXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:19:47 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)) 20:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:19:47 INFO - Running setup.py (path:/tmp/pip-gtK6aZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:19:47 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)) 20:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:19:47 INFO - Running setup.py (path:/tmp/pip-DVE9JA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:19:47 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)) 20:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:19:47 INFO - Running setup.py (path:/tmp/pip-SWGAR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:19:47 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)) 20:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:19:47 INFO - Running setup.py (path:/tmp/pip-SrDn5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:19:47 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)) 20:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:19:47 INFO - Running setup.py (path:/tmp/pip-nOXMT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:19:47 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)) 20:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:19:47 INFO - Running setup.py (path:/tmp/pip-erphSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:19:47 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)) 20:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:19:47 INFO - Running setup.py (path:/tmp/pip-RWXaBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:19:47 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)) 20:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:47 INFO - Running setup.py (path:/tmp/pip-wCmlMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:48 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)) 20:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:19:48 INFO - Running setup.py (path:/tmp/pip-iBMHzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:19:48 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)) 20:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:19:48 INFO - Running setup.py (path:/tmp/pip-2iPrwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:19:48 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)) 20:19:48 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)) 20:19:48 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)) 20:19:48 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)) 20:19:48 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)) 20:19:48 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)) 20:19:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:19:48 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 20:19:48 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 20:19:48 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 20:19:48 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 20:19:48 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 20:19:48 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 20:19:50 INFO - Downloading blessings-1.6.tar.gz 20:19:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:19:50 INFO - Installing collected packages: blessings 20:19:50 INFO - Running setup.py install for blessings 20:19:50 INFO - Successfully installed blessings 20:19:50 INFO - Cleaning up... 20:19:50 INFO - Return code: 0 20:19:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:19:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:19:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:19:50 INFO - Reading from file tmpfile_stdout 20:19:50 INFO - Current package versions: 20:19:50 INFO - argparse == 1.2.1 20:19:50 INFO - blessings == 1.6 20:19:50 INFO - blobuploader == 1.2.4 20:19:50 INFO - docopt == 0.6.1 20:19:50 INFO - functools32 == 3.2.3-2 20:19:50 INFO - jsonschema == 2.5.1 20:19:50 INFO - manifestparser == 1.1 20:19:50 INFO - mozInstall == 1.12 20:19:50 INFO - mozcrash == 0.17 20:19:50 INFO - mozdebug == 0.1 20:19:50 INFO - mozdevice == 0.48 20:19:50 INFO - mozfile == 1.2 20:19:50 INFO - mozhttpd == 0.7 20:19:50 INFO - mozinfo == 0.9 20:19:50 INFO - mozleak == 0.1 20:19:50 INFO - mozlog == 3.2 20:19:50 INFO - moznetwork == 0.27 20:19:50 INFO - mozprocess == 0.22 20:19:50 INFO - mozprofile == 0.28 20:19:50 INFO - mozrunner == 6.11 20:19:50 INFO - mozscreenshot == 0.1 20:19:50 INFO - mozsystemmonitor == 0.3 20:19:50 INFO - moztest == 0.7 20:19:50 INFO - mozversion == 1.4 20:19:50 INFO - psutil == 3.1.1 20:19:50 INFO - requests == 1.2.3 20:19:50 INFO - wsgiref == 0.1.2 20:19:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:19: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')]} 20:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19: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')]} 20:19:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:50 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 0x7f97af758f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2569350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f81c0>, '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 0x25f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9550>, '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': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', '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 20:19:50 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 20:19:50 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 20:19:50 INFO - Using env: {'DISPLAY': ':0', 20:19:50 INFO - 'HOME': '/home/cltbld', 20:19:50 INFO - 'LANG': 'en_US.UTF-8', 20:19:50 INFO - 'LANGUAGE': 'en_US:en', 20:19:50 INFO - 'LOGNAME': 'cltbld', 20:19:50 INFO - 'MAIL': '/var/mail/cltbld', 20:19:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:50 INFO - 'MOZ_NO_REMOTE': '1', 20:19:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:50 INFO - 'NO_EM_RESTART': '1', 20:19:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:50 INFO - 'PWD': '/builds/slave/test', 20:19:50 INFO - 'SHELL': '/bin/bash', 20:19:50 INFO - 'SHLVL': '1', 20:19:50 INFO - 'TERM': 'linux', 20:19:50 INFO - 'TMOUT': '86400', 20:19:50 INFO - 'USER': 'cltbld', 20:19:50 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', 20:19:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:50 INFO - '_': '/tools/buildbot/bin/python'} 20:19:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:50 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)) 20:19:50 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)) 20:19:50 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)) 20:19:50 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)) 20:19:50 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)) 20:19:50 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)) 20:19:50 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)) 20:19:50 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)) 20:19:50 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)) 20:19:50 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)) 20:19:50 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)) 20:19:50 INFO - Cleaning up... 20:19:50 INFO - Return code: 0 20:19:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:19: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')]} 20:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19: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')]} 20:19:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97af758f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2569350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f81c0>, '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 0x25f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9550>, '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': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', '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 20:19: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', 'jsonschema'] in /builds/slave/test/build 20:19: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 jsonschema 20:19:50 INFO - Using env: {'DISPLAY': ':0', 20:19:50 INFO - 'HOME': '/home/cltbld', 20:19:50 INFO - 'LANG': 'en_US.UTF-8', 20:19:50 INFO - 'LANGUAGE': 'en_US:en', 20:19:50 INFO - 'LOGNAME': 'cltbld', 20:19:50 INFO - 'MAIL': '/var/mail/cltbld', 20:19:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:50 INFO - 'MOZ_NO_REMOTE': '1', 20:19:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:50 INFO - 'NO_EM_RESTART': '1', 20:19:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:50 INFO - 'PWD': '/builds/slave/test', 20:19:50 INFO - 'SHELL': '/bin/bash', 20:19:50 INFO - 'SHLVL': '1', 20:19:50 INFO - 'TERM': 'linux', 20:19:50 INFO - 'TMOUT': '86400', 20:19:50 INFO - 'USER': 'cltbld', 20:19:50 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', 20:19:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:50 INFO - '_': '/tools/buildbot/bin/python'} 20:19:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:19:50 INFO - Cleaning up... 20:19:50 INFO - Return code: 0 20:19:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:19: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')]} 20:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19: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')]} 20:19:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97af758f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2569350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f81c0>, '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 0x25f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9550>, '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': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', '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 20:19: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', 'flake8'] in /builds/slave/test/build 20:19: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 flake8 20:19:50 INFO - Using env: {'DISPLAY': ':0', 20:19:50 INFO - 'HOME': '/home/cltbld', 20:19:50 INFO - 'LANG': 'en_US.UTF-8', 20:19:50 INFO - 'LANGUAGE': 'en_US:en', 20:19:50 INFO - 'LOGNAME': 'cltbld', 20:19:50 INFO - 'MAIL': '/var/mail/cltbld', 20:19:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:50 INFO - 'MOZ_NO_REMOTE': '1', 20:19:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:50 INFO - 'NO_EM_RESTART': '1', 20:19:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:50 INFO - 'PWD': '/builds/slave/test', 20:19:50 INFO - 'SHELL': '/bin/bash', 20:19:50 INFO - 'SHLVL': '1', 20:19:50 INFO - 'TERM': 'linux', 20:19:50 INFO - 'TMOUT': '86400', 20:19:50 INFO - 'USER': 'cltbld', 20:19:50 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', 20:19:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:50 INFO - '_': '/tools/buildbot/bin/python'} 20:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:51 INFO - Downloading/unpacking flake8 20:19: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 20:19: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 20:19: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 20:19: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 20:19: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 20:19: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 20:19:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:19:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:19: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 20:19: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 20:19: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 20:19: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 20:19: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 20:19: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 20:19:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:19:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:19: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 20:19: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 20:19: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 20:19: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 20:19: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 20:19: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 20:19:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:19: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 20:19: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 20:19: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 20:19: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 20:19: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 20:19: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 20:19:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:19:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:19:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:19:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:19:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:19:53 INFO - no previously-included directories found matching 'docs/_build' 20:19:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:19:53 INFO - Running setup.py install for pep8 20:19:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:19:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:19:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:19:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:19:53 INFO - no previously-included directories found matching 'docs/_build' 20:19:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:19:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:19:53 INFO - Cleaning up... 20:19:54 INFO - Return code: 0 20:19:54 INFO - Running post-action listener: _resource_record_post_action 20:19:54 INFO - Running post-action listener: _start_resource_monitoring 20:19:54 INFO - Starting resource monitoring. 20:19:54 INFO - ##### 20:19:54 INFO - ##### Finished create-virtualenv step (success) 20:19:54 INFO - ##### 20:19:54 INFO - ##### 20:19:54 INFO - ##### Running install step. 20:19:54 INFO - ##### 20:19:54 INFO - Running pre-action listener: _resource_record_pre_action 20:19:54 INFO - Running main action method: install 20:19:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:19:54 INFO - Reading from file tmpfile_stdout 20:19:54 INFO - Detecting whether we're running mozinstall >=1.0... 20:19:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:19:54 INFO - Reading from file tmpfile_stdout 20:19:54 INFO - Output received: 20:19:54 INFO - Usage: mozinstall [options] installer 20:19:54 INFO - Options: 20:19:54 INFO - -h, --help show this help message and exit 20:19:54 INFO - -d DEST, --destination=DEST 20:19:54 INFO - Directory to install application into. [default: 20:19:54 INFO - "/builds/slave/test"] 20:19:54 INFO - --app=APP Application being installed. [default: firefox] 20:19:54 INFO - mkdir: /builds/slave/test/build/application 20:19:54 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'] 20:19:54 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 20:20:11 INFO - Reading from file tmpfile_stdout 20:20:11 INFO - Output received: 20:20:11 INFO - /builds/slave/test/build/application/firefox/firefox 20:20:11 INFO - Running post-action listener: _resource_record_post_action 20:20:11 INFO - ##### 20:20:11 INFO - ##### Finished install step (success) 20:20:11 INFO - ##### 20:20:11 INFO - ##### 20:20:11 INFO - ##### Running run-tests step. 20:20:11 INFO - ##### 20:20:11 INFO - Running pre-action listener: _resource_record_pre_action 20:20:11 INFO - Running main action method: run_tests 20:20:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:20:11 INFO - Python 2.7.3 20:20:11 INFO - Return code: 0 20:20:11 INFO - grabbing minidump binary from tooltool 20:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:11 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 0x25f81c0>, '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 0x25f90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25f9550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:20:11 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 20:20:11 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 20:20:11 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 20:20:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:20:11 INFO - Return code: 0 20:20:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:20:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:20:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:20:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:20:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:20:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:20:12 INFO - Return code: 0 20:20:12 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/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 20:20:12 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/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 20:20:12 INFO - Using env: {'DISPLAY': ':0', 20:20:12 INFO - 'HOME': '/home/cltbld', 20:20:12 INFO - 'LANG': 'en_US.UTF-8', 20:20:12 INFO - 'LANGUAGE': 'en_US:en', 20:20:12 INFO - 'LOGNAME': 'cltbld', 20:20:12 INFO - 'MAIL': '/var/mail/cltbld', 20:20:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:20:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:12 INFO - 'MOZ_NO_REMOTE': '1', 20:20:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:20:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:20:12 INFO - 'NO_EM_RESTART': '1', 20:20:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:12 INFO - 'PWD': '/builds/slave/test', 20:20:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:20:12 INFO - 'SHELL': '/bin/bash', 20:20:12 INFO - 'SHLVL': '1', 20:20:12 INFO - 'TERM': 'linux', 20:20:12 INFO - 'TMOUT': '86400', 20:20:12 INFO - 'USER': 'cltbld', 20:20:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250', 20:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:12 INFO - '_': '/tools/buildbot/bin/python'} 20:20:12 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/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 20:20:12 INFO - mozversion application_buildid: 20160613173002 20:20:12 INFO - mozversion application_changeset: 79bcc05ef105fb5362888694307faa261615c34d 20:20:12 INFO - mozversion application_display_name: Nightly 20:20:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:20:12 INFO - mozversion application_name: Firefox 20:20:12 INFO - mozversion application_remotingname: firefox 20:20:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:20:12 INFO - mozversion application_vendor: Mozilla 20:20:12 INFO - mozversion application_version: 50.0a1 20:20:12 INFO - mozversion platform_buildid: 20160613173002 20:20:12 INFO - mozversion platform_changeset: 79bcc05ef105fb5362888694307faa261615c34d 20:20:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:20:12 INFO - mozversion platform_version: 50.0a1 20:20:12 INFO - using testdate: 1465874412 20:20:12 INFO - actual date: 1465874412 20:20:12 INFO - starting webserver on 'localhost:57300' 20:20:12 INFO - SUITE-START | Running 2 tests 20:20:12 INFO - TEST-START | dromaeo_css 20:20:12 INFO - operating with platform_type : linux_ 20:20:12 INFO - Initialising browser for dromaeo_css test... 20:20:12 INFO - TEST-INFO | started process 10902 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNRNdxn/profile http://localhost:57300/getInfo.html) 20:20:16 INFO - PROCESS | 10902 | __metrics Screen width/height:1600/1200 20:20:16 INFO - PROCESS | 10902 | colorDepth:24 20:20:16 INFO - PROCESS | 10902 | Browser inner width/height: 1024/697 20:20:16 INFO - PROCESS | 10902 | __metrics 20:20:17 ERROR - PROCESS | 10902 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 20:20:18 INFO - TEST-INFO | 10902: exit 0 20:20:18 INFO - Browser initialized. 20:20:18 INFO - Running cycle 1/1 for dromaeo_css test... 20:20:18 INFO - TEST-INFO | started process 11020 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNRNdxn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:20:30 INFO - PROCESS | 11020 | RSS: Main: 184516608 20:20:30 INFO - PROCESS | 11020 | 20:21:19 INFO - PROCESS | 11020 | 1465874479990 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] 20:23:28 INFO - PROCESS | 11020 | Cycle 1(1): loaded http://localhost:57300/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57300/tests/dromaeo/cssquery-ext.html) 20:23:29 INFO - PROCESS | 11020 | RSS: Main: 189001728 20:23:29 INFO - PROCESS | 11020 | 20:26:31 INFO - PROCESS | 11020 | Cycle 1(1): loaded http://localhost:57300/tests/dromaeo/cssquery-ext.html (next: http://localhost:57300/tests/dromaeo/cssquery-jquery.html) 20:26:32 INFO - PROCESS | 11020 | RSS: Main: 187424768 20:26:32 INFO - PROCESS | 11020 | 20:29:34 INFO - PROCESS | 11020 | Cycle 1(1): loaded http://localhost:57300/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57300/tests/dromaeo/cssquery-mootools.html) 20:29:34 INFO - PROCESS | 11020 | RSS: Main: 188776448 20:29:34 INFO - PROCESS | 11020 | 20:32:36 INFO - PROCESS | 11020 | Cycle 1(1): loaded http://localhost:57300/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57300/tests/dromaeo/cssquery-prototype.html) 20:32:37 INFO - PROCESS | 11020 | RSS: Main: 186687488 20:32:37 INFO - PROCESS | 11020 | 20:35:39 INFO - PROCESS | 11020 | Cycle 1(1): loaded http://localhost:57300/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57300/tests/dromaeo/cssquery-yui.html) 20:35:40 INFO - PROCESS | 11020 | RSS: Main: 188628992 20:35:40 INFO - PROCESS | 11020 | 20:38:43 INFO - PROCESS | 11020 | Cycle 1(1): loaded http://localhost:57300/tests/dromaeo/cssquery-yui.html (next: http://localhost:57300/tests/dromaeo/cssquery-dojo.html) 20:38:43 INFO - PROCESS | 11020 | RSS: Main: 189710336 20:38:43 INFO - PROCESS | 11020 | 20:38:43 INFO - PROCESS | 11020 | __start_tp_report 20:38:43 INFO - PROCESS | 11020 | _x_x_mozilla_page_load 20:38:43 INFO - PROCESS | 11020 | _x_x_mozilla_page_load_details 20:38:43 INFO - PROCESS | 11020 | |i|pagename|runs| 20:38:43 INFO - PROCESS | 11020 | |0;dojo.html;3130.5617213590117;3161.557381966524;3187.2509960159364;3202.0553936588703;3202.423563758524;5409.404965453797;5413.891722165555;5491.835244942653;5567.220589117516;5573.191887176367;5436.510714035736;5445.047116754572;5505.642133261335;5553.250311207986;5613.550915926727;4902.632302577304;4914.557689807916;5033.295338652591;5079.4412614612365;5125.871853203681;766.8591336941952;4932.408111026664;4974.527419895122;5015.5486006259425;5041.621878359119;5016.046951079302;5036.924446133311;5046.52058054486;5055.317532133188;5060.797568097271;5052.267421223902;5056.140456122468;5060.671056381323;5077.949220507785;5088.974555127238;4952.133376659071;4960.702357858504;4995.500449954975;5013.097642424399;5037.244413337992;5476.507114359727;5535.944640553583;5538.418466061046;5540.141278101901;5617.01702202113;5792.275965504312;5800.187973683687;5978.581499295051;5994.7901823436405;6001.909971350433;5908.05471124618;5925.466707996258;5945.197398351211;5952.434518720715;6003.489703375219;5529.419410961871;5540.2243685884005;5545.3622833374275;5546.805861794898;5548.55611551075;5999.550033747487;6038.456538911519;6049.8487537811025;6070.453659170696;6112.694365281718;5824.475797178275;5827.621204621686;5842.298924129047;5843.912341314884;5850.707464626752;6001.729922153513;6006.939930600725;6011.639301641915;6015.669138197353;6024.277086749618;5912.9113063304085;5952.375000624872;5974.462298393166;6004.42957918997;6008.519318454513;5954.047352423591;6015.879682406327;6018.518518518508;6018.638881667114;6027.397260273938;4453.242948698729;4559.772011399416;4568.1548913451115;4586.128635559233;4627.30590411441;3967.3652215645357;3990.2418540477215;4034.1931613677384;4049.5545489996075;4052.392141178788;5656.971715141398;5703.800366987219;5720.427957204246;5748.310202775694;5757.971210143923;5813.796517121965;5991.7603295867675;6001.279846418458;6005.249343832021;6009.909851352233;5635.126555383922;5680.77276908919;5710.143478478261;5710.71446427677;5713.914291285634;5122.410922743932;5135.948640513622;5142.280080788692;5150.948490515122;5220.112580861262;6039.245094363205;6112.655464441461;6197.81406557804;6209.472194863397;6247.312795592481;5955.910661339996;5998.370171131968;6006.609570378087;6016.368281330572;6079.2704875413465;6173.017252078937;6230.813075607739;6237.532185086227;6247.031710084944;6262.279837818709;5759.94240057594;5839.386864379179;5853.09277062056;5922;5970.492508136857;6036.124761909411;6056.3035250946705;6056.485198758155;6064.363241859718;6116.113163591165;5837.0368889132815;5839.620424672383;5886.646801191942;5895.20414744004;5898.262717160355;5564.19319198722;5678.545716342765;5732.971335143297;5744.712764361681;5787.36339002701;5672.546196304368;5680.091185410314;5690.658560486384;5699.116636921284;5717.771289148387;5723.8569035774435;5759.280089988752;5763.6541807491685;5783.248177736868;5789.218455508452;5591;5628.60599758013;5676;5697.7151142443545;5729.1119876419225 20:38:43 INFO - PROCESS | 11020 | |1;ext.html;569.4817715878548;605.7667797897806;626.8840264551058;643.9227292724873;646.5668002438366;40502;41945.16109677809;45627.77186114069;45749.54250457494;45841;45806;46427.767861160646;46461.303080453734;46495.30257046147;46619.53380466194;8960.327975401839;9107.908920910771;9111.817763644724;9129.771755706093;9139;8926.598303076376;8949.284057275403;8991.460512369245;9004.279657627407;9066.229370503515;9061.95469022654;9073.863892041592;9141.5886285117;9151.267898568098;9154.450732956011;9005.279577633773;9014.819703605925;9040.547972601376;9081.7275481735;9098.363114581982;8991.595378207996;9101.954490227507;9104.772380690536;9109.27125829932;9126.361154719172;43018.13963720708;43036;43113.35329970053;43159.56840431587;43370.78314608438;2954.6602140753876;3393.0499460151195;3531.2584357285;3556.448750443685;3600.513930619359;30308.106491175768;30972;31225.8438707805;31464.056078317688;32624.510632340534;3698.4267438547067;3996;4037.253108174997;4045.110075783323;4085.836566537335;353571;353952;356685;357143;357293;62557.68721156365;63050;63093.369066309664;63152;63154;37258.62741372552;38614.613853861665;38646.806765965994;39885.601143988766;40356.798216008734;14982.550523484313;15189.164595947108;15189.79747936543;15200;15405.768913466307;12067.396630168456;12186.329751863732;12213.877861221274;12304.507819687291;12316.384180790925;19749.506262343555;20001.899990499955;20146.294879679142;20147.29484468066;20188.293409730588;7369.7052117915755;7453.590052547053;7459.627018649046;7490.775276741707;7543.207963163899;959.2517836087862;1129.108004676313;1139.2082502660737;1169.5321871251567;1183.1717797541755;32066.83966580199;32599.51100733491;32834.50748238778;33098.51425378414;33680;1113.7891285797684;1136.5567428702811;1184.3841202574613;1202.2726250618425;1210.7275862930946;16951.830481695273;17242.913785430992;17280.740788888175;17360.65278694419;17471.475855724348;160361.1981940083;160661.1966940158;161521;161691;556519;56908.715456422455;58251.70874145602;58730.706346467996;58740.70629646824;59094;1376.7246550689902;1385.88220001299;1392.2621010864057;1401.0962928910797;1412.6327154939584;30880.455977201498;32384.83807580947;32441.51337729983;32529.83735081404;32581.18547036343;51288;51592;51688.22467662913;51746.223806643684;51834.481655182964;462863;464907;466362;466682;468284;29644.258893527833;30531.84734076404;32054.519182212753;32134.517982230755;32291.51562726514;49330.260046100055;49861.750691246314;50121.492824484616;50431.747841260556;51179.232311516105;42051.57948420477;42132.78933605312;42415;43306.35040474458;43664;41778;42123.368149478396;42559;42638;42702.78648606737;36430;41175.38236926388;41313.58686413218;41411;42737.35893961531;34116;37389.626103739705;37938.43092353672;38542.614573855026;38790;28656.570151448163;28775;28860.855695721388;28997.710022900344;29105.272368190963 20:38:43 INFO - PROCESS | 11020 | |2;jquery.html;404.9068714195737;408.636313680824;411.06892887609587;419.3918817714313;419.64539963730647;13931.303434828244;18050.09749512524;19077;19577.119029643647;19578.804211957893;18700;18738.531536711555;19034.61930761384;19475.415737527863;19517.21931122757;5634.098544232924;5837.766489340422;5897.174395584621;5912.379200183983;5974.462298393144;5860.912086318709;5864.44287792659;5872.647641141545;5888.057910734284;5896.941030589682;5697.059985102474;5803.303603567578;5807.767689292423;5815.331236907747;5830.708464576775;5487.341519017744;5786.392428794979;5796.44933731297;5807.535397168216;5816.621919575214;5112.130937740593;5236.240745091978;5260.447652996419;5265.394479634852;5281.577473802086;22092.779072209232;22446.214382496535;22850.428739281484;23392.18127365551;23401.180958666366;2429.927102186937;2495.338735235164;2593.9610905836425;3022.486177349856;3120.0795765249304;14238.501652442219;14316.85683143176;14558.563243102724;14852;14970.550883473514;1907.7138429235588;1915.9712604310946;1954.9706754398696;1966.1349006437122;2013.748281464817;57561;73091.63454182749;76784;79606.99999999942;81950;9295.442273463614;9645.42127472354;11037.503312350964;11038.448077596087;11280.605178818701;15192.240387980557;15255.160966146968;15263;15268.770968435483;15318.770218446733;7996.760097197093;8208.753737387888;8277.668893244203;8291.295239904555;8376.916230837614;7893.329067029252;7928.484648497829;7932.660265113111;7983.600819958979;8042.316403105685;6755.630939612323;6768.9661551691925;6778.864422711518;6834.829129271808;6890.655467226718;2013.5872146209992;2015.667414876529;2022.3528470889173;2046.6009128219855;2100.926467573658;1001.484235618657;1029.7322696099068;1072.0726571515584;1097.4403054442291;1119.8824123467082;19424.514387140152;19482.610347792965;19517;19686.803131968783;19721.785508169396;1018.5365658625308;1027.275770581738;1045.8483519889573;1052.894710528941;1074.2856000759564;10479.895201047892;11352.091832653368;11389.94305028486;11447.484863181176;11523.654290371134;463228;467610;471032;471900;495014;75755;84317;84513;84559.57720211483;90769.54615226881;935.9064093590587;948.2793077261331;962.6149540183983;969.069693094623;995.5465021069175;16861.409850655167;16918.154092295583;17320.65358692794;17466.73799893028;18109.818901810813;39714.80142599384;40592.39111413272;40609;40877.79561102176;43927.341089884314;48278.75860620674;50449.49550504448;59906;61547.6922615384;62666;8550.78623034429;8603.784905377415;8637.395382323177;8818;9071.727848164566;12772.169808962388;13320.067595268238;13533.932330338286;13935.930320348334;14199.361028753938;11938.343391113573;12133;12228.694282643006;12355.444005019976;12419;12035.338056406981;12076.396180190779;12227.266364018187;12327.50689972391;12530.122891397516;12321.815172772236;12359.62921112368;12608.49566017349;12665.176763510342;12671.239725616493;7817.726379576688;7917.208279172267;8012.557739606927;8114.797130071795;8887.777805554913;10775.299605525615;10997.12023038139;11761.588344407905;12140.453679584616;12235.93882030584 20:38:43 INFO - PROCESS | 11020 | |3;mootools.html;1471.9779203311953;1496.16214919645;1620.9594760130994;1714.4856543037095;1733.904635245061;7972.242636949481;8696.652133914651;8725.738227853166;9370.718878433641;9377.39046961947;8725.127487251271;9043.50260735661;9071.183593476586;9133.908660913388;9149.588268527916;2363.3264519611957;2416.9274921752376;2417.262734865874;2421.079989603948;2424.333308340203;2258.4579700871836;2305.481266714984;2313.9652905206435;2321.791038806507;2323.0707716913203;2412.2401443545227;2426.1872272788637;2430.501747141832;2474.0845887021737;2474.653548503211;2269.2624896908487;2274.1358283852032;2297.356740112771;2299.482616411311;2321.5937210988177;2356.5875971705054;2357.3399448154546;2364.3025307534317;2364.9830572853666;2367.112332875172;9105.36262461628;9273.165415112673;9278.582463789078;9311.813763724755;9317.068293170696;5375.973120134413;5523.1163013917985;5527.115661494142;5531.668099914018;5543.057680194336;3327.168207948013;3339.899803005914;3388.288459423524;3405.1146701857697;3481.634428385034;1144.9656510304703;1149.1668540308294;1158.1950544371666;1159.6810877008807;1172.3552046374546;12690.49238030487;12753.872461275454;12756.936215318958;12793.55222567215;12796.360181990864;4718.799391570181;4767.833125840648;4777.211760059621;4803.3995750531185;4925.1873440881855;10839.512221950032;10876.912308769219;10880.292780969212;10885.564577416815;10941.343519388703;5357.973210133924;5388.91916621251;5399.649022813504;5502.972485137549;5505.064139096363;4367.410399596014;4698.765061746899;4827.517248275144;4847.079054979543;4980.950190498121;4081.754586870508;4129.463169787909;4134.276501612206;4135.875923722293;4215.894602634959;1326.0448945282058;1336.6992426703914;1345.5290648273221;1367.268511346425;1369.1511263016794;1010.3230835340339;1022.2282176956351;1035.414990530348;1036.7770929250096;1052.1845569683403;6341.429271365507;6359.21941856281;6365.936340636535;6535.215774107138;6568.146141001735;956.1824639932896;977.6529332087007;994.1003391930315;999.8650182225452;1017.2065788684838;4302.373138348275;4398.164348773723;4463.129689710475;4472.195004899149;4513.210188217049;11088.279261848116;11420.885791141982;11426.314421134759;11458.598949036743;11519.48162332697;11437.942810285895;11438.59964901241;11464.770704585862;11482.425878706032;11493.77012459746;8121.309688676529;8344.582770861432;8482.363822713321;8632.525211113323;8641.092685268208;6023.337432882292;6066.332703402711;6328.525360597881;6353.237611486651;6477.546571739933;10071.597136114473;10277.331973421704;10432.68701938943;10560.947195263974;10649.680509584725;10671.57313707443;10678.89321106779;10724.463776811284;10789.244752867224;10792.514336854703;7487.176410594721;7762.262585054411;7915.683372665029;8040.155783642867;8125.593720314079;8921.598528066383;9019.594118264562;9056.54717264121;9069.682561110329;9095.909040909506;7709.151993280847;7869.331106855752;7967.681292748225;8099.716509922125;8221.260086592236;7927;7978.640961156878;8018.639161237642;8110.026796784424;8121.878171827309;7013.649317534205;7367.336939675455;7436.59098749574;7510.586917719578;7514.9624251878395;5375.838724838261;5417;5473.397926228032;5495.587830912617;5580.748866301107;5366.946330536644;5378.542823860016;5572.526335261548;5705.543556515552;5735.397783232867 20:38:43 INFO - PROCESS | 11020 | |4;prototype.html;324.1862924060609;332.31211392417697;334.49658264312205;334.9179451034497;340.8125530957972;5493.340799104113;5587.636803607773;5656.2929633795775;5678.176664383667;5711.371749107595;5578.3584887737925;5584.441555844413;5584.9162262566;5600.487868275563;5621.915671264935;4317.870463886088;4320.09278051608;4347.69566130371;4363;4367.45406824147;4106.404571337154;4317;4340.696151269412;4357.891052723691;4373.562643735617;4226.957730422687;4275.166342563186;4313.978430107845;4318.935215971763;4326.372675961999;4270.316749320125;4307.07397909451;4320.6327462165755;4327;4346;3625.29306785177;3787.62123787619;3798.373268410709;3804.334241507725;3805.904852378685;5446.645968012067;5461.726913654302;5469.835904922819;5488.4785945335125;5517.172424136372;4877.6829506081995;4906;4913.410390753097;4954.900901981976;4990.9768497457935;5479.301416560879;5827.679477628729;5855.326637436707;5960.880782384328;5985.413865325692;4101.405296232029;4115.691323150776;4119.814608342632;4147.6474499667265;4153.958460415387;6069.453749162552;6119.143319935212;6158.876822463526;6164.938350616481;6219.1604133442315;4104.056067104582;4190.979045104755;4226.957730422657;4235.343521754133;4240.957590424056;4219.409282700424;4228.9154216915485;4262.254105531581;4266.786660666954;4298.161858437575;4865.440474345425;4918.9508104919205;4942.604591632661;4948.851534453972;4987.526185012418;5905.970470147708;5960.4635582797755;5966.522678185735;5984.31180414258;6015.909761353583;1487.300968544782;1493.3951749541452;1506.4802643088117;1508.3664860758288;1508.8189417269998;924.5515924776478;952.6332362040525;954.9570269337896;962.1196605106389;962.3311798300114;5115.769790359368;5148.057864450095;5202.92195617066;5223.582113430916;5244.396894357122;5252.632315737938;5363.758630861621;5489.917651235235;5502.899420115993;5531.695756733418;5004.224345226496;5131.254778693381;5138.922916156261;5227.196617167071;5236.214567814782;2831.377097038648;2858.399296394026;2918.6789453160136;2923.845081192917;2941.426421847762;5537.483697851893;5543.959171851806;5577.776888924479;5609.663420194802;5635.956583444976;5173;5420.647657902224;5448.863778405493;5456.645318054393;5504.53211477029;5552.666839989613;5560.388357280696;5565.888682226333;5648.293963254593;5666.688332141689;5096.770645321044;5340.412554618911;5368.651037682538;5397.9460205397445;5446.863828404163;5304.23088652151;5316.734163291897;5329.08153064904;5338.786448542015;5355.410904800391;5564;5573.940951219255;5628.155776633538;5686.886262274814;6124.173236613;4188.602082802129;4189.91620167601;4210.5578764316015;4214.641755450821;4217.523866646649;5924.940750592439;5940.990031694536;5997.520198384206;6026.819195424145;6055.848603784941;5651.57613179005;5864.208331875142;5866.882662346815;5906.1060080559355;5937.614055086406;5722.885542289214;5757.481826635623;5773.910957637644;5797.797077102281;5832.3292821326095;5746.626469279484;5751.281089863767;5831.912521312099;5843.561732869966;5847.883042339215;5735.13972904051;5836.278297902044;5903.527717782481;5931.555133365101;6049.213602231682;5785.334686510937;5802.767889284551;5807.809399073264;5812.505936995233;5915.319738230159 20:38:43 INFO - PROCESS | 11020 | |5;yui.html;776.7203806629614;796.4345314826473;799.8962728025292;802.2338666573423;827.5393929714054;15145.848541514582;16013;16139.435119770811;16204.513864584067;16221.594460138502;13696.65758356039;13860.93069534651;13873.306334683251;13882.93058534706;13890.305484725774;676.3067855448156;789.1477204618998;803.6945960535003;813.5484805932705;817.4849844597895;793.2147174297432;799.1289494451047;801.5992003998001;803.8070862992898;803.8311954489535;844.6368061733452;845.7970087179064;846.1580727176437;853.7353420439653;854.7948492361819;841.9536925469097;842.8525008123585;843.7679638099572;848.4061157189992;852.6291063387384;615.2248167309178;617.3764497857196;620.711369213318;623.4451338308909;624.0265186309372;14772.409103635842;14885.479008234768;14902.105873647615;14917.179555124463;14924.925375373054;14971.70056598862;15002.774958375632;15072.623184420367;15273.778097752152;15315.387384504607;11922.105842061794;12005.45975431099;12051.57819476314;12234.143609947307;12290.139690221687;3917.6865850732156;3917.7061720371084;4024.75851448914;4066.5120185577625;4073.5111786585503;75221;76439.61780191063;77171.61414192893;77968;78162.60918695427;11718.765624687629;11763.122476446802;11788.528458861721;11794.233374830608;12121.333326666942;22902.42743931415;22923.770762292497;22930.770692293197;22946.42633934165;23059.769402306098;8488.490690558587;8521.36089793268;8733.170348816851;8748.212660860552;8916.286697064219;4603.079384123189;4660.370849935283;4720.386349774576;4764.880877978078;4868.488808675038;3460.2733425980323;3581.194231297989;3584.0860580551794;3588.3899737044244;3606.386914224588;593.7862369546959;606.9453749162508;607.8298076538576;617.8115674719254;622.2346513788066;625.9342769009279;739.3087463221905;743.5129989856653;746.2872956326695;751.7932568543695;9509.90490095104;9805.656802012038;9832.164266037324;9952.751181220527;10340;717.9030830837875;737.4535985648417;745.1765798792364;756.4137793210306;760.1144666463508;4761.642876784185;4812.230043193143;4834.323194752737;4884.290716475035;4925.11347957364;119902.400487997;120826;122296;125125.37437312755;125405;61418.38581614216;96656.51671741596;96975.51512242394;97272.51363743136;97784.51107744416;55145.172822407694;77887.22112778913;79494.205057951;83904.58047709844;91209;9896.257780666623;10006.949965250127;10131.392116473035;10149.441780702133;10223.795524089328;51735.48264517307;52210;52537.474625254785;53625;54737;73732;76214.71355859333;77103.61448192723;77866.38135758524;81873;11249;12364;12409;12447.502099915902;12984.15602985803;12432.502699891904;12546.435410406371;13042.152260103063;14289.341744295118;14694.706105878036;13582.86417135816;13754.31228438594;13991.510297139552;14154.929225353808;14738.705225895637;14246.145231286157;14282.785758213842;14309.427622894967;15093.622659433162;15195.240237988277;14152.52330842119;14450.277486125862;14793.038452500554;14943.701125977203;15118.244087795347;11474.632527264173;11623;11946.462409191781;12251.877481225074;12450.875491245333;11869.643910682693;12005.640568242321;12022.699432514257;12099.153059285765;12422.751544968869 20:38:43 INFO - PROCESS | 11020 | __end_tp_report 20:38:43 INFO - PROCESS | 11020 | __start_cc_report 20:38:43 INFO - PROCESS | 11020 | _x_x_mozilla_cycle_collect,358 20:38:43 INFO - PROCESS | 11020 | __end_cc_report 20:38:43 INFO - PROCESS | 11020 | __startTimestamp1465875523376__endTimestamp 20:38:43 INFO - PROCESS | 11020 | 20:38:43 INFO - PROCESS | 11020 | ------- Summary: start ------- 20:38:43 INFO - PROCESS | 11020 | Number of tests: 6 20:38:43 INFO - PROCESS | 11020 | 20:38:43 INFO - PROCESS | 11020 | [#0] dojo.html Cycles:165 Average:5496.93 Median:5720.43 stddev:742.59 (13.0%) stddev-sans-first:721.29 20:38:43 INFO - PROCESS | 11020 | Values: 3130.6 3161.6 3187.3 3202.1 3202.4 5409.4 5413.9 5491.8 5567.2 5573.2 5436.5 5445.0 5505.6 5553.3 5613.6 4902.6 4914.6 5033.3 5079.4 5125.9 766.9 4932.4 4974.5 5015.5 5041.6 5016.0 5036.9 5046.5 5055.3 5060.8 5052.3 5056.1 5060.7 5077.9 5089.0 4952.1 4960.7 4995.5 5013.1 5037.2 5476.5 5535.9 5538.4 5540.1 5617.0 5792.3 5800.2 5978.6 5994.8 6001.9 5908.1 5925.5 5945.2 5952.4 6003.5 5529.4 5540.2 5545.4 5546.8 5548.6 5999.6 6038.5 6049.8 6070.5 6112.7 5824.5 5827.6 5842.3 5843.9 5850.7 6001.7 6006.9 6011.6 6015.7 6024.3 5912.9 5952.4 5974.5 6004.4 6008.5 5954.0 6015.9 6018.5 6018.6 6027.4 4453.2 4559.8 4568.2 4586.1 4627.3 3967.4 3990.2 4034.2 4049.6 4052.4 5657.0 5703.8 5720.4 5748.3 5758.0 5813.8 5991.8 6001.3 6005.2 6009.9 5635.1 5680.8 5710.1 5710.7 5713.9 5122.4 5135.9 5142.3 5150.9 5220.1 6039.2 6112.7 6197.8 6209.5 6247.3 5955.9 5998.4 6006.6 6016.4 6079.3 6173.0 6230.8 6237.5 6247.0 6262.3 5759.9 5839.4 5853.1 5922.0 5970.5 6036.1 6056.3 6056.5 6064.4 6116.1 5837.0 5839.6 5886.6 5895.2 5898.3 5564.2 5678.5 5733.0 5744.7 5787.4 5672.5 5680.1 5690.7 5699.1 5717.8 5723.9 5759.3 5763.7 5783.2 5789.2 5591.0 5628.6 5676.0 5697.7 5729.1 20:38:43 INFO - PROCESS | 11020 | 20:38:43 INFO - PROCESS | 11020 | [#1] ext.html Cycles:180 Average:52945.23 Median:41244.48 stddev:100070.26 (242.6%) stddev-sans-first:100273.72 20:38:43 INFO - PROCESS | 11020 | Values: 569.5 605.8 626.9 643.9 646.6 40502.0 41945.2 45627.8 45749.5 45841.0 45806.0 46427.8 46461.3 46495.3 46619.5 8960.3 9107.9 9111.8 9129.8 9139.0 8926.6 8949.3 8991.5 9004.3 9066.2 9062.0 9073.9 9141.6 9151.3 9154.5 9005.3 9014.8 9040.5 9081.7 9098.4 8991.6 9102.0 9104.8 9109.3 9126.4 43018.1 43036.0 43113.4 43159.6 43370.8 2954.7 3393.0 3531.3 3556.4 3600.5 30308.1 30972.0 31225.8 31464.1 32624.5 3698.4 3996.0 4037.3 4045.1 4085.8 353571.0 353952.0 356685.0 357143.0 357293.0 62557.7 63050.0 63093.4 63152.0 63154.0 37258.6 38614.6 38646.8 39885.6 40356.8 14982.6 15189.2 15189.8 15200.0 15405.8 12067.4 12186.3 12213.9 12304.5 12316.4 19749.5 20001.9 20146.3 20147.3 20188.3 7369.7 7453.6 7459.6 7490.8 7543.2 959.3 1129.1 1139.2 1169.5 1183.2 32066.8 32599.5 32834.5 33098.5 33680.0 1113.8 1136.6 1184.4 1202.3 1210.7 16951.8 17242.9 17280.7 17360.7 17471.5 160361.2 160661.2 161521.0 161691.0 556519.0 56908.7 58251.7 58730.7 58740.7 59094.0 1376.7 1385.9 1392.3 1401.1 1412.6 30880.5 32384.8 32441.5 32529.8 32581.2 51288.0 51592.0 51688.2 51746.2 51834.5 462863.0 464907.0 466362.0 466682.0 468284.0 29644.3 30531.8 32054.5 32134.5 32291.5 49330.3 49861.8 50121.5 50431.7 51179.2 42051.6 42132.8 42415.0 43306.4 43664.0 41778.0 42123.4 42559.0 42638.0 42702.8 36430.0 41175.4 41313.6 41411.0 42737.4 34116.0 37389.6 37938.4 38542.6 38790.0 28656.6 28775.0 28860.9 28997.7 29105.3 20:38:43 INFO - PROCESS | 11020 | 20:38:43 INFO - PROCESS | 11020 | [#2] jquery.html Cycles:180 Average:28287.76 Median:2808.22 stddev:77881.70 (2773.3%) stddev-sans-first:78072.04 20:38:43 INFO - PROCESS | 11020 | Values: 404.9 408.6 411.1 419.4 419.6 13931.3 18050.1 19077.0 19577.1 19578.8 18700.0 18738.5 19034.6 19475.4 19517.2 5634.1 5837.8 5897.2 5912.4 5974.5 5860.9 5864.4 5872.6 5888.1 5896.9 5697.1 5803.3 5807.8 5815.3 5830.7 5487.3 5786.4 5796.4 5807.5 5816.6 5112.1 5236.2 5260.4 5265.4 5281.6 22092.8 22446.2 22850.4 23392.2 23401.2 2429.9 2495.3 2594.0 3022.5 3120.1 14238.5 14316.9 14558.6 14852.0 14970.6 1907.7 1916.0 1955.0 1966.1 2013.7 57561.0 73091.6 76784.0 79607.0 81950.0 9295.4 9645.4 11037.5 11038.4 11280.6 15192.2 15255.2 15263.0 15268.8 15318.8 7996.8 8208.8 8277.7 8291.3 8376.9 7893.3 7928.5 7932.7 7983.6 8042.3 6755.6 6769.0 6778.9 6834.8 6890.7 2013.6 2015.7 2022.4 2046.6 2100.9 1001.5 1029.7 1072.1 1097.4 1119.9 19424.5 19482.6 19517.0 19686.8 19721.8 1018.5 1027.3 1045.8 1052.9 1074.3 10479.9 11352.1 11389.9 11447.5 11523.7 463228.0 467610.0 471032.0 471900.0 495014.0 75755.0 84317.0 84513.0 84559.6 90769.5 935.9 948.3 962.6 969.1 995.5 16861.4 16918.2 17320.7 17466.7 18109.8 39714.8 40592.4 40609.0 40877.8 43927.3 48278.8 50449.5 59906.0 61547.7 62666.0 8550.8 8603.8 8637.4 8818.0 9071.7 12772.2 13320.1 13533.9 13935.9 14199.4 11938.3 12133.0 12228.7 12355.4 12419.0 12035.3 12076.4 12227.3 12327.5 12530.1 12321.8 12359.6 12608.5 12665.2 12671.2 7817.7 7917.2 8012.6 8114.8 8887.8 10775.3 10997.1 11761.6 12140.5 12235.9 20:38:43 INFO - PROCESS | 11020 | 20:38:43 INFO - PROCESS | 11020 | [#3] mootools.html Cycles:180 Average:6042.40 Median:4492.70 stddev:3443.31 (76.6%) stddev-sans-first:3435.84 20:38:43 INFO - PROCESS | 11020 | Values: 1472.0 1496.2 1621.0 1714.5 1733.9 7972.2 8696.7 8725.7 9370.7 9377.4 8725.1 9043.5 9071.2 9133.9 9149.6 2363.3 2416.9 2417.3 2421.1 2424.3 2258.5 2305.5 2314.0 2321.8 2323.1 2412.2 2426.2 2430.5 2474.1 2474.7 2269.3 2274.1 2297.4 2299.5 2321.6 2356.6 2357.3 2364.3 2365.0 2367.1 9105.4 9273.2 9278.6 9311.8 9317.1 5376.0 5523.1 5527.1 5531.7 5543.1 3327.2 3339.9 3388.3 3405.1 3481.6 1145.0 1149.2 1158.2 1159.7 1172.4 12690.5 12753.9 12756.9 12793.6 12796.4 4718.8 4767.8 4777.2 4803.4 4925.2 10839.5 10876.9 10880.3 10885.6 10941.3 5358.0 5388.9 5399.6 5503.0 5505.1 4367.4 4698.8 4827.5 4847.1 4981.0 4081.8 4129.5 4134.3 4135.9 4215.9 1326.0 1336.7 1345.5 1367.3 1369.2 1010.3 1022.2 1035.4 1036.8 1052.2 6341.4 6359.2 6365.9 6535.2 6568.1 956.2 977.7 994.1 999.9 1017.2 4302.4 4398.2 4463.1 4472.2 4513.2 11088.3 11420.9 11426.3 11458.6 11519.5 11437.9 11438.6 11464.8 11482.4 11493.8 8121.3 8344.6 8482.4 8632.5 8641.1 6023.3 6066.3 6328.5 6353.2 6477.5 10071.6 10277.3 10432.7 10560.9 10649.7 10671.6 10678.9 10724.5 10789.2 10792.5 7487.2 7762.3 7915.7 8040.2 8125.6 8921.6 9019.6 9056.5 9069.7 9095.9 7709.2 7869.3 7967.7 8099.7 8221.3 7927.0 7978.6 8018.6 8110.0 8121.9 7013.6 7367.3 7436.6 7510.6 7515.0 5375.8 5417.0 5473.4 5495.6 5580.7 5366.9 5378.5 5572.5 5705.5 5735.4 20:38:43 INFO - PROCESS | 11020 | 20:38:43 INFO - PROCESS | 11020 | [#4] prototype.html Cycles:180 Average:4772.81 Median:5383.30 stddev:1391.73 (25.9%) stddev-sans-first:1354.98 20:38:43 INFO - PROCESS | 11020 | Values: 324.2 332.3 334.5 334.9 340.8 5493.3 5587.6 5656.3 5678.2 5711.4 5578.4 5584.4 5584.9 5600.5 5621.9 4317.9 4320.1 4347.7 4363.0 4367.5 4106.4 4317.0 4340.7 4357.9 4373.6 4227.0 4275.2 4314.0 4318.9 4326.4 4270.3 4307.1 4320.6 4327.0 4346.0 3625.3 3787.6 3798.4 3804.3 3805.9 5446.6 5461.7 5469.8 5488.5 5517.2 4877.7 4906.0 4913.4 4954.9 4991.0 5479.3 5827.7 5855.3 5960.9 5985.4 4101.4 4115.7 4119.8 4147.6 4154.0 6069.5 6119.1 6158.9 6164.9 6219.2 4104.1 4191.0 4227.0 4235.3 4241.0 4219.4 4228.9 4262.3 4266.8 4298.2 4865.4 4919.0 4942.6 4948.9 4987.5 5906.0 5960.5 5966.5 5984.3 6015.9 1487.3 1493.4 1506.5 1508.4 1508.8 924.6 952.6 955.0 962.1 962.3 5115.8 5148.1 5202.9 5223.6 5244.4 5252.6 5363.8 5489.9 5502.9 5531.7 5004.2 5131.3 5138.9 5227.2 5236.2 2831.4 2858.4 2918.7 2923.8 2941.4 5537.5 5544.0 5577.8 5609.7 5636.0 5173.0 5420.6 5448.9 5456.6 5504.5 5552.7 5560.4 5565.9 5648.3 5666.7 5096.8 5340.4 5368.7 5397.9 5446.9 5304.2 5316.7 5329.1 5338.8 5355.4 5564.0 5573.9 5628.2 5686.9 6124.2 4188.6 4189.9 4210.6 4214.6 4217.5 5924.9 5941.0 5997.5 6026.8 6055.8 5651.6 5864.2 5866.9 5906.1 5937.6 5722.9 5757.5 5773.9 5797.8 5832.3 5746.6 5751.3 5831.9 5843.6 5847.9 5735.1 5836.3 5903.5 5931.6 6049.2 5785.3 5802.8 5807.8 5812.5 5915.3 20:38:43 INFO - PROCESS | 11020 | 20:38:43 INFO - PROCESS | 11020 | [#5] yui.html Cycles:180 Average:20830.64 Median:4631.73 stddev:29872.78 (645.0%) stddev-sans-first:29918.63 20:38:43 INFO - PROCESS | 11020 | Values: 776.7 796.4 799.9 802.2 827.5 15145.8 16013.0 16139.4 16204.5 16221.6 13696.7 13860.9 13873.3 13882.9 13890.3 676.3 789.1 803.7 813.5 817.5 793.2 799.1 801.6 803.8 803.8 844.6 845.8 846.2 853.7 854.8 842.0 842.9 843.8 848.4 852.6 615.2 617.4 620.7 623.4 624.0 14772.4 14885.5 14902.1 14917.2 14924.9 14971.7 15002.8 15072.6 15273.8 15315.4 11922.1 12005.5 12051.6 12234.1 12290.1 3917.7 3917.7 4024.8 4066.5 4073.5 75221.0 76439.6 77171.6 77968.0 78162.6 11718.8 11763.1 11788.5 11794.2 12121.3 22902.4 22923.8 22930.8 22946.4 23059.8 8488.5 8521.4 8733.2 8748.2 8916.3 4603.1 4660.4 4720.4 4764.9 4868.5 3460.3 3581.2 3584.1 3588.4 3606.4 593.8 606.9 607.8 617.8 622.2 625.9 739.3 743.5 746.3 751.8 9509.9 9805.7 9832.2 9952.8 10340.0 717.9 737.5 745.2 756.4 760.1 4761.6 4812.2 4834.3 4884.3 4925.1 119902.4 120826.0 122296.0 125125.4 125405.0 61418.4 96656.5 96975.5 97272.5 97784.5 55145.2 77887.2 79494.2 83904.6 91209.0 9896.3 10006.9 10131.4 10149.4 10223.8 51735.5 52210.0 52537.5 53625.0 54737.0 73732.0 76214.7 77103.6 77866.4 81873.0 11249.0 12364.0 12409.0 12447.5 12984.2 12432.5 12546.4 13042.2 14289.3 14694.7 13582.9 13754.3 13991.5 14154.9 14738.7 14246.1 14282.8 14309.4 15093.6 15195.2 14152.5 14450.3 14793.0 14943.7 15118.2 11474.6 11623.0 11946.5 12251.9 12450.9 11869.6 12005.6 12022.7 12099.2 12422.8 20:38:43 INFO - PROCESS | 11020 | -------- Summary: end -------- 20:38:43 INFO - PROCESS | 11020 | 20:38:44 INFO - TEST-INFO | 11020: exit 0 20:38:44 INFO - TEST-OK | dromaeo_css | took 1111632ms 20:38:44 INFO - TEST-START | kraken 20:38:44 INFO - operating with platform_type : linux_ 20:38:44 INFO - Initialising browser for kraken test... 20:38:44 INFO - TEST-INFO | started process 11253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMeGG7f/profile http://localhost:57300/getInfo.html) 20:38:48 INFO - PROCESS | 11253 | __metrics Screen width/height:1600/1200 20:38:48 INFO - PROCESS | 11253 | colorDepth:24 20:38:48 INFO - PROCESS | 11253 | Browser inner width/height: 1024/697 20:38:48 INFO - PROCESS | 11253 | __metrics 20:38:49 ERROR - PROCESS | 11253 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 20:38:50 INFO - TEST-INFO | 11253: exit 0 20:38:50 INFO - Browser initialized. 20:38:50 INFO - Running cycle 1/1 for kraken test... 20:38:50 INFO - TEST-INFO | started process 11373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMeGG7f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:39:02 INFO - PROCESS | 11373 | RSS: Main: 184827904 20:39:02 INFO - PROCESS | 11373 | 20:39:04 INFO - PROCESS | 11373 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57300/tests/kraken/driver.html?testName=audio-beat-detection) 20:39:05 INFO - PROCESS | 11373 | RSS: Main: 190337024 20:39:05 INFO - PROCESS | 11373 | 20:39:08 INFO - PROCESS | 11373 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57300/tests/kraken/driver.html?testName=audio-dft) 20:39:08 INFO - PROCESS | 11373 | RSS: Main: 189472768 20:39:08 INFO - PROCESS | 11373 | 20:39:11 INFO - PROCESS | 11373 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57300/tests/kraken/driver.html?testName=audio-fft) 20:39:12 INFO - PROCESS | 11373 | RSS: Main: 185298944 20:39:12 INFO - PROCESS | 11373 | 20:39:14 INFO - PROCESS | 11373 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57300/tests/kraken/driver.html?testName=audio-oscillator) 20:39:15 INFO - PROCESS | 11373 | RSS: Main: 185962496 20:39:15 INFO - PROCESS | 11373 | 20:39:17 INFO - PROCESS | 11373 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57300/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:39:18 INFO - PROCESS | 11373 | RSS: Main: 185995264 20:39:18 INFO - PROCESS | 11373 | 20:39:21 INFO - PROCESS | 11373 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57300/tests/kraken/driver.html?testName=imaging-darkroom) 20:39:21 INFO - PROCESS | 11373 | RSS: Main: 186769408 20:39:21 INFO - PROCESS | 11373 | 20:39:25 INFO - PROCESS | 11373 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57300/tests/kraken/driver.html?testName=imaging-desaturate) 20:39:25 INFO - PROCESS | 11373 | RSS: Main: 183099392 20:39:25 INFO - PROCESS | 11373 | 20:39:28 INFO - PROCESS | 11373 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57300/tests/kraken/driver.html?testName=json-parse-financial) 20:39:29 INFO - PROCESS | 11373 | RSS: Main: 185462784 20:39:29 INFO - PROCESS | 11373 | 20:39:30 INFO - PROCESS | 11373 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57300/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:39:31 INFO - PROCESS | 11373 | RSS: Main: 185835520 20:39:31 INFO - PROCESS | 11373 | 20:39:33 INFO - PROCESS | 11373 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57300/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:39:34 INFO - PROCESS | 11373 | RSS: Main: 186019840 20:39:34 INFO - PROCESS | 11373 | 20:39:36 INFO - PROCESS | 11373 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57300/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:39:36 INFO - PROCESS | 11373 | RSS: Main: 186351616 20:39:36 INFO - PROCESS | 11373 | 20:39:39 INFO - PROCESS | 11373 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:39:39 INFO - PROCESS | 11373 | RSS: Main: 186654720 20:39:39 INFO - PROCESS | 11373 | 20:39:42 INFO - PROCESS | 11373 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:39:43 INFO - PROCESS | 11373 | RSS: Main: 186724352 20:39:43 INFO - PROCESS | 11373 | 20:39:44 INFO - PROCESS | 11373 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57300/tests/kraken/driver.html?testName=ai-astar) 20:39:45 INFO - PROCESS | 11373 | RSS: Main: 188153856 20:39:45 INFO - PROCESS | 11373 | 20:39:45 INFO - PROCESS | 11373 | __start_tp_report 20:39:45 INFO - PROCESS | 11373 | _x_x_mozilla_page_load 20:39:45 INFO - PROCESS | 11373 | _x_x_mozilla_page_load_details 20:39:45 INFO - PROCESS | 11373 | |i|pagename|runs| 20:39:45 INFO - PROCESS | 11373 | |0;ai-astar;111;110;110;110;110;111;111;110;110;109 20:39:45 INFO - PROCESS | 11373 | |1;audio-beat-detection;154;125;153;177;126;151;155;128;178;133 20:39:45 INFO - PROCESS | 11373 | |2;audio-dft;161;164;162;165;178;163;165;162;164;163 20:39:45 INFO - PROCESS | 11373 | |3;audio-fft;74;75;74;160;76;75;75;74;166;76 20:39:45 INFO - PROCESS | 11373 | |4;audio-oscillator;86;84;146;86;85;86;137;83;85;143 20:39:45 INFO - PROCESS | 11373 | |5;imaging-gaussian-blur;119;118;118;118;119;118;117;117;130;120 20:39:45 INFO - PROCESS | 11373 | |6;imaging-darkroom;149;149;146;148;146;148;147;146;147;147 20:39:45 INFO - PROCESS | 11373 | |7;imaging-desaturate;95;96;96;98;95;96;96;96;97;96 20:39:45 INFO - PROCESS | 11373 | |8;json-parse-financial;56;55;54;54;54;57;56;55;55;54 20:39:45 INFO - PROCESS | 11373 | |9;json-stringify-tinderbox;61;61;61;59;61;60;60;60;60;60 20:39:45 INFO - PROCESS | 11373 | |10;stanford-crypto-aes;81;79;79;84;87;80;80;82;108;82 20:39:45 INFO - PROCESS | 11373 | |11;stanford-crypto-ccm;124;125;129;124;135;124;128;137;126;122 20:39:45 INFO - PROCESS | 11373 | |12;stanford-crypto-pbkdf2;164;164;159;158;164;157;161;160;157;158 20:39:45 INFO - PROCESS | 11373 | |13;stanford-crypto-sha256-iterative;64;64;63;64;66;62;63;63;62;64 20:39:45 INFO - PROCESS | 11373 | __end_tp_report 20:39:45 INFO - PROCESS | 11373 | __start_cc_report 20:39:45 INFO - PROCESS | 11373 | _x_x_mozilla_cycle_collect,895 20:39:45 INFO - PROCESS | 11373 | __end_cc_report 20:39:45 INFO - PROCESS | 11373 | __startTimestamp1465875585210__endTimestamp 20:39:45 INFO - PROCESS | 11373 | 20:39:45 INFO - PROCESS | 11373 | ------- Summary: start ------- 20:39:45 INFO - PROCESS | 11373 | Number of tests: 14 20:39:45 INFO - PROCESS | 11373 | 20:39:45 INFO - PROCESS | 11373 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 20:39:45 INFO - PROCESS | 11373 | Values: 111.0 110.0 110.0 110.0 110.0 111.0 111.0 110.0 110.0 109.0 20:39:45 INFO - PROCESS | 11373 | 20:39:45 INFO - PROCESS | 11373 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:153.50 stddev:19.71 (12.8%) stddev-sans-first:20.79 20:39:45 INFO - PROCESS | 11373 | Values: 154.0 125.0 153.0 177.0 126.0 151.0 155.0 128.0 178.0 133.0 20:39:45 INFO - PROCESS | 11373 | 20:39:45 INFO - PROCESS | 11373 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:4.85 (3.0%) stddev-sans-first:4.96 20:39:45 INFO - PROCESS | 11373 | Values: 161.0 164.0 162.0 165.0 178.0 163.0 165.0 162.0 164.0 163.0 20:39:45 INFO - PROCESS | 11373 | 20:39:45 INFO - PROCESS | 11373 | [#3] audio-fft Cycles:10 Average:92.50 Median:75.00 stddev:37.19 (49.6%) stddev-sans-first:38.84 20:39:45 INFO - PROCESS | 11373 | Values: 74.0 75.0 74.0 160.0 76.0 75.0 75.0 74.0 166.0 76.0 20:39:45 INFO - PROCESS | 11373 | 20:39:45 INFO - PROCESS | 11373 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:85.00 stddev:27.63 (32.5%) stddev-sans-first:28.69 20:39:45 INFO - PROCESS | 11373 | Values: 86.0 84.0 146.0 86.0 85.0 86.0 137.0 83.0 85.0 143.0 20:39:45 INFO - PROCESS | 11373 | 20:39:45 INFO - PROCESS | 11373 | [#5] imaging-gaussian-blur Cycles:10 Average:119.40 Median:118.50 stddev:3.84 (3.2%) stddev-sans-first:4.07 20:39:45 INFO - PROCESS | 11373 | Values: 119.0 118.0 118.0 118.0 119.0 118.0 117.0 117.0 130.0 120.0 20:39:45 INFO - PROCESS | 11373 | 20:39:45 INFO - PROCESS | 11373 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:1.16 (0.8%) stddev-sans-first:1.05 20:39:45 INFO - PROCESS | 11373 | Values: 149.0 149.0 146.0 148.0 146.0 148.0 147.0 146.0 147.0 147.0 20:39:45 INFO - PROCESS | 11373 | 20:39:45 INFO - PROCESS | 11373 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.83 20:39:45 INFO - PROCESS | 11373 | Values: 95.0 96.0 96.0 98.0 95.0 96.0 96.0 96.0 97.0 96.0 20:39:45 INFO - PROCESS | 11373 | 20:39:45 INFO - PROCESS | 11373 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.05 (1.9%) stddev-sans-first:1.05 20:39:45 INFO - PROCESS | 11373 | Values: 56.0 55.0 54.0 54.0 54.0 57.0 56.0 55.0 55.0 54.0 20:39:45 INFO - PROCESS | 11373 | 20:39:45 INFO - PROCESS | 11373 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.50 stddev:0.67 (1.1%) stddev-sans-first:0.67 20:39:45 INFO - PROCESS | 11373 | Values: 61.0 61.0 61.0 59.0 61.0 60.0 60.0 60.0 60.0 60.0 20:39:45 INFO - PROCESS | 11373 | 20:39:45 INFO - PROCESS | 11373 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:81.50 stddev:8.72 (10.7%) stddev-sans-first:9.17 20:39:45 INFO - PROCESS | 11373 | Values: 81.0 79.0 79.0 84.0 87.0 80.0 80.0 82.0 108.0 82.0 20:39:45 INFO - PROCESS | 11373 | 20:39:45 INFO - PROCESS | 11373 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:127.00 stddev:4.99 (3.9%) stddev-sans-first:5.14 20:39:45 INFO - PROCESS | 11373 | Values: 124.0 125.0 129.0 124.0 135.0 124.0 128.0 137.0 126.0 122.0 20:39:45 INFO - PROCESS | 11373 | 20:39:45 INFO - PROCESS | 11373 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.50 stddev:2.90 (1.8%) stddev-sans-first:2.73 20:39:45 INFO - PROCESS | 11373 | Values: 164.0 164.0 159.0 158.0 164.0 157.0 161.0 160.0 157.0 158.0 20:39:45 INFO - PROCESS | 11373 | 20:39:45 INFO - PROCESS | 11373 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.18 (1.8%) stddev-sans-first:1.24 20:39:45 INFO - PROCESS | 11373 | Values: 64.0 64.0 63.0 64.0 66.0 62.0 63.0 63.0 62.0 64.0 20:39:45 INFO - PROCESS | 11373 | -------- Summary: end -------- 20:39:45 INFO - PROCESS | 11373 | 20:39:46 INFO - TEST-INFO | 11373: exit 0 20:39:46 INFO - TEST-OK | kraken | took 62124ms 20:39:46 INFO - SUITE-END | took 1173s 20:39:46 INFO - Completed test suite (00:19:33) 20:39:46 INFO - javascript benchmark 20:39:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7389.787915435629, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3130.5617213590117, 3161.557381966524, 3187.2509960159364, 3202.0553936588703, 3202.423563758524, 5409.404965453797, 5413.891722165555, 5491.835244942653, 5567.220589117516, 5573.191887176367, 5436.510714035736, 5445.047116754572, 5505.642133261335, 5553.250311207986, 5613.550915926727, 4902.632302577304, 4914.557689807916, 5033.295338652591, 5079.4412614612365, 5125.871853203681, 766.8591336941952, 4932.408111026664, 4974.527419895122, 5015.5486006259425, 5041.621878359119, 5016.046951079302, 5036.924446133311, 5046.52058054486, 5055.317532133188, 5060.797568097271, 5052.267421223902, 5056.140456122468, 5060.671056381323, 5077.949220507785, 5088.974555127238, 4952.133376659071, 4960.702357858504, 4995.500449954975, 5013.097642424399, 5037.244413337992, 5476.507114359727, 5535.944640553583, 5538.418466061046, 5540.141278101901, 5617.01702202113, 5792.275965504312, 5800.187973683687, 5978.581499295051, 5994.7901823436405, 6001.909971350433, 5908.05471124618, 5925.466707996258, 5945.197398351211, 5952.434518720715, 6003.489703375219, 5529.419410961871, 5540.2243685884005, 5545.3622833374275, 5546.805861794898, 5548.55611551075, 5999.550033747487, 6038.456538911519, 6049.8487537811025, 6070.453659170696, 6112.694365281718, 5824.475797178275, 5827.621204621686, 5842.298924129047, 5843.912341314884, 5850.707464626752, 6001.729922153513, 6006.939930600725, 6011.639301641915, 6015.669138197353, 6024.277086749618, 5912.9113063304085, 5952.375000624872, 5974.462298393166, 6004.42957918997, 6008.519318454513, 5954.047352423591, 6015.879682406327, 6018.518518518508, 6018.638881667114, 6027.397260273938, 4453.242948698729, 4559.772011399416, 4568.1548913451115, 4586.128635559233, 4627.30590411441, 3967.3652215645357, 3990.2418540477215, 4034.1931613677384, 4049.5545489996075, 4052.392141178788, 5656.971715141398, 5703.800366987219, 5720.427957204246, 5748.310202775694, 5757.971210143923, 5813.796517121965, 5991.7603295867675, 6001.279846418458, 6005.249343832021, 6009.909851352233, 5635.126555383922, 5680.77276908919, 5710.143478478261, 5710.71446427677, 5713.914291285634, 5122.410922743932, 5135.948640513622, 5142.280080788692, 5150.948490515122, 5220.112580861262, 6039.245094363205, 6112.655464441461, 6197.81406557804, 6209.472194863397, 6247.312795592481, 5955.910661339996, 5998.370171131968, 6006.609570378087, 6016.368281330572, 6079.2704875413465, 6173.017252078937, 6230.813075607739, 6237.532185086227, 6247.031710084944, 6262.279837818709, 5759.94240057594, 5839.386864379179, 5853.09277062056, 5922.0, 5970.492508136857, 6036.124761909411, 6056.3035250946705, 6056.485198758155, 6064.363241859718, 6116.113163591165, 5837.0368889132815, 5839.620424672383, 5886.646801191942, 5895.20414744004, 5898.262717160355, 5564.19319198722, 5678.545716342765, 5732.971335143297, 5744.712764361681, 5787.36339002701, 5672.546196304368, 5680.091185410314, 5690.658560486384, 5699.116636921284, 5717.771289148387, 5723.8569035774435, 5759.280089988752, 5763.6541807491685, 5783.248177736868, 5789.218455508452, 5591.0, 5628.60599758013, 5676.0, 5697.7151142443545, 5729.1119876419225], "value": 5446.974919979154, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.4817715878548, 605.7667797897806, 626.8840264551058, 643.9227292724873, 646.5668002438366, 40502.0, 41945.16109677809, 45627.77186114069, 45749.54250457494, 45841.0, 45806.0, 46427.767861160646, 46461.303080453734, 46495.30257046147, 46619.53380466194, 8960.327975401839, 9107.908920910771, 9111.817763644724, 9129.771755706093, 9139.0, 8926.598303076376, 8949.284057275403, 8991.460512369245, 9004.279657627407, 9066.229370503515, 9061.95469022654, 9073.863892041592, 9141.5886285117, 9151.267898568098, 9154.450732956011, 9005.279577633773, 9014.819703605925, 9040.547972601376, 9081.7275481735, 9098.363114581982, 8991.595378207996, 9101.954490227507, 9104.772380690536, 9109.27125829932, 9126.361154719172, 43018.13963720708, 43036.0, 43113.35329970053, 43159.56840431587, 43370.78314608438, 2954.6602140753876, 3393.0499460151195, 3531.2584357285, 3556.448750443685, 3600.513930619359, 30308.106491175768, 30972.0, 31225.8438707805, 31464.056078317688, 32624.510632340534, 3698.4267438547067, 3996.0, 4037.253108174997, 4045.110075783323, 4085.836566537335, 353571.0, 353952.0, 356685.0, 357143.0, 357293.0, 62557.68721156365, 63050.0, 63093.369066309664, 63152.0, 63154.0, 37258.62741372552, 38614.613853861665, 38646.806765965994, 39885.601143988766, 40356.798216008734, 14982.550523484313, 15189.164595947108, 15189.79747936543, 15200.0, 15405.768913466307, 12067.396630168456, 12186.329751863732, 12213.877861221274, 12304.507819687291, 12316.384180790925, 19749.506262343555, 20001.899990499955, 20146.294879679142, 20147.29484468066, 20188.293409730588, 7369.7052117915755, 7453.590052547053, 7459.627018649046, 7490.775276741707, 7543.207963163899, 959.2517836087862, 1129.108004676313, 1139.2082502660737, 1169.5321871251567, 1183.1717797541755, 32066.83966580199, 32599.51100733491, 32834.50748238778, 33098.51425378414, 33680.0, 1113.7891285797684, 1136.5567428702811, 1184.3841202574613, 1202.2726250618425, 1210.7275862930946, 16951.830481695273, 17242.913785430992, 17280.740788888175, 17360.65278694419, 17471.475855724348, 160361.1981940083, 160661.1966940158, 161521.0, 161691.0, 556519.0, 56908.715456422455, 58251.70874145602, 58730.706346467996, 58740.70629646824, 59094.0, 1376.7246550689902, 1385.88220001299, 1392.2621010864057, 1401.0962928910797, 1412.6327154939584, 30880.455977201498, 32384.83807580947, 32441.51337729983, 32529.83735081404, 32581.18547036343, 51288.0, 51592.0, 51688.22467662913, 51746.223806643684, 51834.481655182964, 462863.0, 464907.0, 466362.0, 466682.0, 468284.0, 29644.258893527833, 30531.84734076404, 32054.519182212753, 32134.517982230755, 32291.51562726514, 49330.260046100055, 49861.750691246314, 50121.492824484616, 50431.747841260556, 51179.232311516105, 42051.57948420477, 42132.78933605312, 42415.0, 43306.35040474458, 43664.0, 41778.0, 42123.368149478396, 42559.0, 42638.0, 42702.78648606737, 36430.0, 41175.38236926388, 41313.58686413218, 41411.0, 42737.35893961531, 34116.0, 37389.626103739705, 37938.43092353672, 38542.614573855026, 38790.0, 28656.570151448163, 28775.0, 28860.855695721388, 28997.710022900344, 29105.272368190963], "value": 19800.22838774088, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.9068714195737, 408.636313680824, 411.06892887609587, 419.3918817714313, 419.64539963730647, 13931.303434828244, 18050.09749512524, 19077.0, 19577.119029643647, 19578.804211957893, 18700.0, 18738.531536711555, 19034.61930761384, 19475.415737527863, 19517.21931122757, 5634.098544232924, 5837.766489340422, 5897.174395584621, 5912.379200183983, 5974.462298393144, 5860.912086318709, 5864.44287792659, 5872.647641141545, 5888.057910734284, 5896.941030589682, 5697.059985102474, 5803.303603567578, 5807.767689292423, 5815.331236907747, 5830.708464576775, 5487.341519017744, 5786.392428794979, 5796.44933731297, 5807.535397168216, 5816.621919575214, 5112.130937740593, 5236.240745091978, 5260.447652996419, 5265.394479634852, 5281.577473802086, 22092.779072209232, 22446.214382496535, 22850.428739281484, 23392.18127365551, 23401.180958666366, 2429.927102186937, 2495.338735235164, 2593.9610905836425, 3022.486177349856, 3120.0795765249304, 14238.501652442219, 14316.85683143176, 14558.563243102724, 14852.0, 14970.550883473514, 1907.7138429235588, 1915.9712604310946, 1954.9706754398696, 1966.1349006437122, 2013.748281464817, 57561.0, 73091.63454182749, 76784.0, 79606.99999999942, 81950.0, 9295.442273463614, 9645.42127472354, 11037.503312350964, 11038.448077596087, 11280.605178818701, 15192.240387980557, 15255.160966146968, 15263.0, 15268.770968435483, 15318.770218446733, 7996.760097197093, 8208.753737387888, 8277.668893244203, 8291.295239904555, 8376.916230837614, 7893.329067029252, 7928.484648497829, 7932.660265113111, 7983.600819958979, 8042.316403105685, 6755.630939612323, 6768.9661551691925, 6778.864422711518, 6834.829129271808, 6890.655467226718, 2013.5872146209992, 2015.667414876529, 2022.3528470889173, 2046.6009128219855, 2100.926467573658, 1001.484235618657, 1029.7322696099068, 1072.0726571515584, 1097.4403054442291, 1119.8824123467082, 19424.514387140152, 19482.610347792965, 19517.0, 19686.803131968783, 19721.785508169396, 1018.5365658625308, 1027.275770581738, 1045.8483519889573, 1052.894710528941, 1074.2856000759564, 10479.895201047892, 11352.091832653368, 11389.94305028486, 11447.484863181176, 11523.654290371134, 463228.0, 467610.0, 471032.0, 471900.0, 495014.0, 75755.0, 84317.0, 84513.0, 84559.57720211483, 90769.54615226881, 935.9064093590587, 948.2793077261331, 962.6149540183983, 969.069693094623, 995.5465021069175, 16861.409850655167, 16918.154092295583, 17320.65358692794, 17466.73799893028, 18109.818901810813, 39714.80142599384, 40592.39111413272, 40609.0, 40877.79561102176, 43927.341089884314, 48278.75860620674, 50449.49550504448, 59906.0, 61547.6922615384, 62666.0, 8550.78623034429, 8603.784905377415, 8637.395382323177, 8818.0, 9071.727848164566, 12772.169808962388, 13320.067595268238, 13533.932330338286, 13935.930320348334, 14199.361028753938, 11938.343391113573, 12133.0, 12228.694282643006, 12355.444005019976, 12419.0, 12035.338056406981, 12076.396180190779, 12227.266364018187, 12327.50689972391, 12530.122891397516, 12321.815172772236, 12359.62921112368, 12608.49566017349, 12665.176763510342, 12671.239725616493, 7817.726379576688, 7917.208279172267, 8012.557739606927, 8114.797130071795, 8887.777805554913, 10775.299605525615, 10997.12023038139, 11761.588344407905, 12140.453679584616, 12235.93882030584], "value": 9445.697277548543, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.9779203311953, 1496.16214919645, 1620.9594760130994, 1714.4856543037095, 1733.904635245061, 7972.242636949481, 8696.652133914651, 8725.738227853166, 9370.718878433641, 9377.39046961947, 8725.127487251271, 9043.50260735661, 9071.183593476586, 9133.908660913388, 9149.588268527916, 2363.3264519611957, 2416.9274921752376, 2417.262734865874, 2421.079989603948, 2424.333308340203, 2258.4579700871836, 2305.481266714984, 2313.9652905206435, 2321.791038806507, 2323.0707716913203, 2412.2401443545227, 2426.1872272788637, 2430.501747141832, 2474.0845887021737, 2474.653548503211, 2269.2624896908487, 2274.1358283852032, 2297.356740112771, 2299.482616411311, 2321.5937210988177, 2356.5875971705054, 2357.3399448154546, 2364.3025307534317, 2364.9830572853666, 2367.112332875172, 9105.36262461628, 9273.165415112673, 9278.582463789078, 9311.813763724755, 9317.068293170696, 5375.973120134413, 5523.1163013917985, 5527.115661494142, 5531.668099914018, 5543.057680194336, 3327.168207948013, 3339.899803005914, 3388.288459423524, 3405.1146701857697, 3481.634428385034, 1144.9656510304703, 1149.1668540308294, 1158.1950544371666, 1159.6810877008807, 1172.3552046374546, 12690.49238030487, 12753.872461275454, 12756.936215318958, 12793.55222567215, 12796.360181990864, 4718.799391570181, 4767.833125840648, 4777.211760059621, 4803.3995750531185, 4925.1873440881855, 10839.512221950032, 10876.912308769219, 10880.292780969212, 10885.564577416815, 10941.343519388703, 5357.973210133924, 5388.91916621251, 5399.649022813504, 5502.972485137549, 5505.064139096363, 4367.410399596014, 4698.765061746899, 4827.517248275144, 4847.079054979543, 4980.950190498121, 4081.754586870508, 4129.463169787909, 4134.276501612206, 4135.875923722293, 4215.894602634959, 1326.0448945282058, 1336.6992426703914, 1345.5290648273221, 1367.268511346425, 1369.1511263016794, 1010.3230835340339, 1022.2282176956351, 1035.414990530348, 1036.7770929250096, 1052.1845569683403, 6341.429271365507, 6359.21941856281, 6365.936340636535, 6535.215774107138, 6568.146141001735, 956.1824639932896, 977.6529332087007, 994.1003391930315, 999.8650182225452, 1017.2065788684838, 4302.373138348275, 4398.164348773723, 4463.129689710475, 4472.195004899149, 4513.210188217049, 11088.279261848116, 11420.885791141982, 11426.314421134759, 11458.598949036743, 11519.48162332697, 11437.942810285895, 11438.59964901241, 11464.770704585862, 11482.425878706032, 11493.77012459746, 8121.309688676529, 8344.582770861432, 8482.363822713321, 8632.525211113323, 8641.092685268208, 6023.337432882292, 6066.332703402711, 6328.525360597881, 6353.237611486651, 6477.546571739933, 10071.597136114473, 10277.331973421704, 10432.68701938943, 10560.947195263974, 10649.680509584725, 10671.57313707443, 10678.89321106779, 10724.463776811284, 10789.244752867224, 10792.514336854703, 7487.176410594721, 7762.262585054411, 7915.683372665029, 8040.155783642867, 8125.593720314079, 8921.598528066383, 9019.594118264562, 9056.54717264121, 9069.682561110329, 9095.909040909506, 7709.151993280847, 7869.331106855752, 7967.681292748225, 8099.716509922125, 8221.260086592236, 7927.0, 7978.640961156878, 8018.639161237642, 8110.026796784424, 8121.878171827309, 7013.649317534205, 7367.336939675455, 7436.59098749574, 7510.586917719578, 7514.9624251878395, 5375.838724838261, 5417.0, 5473.397926228032, 5495.587830912617, 5580.748866301107, 5366.946330536644, 5378.542823860016, 5572.526335261548, 5705.543556515552, 5735.397783232867], "value": 4827.259335258012, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.1862924060609, 332.31211392417697, 334.49658264312205, 334.9179451034497, 340.8125530957972, 5493.340799104113, 5587.636803607773, 5656.2929633795775, 5678.176664383667, 5711.371749107595, 5578.3584887737925, 5584.441555844413, 5584.9162262566, 5600.487868275563, 5621.915671264935, 4317.870463886088, 4320.09278051608, 4347.69566130371, 4363.0, 4367.45406824147, 4106.404571337154, 4317.0, 4340.696151269412, 4357.891052723691, 4373.562643735617, 4226.957730422687, 4275.166342563186, 4313.978430107845, 4318.935215971763, 4326.372675961999, 4270.316749320125, 4307.07397909451, 4320.6327462165755, 4327.0, 4346.0, 3625.29306785177, 3787.62123787619, 3798.373268410709, 3804.334241507725, 3805.904852378685, 5446.645968012067, 5461.726913654302, 5469.835904922819, 5488.4785945335125, 5517.172424136372, 4877.6829506081995, 4906.0, 4913.410390753097, 4954.900901981976, 4990.9768497457935, 5479.301416560879, 5827.679477628729, 5855.326637436707, 5960.880782384328, 5985.413865325692, 4101.405296232029, 4115.691323150776, 4119.814608342632, 4147.6474499667265, 4153.958460415387, 6069.453749162552, 6119.143319935212, 6158.876822463526, 6164.938350616481, 6219.1604133442315, 4104.056067104582, 4190.979045104755, 4226.957730422657, 4235.343521754133, 4240.957590424056, 4219.409282700424, 4228.9154216915485, 4262.254105531581, 4266.786660666954, 4298.161858437575, 4865.440474345425, 4918.9508104919205, 4942.604591632661, 4948.851534453972, 4987.526185012418, 5905.970470147708, 5960.4635582797755, 5966.522678185735, 5984.31180414258, 6015.909761353583, 1487.300968544782, 1493.3951749541452, 1506.4802643088117, 1508.3664860758288, 1508.8189417269998, 924.5515924776478, 952.6332362040525, 954.9570269337896, 962.1196605106389, 962.3311798300114, 5115.769790359368, 5148.057864450095, 5202.92195617066, 5223.582113430916, 5244.396894357122, 5252.632315737938, 5363.758630861621, 5489.917651235235, 5502.899420115993, 5531.695756733418, 5004.224345226496, 5131.254778693381, 5138.922916156261, 5227.196617167071, 5236.214567814782, 2831.377097038648, 2858.399296394026, 2918.6789453160136, 2923.845081192917, 2941.426421847762, 5537.483697851893, 5543.959171851806, 5577.776888924479, 5609.663420194802, 5635.956583444976, 5173.0, 5420.647657902224, 5448.863778405493, 5456.645318054393, 5504.53211477029, 5552.666839989613, 5560.388357280696, 5565.888682226333, 5648.293963254593, 5666.688332141689, 5096.770645321044, 5340.412554618911, 5368.651037682538, 5397.9460205397445, 5446.863828404163, 5304.23088652151, 5316.734163291897, 5329.08153064904, 5338.786448542015, 5355.410904800391, 5564.0, 5573.940951219255, 5628.155776633538, 5686.886262274814, 6124.173236613, 4188.602082802129, 4189.91620167601, 4210.5578764316015, 4214.641755450821, 4217.523866646649, 5924.940750592439, 5940.990031694536, 5997.520198384206, 6026.819195424145, 6055.848603784941, 5651.57613179005, 5864.208331875142, 5866.882662346815, 5906.1060080559355, 5937.614055086406, 5722.885542289214, 5757.481826635623, 5773.910957637644, 5797.797077102281, 5832.3292821326095, 5746.626469279484, 5751.281089863767, 5831.912521312099, 5843.561732869966, 5847.883042339215, 5735.13972904051, 5836.278297902044, 5903.527717782481, 5931.555133365101, 6049.213602231682, 5785.334686510937, 5802.767889284551, 5807.809399073264, 5812.505936995233, 5915.319738230159], "value": 4326.800853054248, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.7203806629614, 796.4345314826473, 799.8962728025292, 802.2338666573423, 827.5393929714054, 15145.848541514582, 16013.0, 16139.435119770811, 16204.513864584067, 16221.594460138502, 13696.65758356039, 13860.93069534651, 13873.306334683251, 13882.93058534706, 13890.305484725774, 676.3067855448156, 789.1477204618998, 803.6945960535003, 813.5484805932705, 817.4849844597895, 793.2147174297432, 799.1289494451047, 801.5992003998001, 803.8070862992898, 803.8311954489535, 844.6368061733452, 845.7970087179064, 846.1580727176437, 853.7353420439653, 854.7948492361819, 841.9536925469097, 842.8525008123585, 843.7679638099572, 848.4061157189992, 852.6291063387384, 615.2248167309178, 617.3764497857196, 620.711369213318, 623.4451338308909, 624.0265186309372, 14772.409103635842, 14885.479008234768, 14902.105873647615, 14917.179555124463, 14924.925375373054, 14971.70056598862, 15002.774958375632, 15072.623184420367, 15273.778097752152, 15315.387384504607, 11922.105842061794, 12005.45975431099, 12051.57819476314, 12234.143609947307, 12290.139690221687, 3917.6865850732156, 3917.7061720371084, 4024.75851448914, 4066.5120185577625, 4073.5111786585503, 75221.0, 76439.61780191063, 77171.61414192893, 77968.0, 78162.60918695427, 11718.765624687629, 11763.122476446802, 11788.528458861721, 11794.233374830608, 12121.333326666942, 22902.42743931415, 22923.770762292497, 22930.770692293197, 22946.42633934165, 23059.769402306098, 8488.490690558587, 8521.36089793268, 8733.170348816851, 8748.212660860552, 8916.286697064219, 4603.079384123189, 4660.370849935283, 4720.386349774576, 4764.880877978078, 4868.488808675038, 3460.2733425980323, 3581.194231297989, 3584.0860580551794, 3588.3899737044244, 3606.386914224588, 593.7862369546959, 606.9453749162508, 607.8298076538576, 617.8115674719254, 622.2346513788066, 625.9342769009279, 739.3087463221905, 743.5129989856653, 746.2872956326695, 751.7932568543695, 9509.90490095104, 9805.656802012038, 9832.164266037324, 9952.751181220527, 10340.0, 717.9030830837875, 737.4535985648417, 745.1765798792364, 756.4137793210306, 760.1144666463508, 4761.642876784185, 4812.230043193143, 4834.323194752737, 4884.290716475035, 4925.11347957364, 119902.400487997, 120826.0, 122296.0, 125125.37437312755, 125405.0, 61418.38581614216, 96656.51671741596, 96975.51512242394, 97272.51363743136, 97784.51107744416, 55145.172822407694, 77887.22112778913, 79494.205057951, 83904.58047709844, 91209.0, 9896.257780666623, 10006.949965250127, 10131.392116473035, 10149.441780702133, 10223.795524089328, 51735.48264517307, 52210.0, 52537.474625254785, 53625.0, 54737.0, 73732.0, 76214.71355859333, 77103.61448192723, 77866.38135758524, 81873.0, 11249.0, 12364.0, 12409.0, 12447.502099915902, 12984.15602985803, 12432.502699891904, 12546.435410406371, 13042.152260103063, 14289.341744295118, 14694.706105878036, 13582.86417135816, 13754.31228438594, 13991.510297139552, 14154.929225353808, 14738.705225895637, 14246.145231286157, 14282.785758213842, 14309.427622894967, 15093.622659433162, 15195.240237988277, 14152.52330842119, 14450.277486125862, 14793.038452500554, 14943.701125977203, 15118.244087795347, 11474.632527264173, 11623.0, 11946.462409191781, 12251.877481225074, 12450.875491245333, 11869.643910682693, 12005.640568242321, 12022.699432514257, 12099.153059285765, 12422.751544968869], "value": 7652.839521336871, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 109.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 153.0, 177.0, 126.0, 151.0, 155.0, 128.0, 178.0, 133.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 162.0, 165.0, 178.0, 163.0, 165.0, 162.0, 164.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 160.0, 76.0, 75.0, 75.0, 74.0, 166.0, 76.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 146.0, 86.0, 85.0, 86.0, 137.0, 83.0, 85.0, 143.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 118.0, 119.0, 118.0, 117.0, 117.0, 130.0, 120.0], "value": 119.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 146.0, 148.0, 146.0, 148.0, 147.0, 146.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 98.0, 95.0, 96.0, 96.0, 96.0, 97.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 54.0, 54.0, 57.0, 56.0, 55.0, 55.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 59.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 79.0, 84.0, 87.0, 80.0, 80.0, 82.0, 108.0, 82.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 125.0, 129.0, 124.0, 135.0, 124.0, 128.0, 137.0, 126.0, 122.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 159.0, 158.0, 164.0, 157.0, 161.0, 160.0, 157.0, 158.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 64.0, 66.0, 62.0, 63.0, 63.0, 62.0, 64.0], "value": 63.5, "unit": "score"}]}]} 20:39:46 INFO - Return code: 0 20:39:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:39:46 ERROR - # TBPL SUCCESS # 20:39:46 INFO - Running post-action listener: _resource_record_post_action 20:39:46 INFO - ##### 20:39:46 INFO - ##### Finished run-tests step (success) 20:39:46 INFO - ##### 20:39:46 INFO - Running post-run listener: _resource_record_post_run 20:39:46 INFO - Total resource usage - Wall time: 1192s; CPU: 14.0%; Read bytes: 8192; Write bytes: 296341504; Read time: 24; Write time: 223600 20:39:46 INFO - TinderboxPrint: CPU usage
13.5% 20:39:46 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 20:39:46 INFO - TinderboxPrint: I/O write bytes / time
296,341,504 / 223,600 20:39:46 INFO - TinderboxPrint: CPU idle
8,219.6 (86.4%) 20:39:46 INFO - TinderboxPrint: CPU user
1,232.9 (13.0%) 20:39:46 INFO - TinderboxPrint: Swap in / out
0 / 0 20:39:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5316608; Read time: 0; Write time: 440 20:39:46 INFO - run-tests - Wall time: 1175s; CPU: 14.0%; Read bytes: 8192; Write bytes: 291024896; Read time: 24; Write time: 223160 20:39:47 INFO - Running post-run listener: _upload_blobber_files 20:39:47 INFO - Blob upload gear active. 20:39:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:39:47 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 20:39:47 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'] 20:39:47 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 20:39:47 INFO - (blobuploader) - INFO - Open directory for files ... 20:39:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:39:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:39:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:39:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:39:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:39:48 INFO - (blobuploader) - INFO - Done attempting. 20:39:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:39:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:39:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:39:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:39:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:39:52 INFO - (blobuploader) - INFO - Done attempting. 20:39:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:39:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:39:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:39:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:39:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:39:53 INFO - (blobuploader) - INFO - Done attempting. 20:39:53 INFO - (blobuploader) - INFO - Iteration through files over. 20:39:53 INFO - Return code: 0 20:39:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:39:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:39:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63e19ea6b6847cffa780fd5334a5977fec1789c1c8f5a7d69e2798fe7a721a22e5c635b5a7c173097119a7c65a946a472d09b22d4997aeef2e35a857a0743fd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d2fe797bd18a7225f13c5cfa1fe8e783df5589adfee9ee0e2c3f35f5bd159a6809e9349c3a0872e1feca4cc35b556b7aa946c0f260e363c1a1b32ecc16b49d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a487b0271940b736e91a2b14aea1cf5465d9e1b30c123b45243258e65b0d00135cc3b98834288d56ccbbae782458a497fd52d5fd1cd9e030240ee31a3d6c3de"} 20:39:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:39:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:39:53 INFO - Contents: 20:39:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63e19ea6b6847cffa780fd5334a5977fec1789c1c8f5a7d69e2798fe7a721a22e5c635b5a7c173097119a7c65a946a472d09b22d4997aeef2e35a857a0743fd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d2fe797bd18a7225f13c5cfa1fe8e783df5589adfee9ee0e2c3f35f5bd159a6809e9349c3a0872e1feca4cc35b556b7aa946c0f260e363c1a1b32ecc16b49d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a487b0271940b736e91a2b14aea1cf5465d9e1b30c123b45243258e65b0d00135cc3b98834288d56ccbbae782458a497fd52d5fd1cd9e030240ee31a3d6c3de"} 20:39:53 INFO - Running post-run listener: copy_logs_to_upload_dir 20:39:53 INFO - Copying logs to upload dir... 20:39:53 INFO - mkdir: /builds/slave/test/build/upload/logs 20:39:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.658562 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-13 20:39:52.491106) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 20:39:52.494765) ========= 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=3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250 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/63e19ea6b6847cffa780fd5334a5977fec1789c1c8f5a7d69e2798fe7a721a22e5c635b5a7c173097119a7c65a946a472d09b22d4997aeef2e35a857a0743fd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d2fe797bd18a7225f13c5cfa1fe8e783df5589adfee9ee0e2c3f35f5bd159a6809e9349c3a0872e1feca4cc35b556b7aa946c0f260e363c1a1b32ecc16b49d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a487b0271940b736e91a2b14aea1cf5465d9e1b30c123b45243258e65b0d00135cc3b98834288d56ccbbae782458a497fd52d5fd1cd9e030240ee31a3d6c3de"} build_url:https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/VdRlrr5EToObkXHZ4mSutA/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/63e19ea6b6847cffa780fd5334a5977fec1789c1c8f5a7d69e2798fe7a721a22e5c635b5a7c173097119a7c65a946a472d09b22d4997aeef2e35a857a0743fd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d2fe797bd18a7225f13c5cfa1fe8e783df5589adfee9ee0e2c3f35f5bd159a6809e9349c3a0872e1feca4cc35b556b7aa946c0f260e363c1a1b32ecc16b49d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a487b0271940b736e91a2b14aea1cf5465d9e1b30c123b45243258e65b0d00135cc3b98834288d56ccbbae782458a497fd52d5fd1cd9e030240ee31a3d6c3de"}' ========= master_lag: 0.80 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 20:39:53.302704) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 20:39:53.303087) ========= 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=3a3620fb28aea1604ab609ef000001d2-1465860189.46173-1781714250 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 20:39:53.319847) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 20:39:53.320168) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 20:39:53.323520) ========= ========= Total master_lag: 0.89 =========