builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-033 starttime: 1465470605.77 results: success (0) buildid: 20160609025931 builduid: b264b20b80e14011904513992015937d revision: cb493102af8a50946ac601a86cc3d076703faa57 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:05.770079) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:05.770495) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:05.771015) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:05.790072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:05.790381) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 04:10: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.5M=0s 2016-06-09 04:10:06 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073463 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:05.877669) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:05.877958) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013667 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:05.929060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 04:10:05.929538) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cb493102af8a50946ac601a86cc3d076703faa57 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev cb493102af8a50946ac601a86cc3d076703faa57 --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=edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 04:10:06,165 truncating revision to first 12 chars 2016-06-09 04:10:06,165 Setting DEBUG logging. 2016-06-09 04:10:06,165 attempt 1/10 2016-06-09 04:10:06,165 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cb493102af8a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 04:10:07,467 unpacking tar archive at: mozilla-central-cb493102af8a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.649647 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 04:10:07.594335) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:07.594703) ========= script_repo_revision: cb493102af8a50946ac601a86cc3d076703faa57 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:07.595134) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:07.595431) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 04:10:07.604667) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-06-09 04:10:07.604944) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:10:07 INFO - MultiFileLogger online at 20160609 04:10:07 in /builds/slave/test 04:10:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:10:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:10:07 INFO - {'append_to_log': False, 04:10:07 INFO - 'base_work_dir': '/builds/slave/test', 04:10:07 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:10:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:10:07 INFO - 'branch': 'Firefox-Non-PGO', 04:10:07 INFO - 'buildbot_json_path': 'buildprops.json', 04:10:07 INFO - 'config_files': ('talos/linux_config.py',), 04:10:07 INFO - 'default_actions': ('clobber', 04:10:07 INFO - 'read-buildbot-config', 04:10:07 INFO - 'download-and-extract', 04:10:07 INFO - 'populate-webroot', 04:10:07 INFO - 'create-virtualenv', 04:10:07 INFO - 'install', 04:10:07 INFO - 'run-tests'), 04:10:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:10:07 INFO - 'download_minidump_stackwalk': True, 04:10:07 INFO - 'download_symbols': 'ondemand', 04:10:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:10:07 INFO - 'tooltool.py': '/tools/tooltool.py', 04:10:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:10:07 INFO - '/tools/misc-python/virtualenv.py')}, 04:10:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:10:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:10:07 INFO - 'installer_path': 'installer.exe', 04:10:07 INFO - 'log_level': 'info', 04:10:07 INFO - 'log_name': 'talos', 04:10:07 INFO - 'log_to_console': True, 04:10:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:10:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:10:07 INFO - 'opt_config_files': (), 04:10:07 INFO - 'pip_index': False, 04:10:07 INFO - 'sps_profile': False, 04:10:07 INFO - 'sps_profile_interval': 0, 04:10:07 INFO - 'suite': 'dromaeojs-e10s', 04:10:07 INFO - 'system_bits': '32', 04:10:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:10:07 INFO - 'title': 'talos-linux64-ix-033', 04:10:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:10:07 INFO - 'use_talos_json': True, 04:10:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:10:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:10:07 INFO - 'work_dir': 'build'} 04:10:07 INFO - ##### 04:10:07 INFO - ##### Running clobber step. 04:10:07 INFO - ##### 04:10:07 INFO - Running pre-action listener: _resource_record_pre_action 04:10:07 INFO - Running main action method: clobber 04:10:07 INFO - rmtree: /builds/slave/test/build 04:10:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:10:08 INFO - Running post-action listener: _resource_record_post_action 04:10:08 INFO - ##### 04:10:08 INFO - ##### Finished clobber step (success) 04:10:08 INFO - ##### 04:10:08 INFO - ##### 04:10:08 INFO - ##### Running read-buildbot-config step. 04:10:08 INFO - ##### 04:10:08 INFO - Running pre-action listener: _resource_record_pre_action 04:10:08 INFO - Running main action method: read_buildbot_config 04:10:08 INFO - Using buildbot properties: 04:10:08 INFO - { 04:10:08 INFO - "project": "", 04:10:08 INFO - "product": "firefox", 04:10:08 INFO - "script_repo_revision": "production", 04:10:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:10:08 INFO - "repository": "", 04:10:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:10:08 INFO - "buildid": "20160609025931", 04:10:08 INFO - "pgo_build": "False", 04:10:08 INFO - "basedir": "/builds/slave/test", 04:10:08 INFO - "buildnumber": 79, 04:10:08 INFO - "slavename": "talos-linux64-ix-033", 04:10:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:10:08 INFO - "platform": "ubuntu64_hw", 04:10:08 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:10:08 INFO - "branch": "mozilla-central", 04:10:08 INFO - "repo_path": "mozilla-central", 04:10:08 INFO - "revision": "cb493102af8a50946ac601a86cc3d076703faa57", 04:10:08 INFO - "stage_platform": "linux64", 04:10:08 INFO - "builduid": "b264b20b80e14011904513992015937d", 04:10:08 INFO - "slavebuilddir": "test" 04:10:08 INFO - } 04:10:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:10:08 INFO - Running post-action listener: _resource_record_post_action 04:10:08 INFO - ##### 04:10:08 INFO - ##### Finished read-buildbot-config step (success) 04:10:08 INFO - ##### 04:10:08 INFO - ##### 04:10:08 INFO - ##### Running download-and-extract step. 04:10:08 INFO - ##### 04:10:08 INFO - Running pre-action listener: _resource_record_pre_action 04:10:08 INFO - Running main action method: download_and_extract 04:10:08 INFO - mkdir: /builds/slave/test/build/tests 04:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:08 INFO - https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:10:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:10:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:10:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/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 04:10:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/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 04:10:14 INFO - Downloaded 1361 bytes. 04:10:14 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:10:14 INFO - Using the following test package requirements: 04:10:14 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:10:14 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:10:14 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:10:14 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:14 INFO - u'jsshell-linux-x86_64.zip'], 04:10:14 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:10:14 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:10:14 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:10:14 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:10:14 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:10:14 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:10:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:10:14 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')]} 04:10:14 INFO - https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:10:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:10:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:10:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/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 04:10:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/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 04:10:21 INFO - Downloaded 22879571 bytes. 04:10:21 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'] 04:10:21 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 04:10:23 INFO - Return code: 0 04:10:23 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 04:10:23 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')]} 04:10:23 INFO - https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:10:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:10:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:10:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/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 04:10:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/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 04:10:24 INFO - Downloaded 22879571 bytes. 04:10: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'] 04:10: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 04:10:25 INFO - Return code: 0 04:10: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')]} 04:10:25 INFO - https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:10:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:10:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:10:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/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 04:10:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/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 04:10:27 INFO - Downloaded 10833377 bytes. 04:10: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'] 04:10: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 04:10:27 INFO - Return code: 0 04:10: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')]} 04:10:27 INFO - https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:10:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:10:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:10:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/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 04:10:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/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 04:10:29 INFO - Downloaded 55435697 bytes. 04:10:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:10:29 INFO - mkdir: /builds/slave/test/properties 04:10:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:10:29 INFO - Writing to file /builds/slave/test/properties/build_url 04:10:29 INFO - Contents: 04:10:29 INFO - build_url:https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:10:29 INFO - Running post-action listener: _resource_record_post_action 04:10:29 INFO - Running post-action listener: set_extra_try_arguments 04:10:29 INFO - ##### 04:10:29 INFO - ##### Finished download-and-extract step (success) 04:10:29 INFO - ##### 04:10:29 INFO - ##### 04:10:29 INFO - ##### Running populate-webroot step. 04:10:29 INFO - ##### 04:10:29 INFO - Running pre-action listener: _resource_record_pre_action 04:10:29 INFO - Running main action method: populate_webroot 04:10:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:10:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:10:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:10:29 INFO - '--tppagecycles', 04:10:29 INFO - '7'], 04:10:29 INFO - 'tests': ['tsvgm']}}, 04:10:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:10:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:10:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:10:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:10:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:10:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:10:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:29 INFO - 'talos_options': ['--disable-e10s'], 04:10:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:10:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:10:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:29 INFO - 'talos_options': ['--disable-e10s'], 04:10:29 INFO - 'tests': ['damp', 'tps']}, 04:10:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:29 INFO - 'tests': ['damp', 'tps']}, 04:10:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:10:29 INFO - 'tests': ['dromaeo_dom']}, 04:10:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:10:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:10:29 INFO - 'tests': ['a11yr', 04:10:29 INFO - 'ts_paint', 04:10:29 INFO - 'tpaint', 04:10:29 INFO - 'sessionrestore', 04:10:29 INFO - 'sessionrestore_no_auto_restore', 04:10:29 INFO - 'tabpaint']}, 04:10:29 INFO - 'other-e10s': {'tests': ['a11yr', 04:10:29 INFO - 'ts_paint', 04:10:29 INFO - 'tpaint', 04:10:29 INFO - 'sessionrestore', 04:10:29 INFO - 'sessionrestore_no_auto_restore', 04:10:29 INFO - 'tabpaint']}, 04:10:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:10:29 INFO - 'ts_paint', 04:10:29 INFO - 'tpaint', 04:10:29 INFO - 'sessionrestore', 04:10:29 INFO - 'sessionrestore_no_auto_restore', 04:10:29 INFO - 'tabpaint']}, 04:10:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:10:29 INFO - 'ts_paint', 04:10:29 INFO - 'tpaint', 04:10:29 INFO - 'sessionrestore', 04:10:29 INFO - 'sessionrestore_no_auto_restore', 04:10:29 INFO - 'tabpaint']}, 04:10:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:10:29 INFO - 'tests': ['a11yr', 04:10:29 INFO - 'ts_paint', 04:10:29 INFO - 'tpaint', 04:10:29 INFO - 'sessionrestore', 04:10:29 INFO - 'sessionrestore_no_auto_restore', 04:10:29 INFO - 'tabpaint']}, 04:10:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:10:29 INFO - 'tests': ['a11yr', 04:10:29 INFO - 'ts_paint', 04:10:29 INFO - 'tpaint', 04:10:29 INFO - 'sessionrestore', 04:10:29 INFO - 'sessionrestore_no_auto_restore', 04:10:29 INFO - 'tabpaint']}, 04:10:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:10:29 INFO - 'tests': ['tsvgx', 04:10:29 INFO - 'tsvgr_opacity', 04:10:29 INFO - 'tart', 04:10:29 INFO - 'tscrollx', 04:10:29 INFO - 'cart']}, 04:10:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:10:29 INFO - 'tsvgr_opacity', 04:10:29 INFO - 'tart', 04:10:29 INFO - 'tscrollx', 04:10:29 INFO - 'cart']}, 04:10:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:29 INFO - 'talos_options': ['--disable-e10s'], 04:10:29 INFO - 'tests': ['tp5o']}, 04:10:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:29 INFO - 'tests': ['tp5o']}, 04:10:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:29 INFO - 'talos_options': ['--disable-e10s', 04:10:29 INFO - '--xperf_path', 04:10:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:10:29 INFO - 'tests': ['tp5n']}, 04:10:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:29 INFO - 'talos_options': ['--xperf_path', 04:10:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:10:29 INFO - 'tests': ['tp5n']}}, 04:10:29 INFO - 'talos.zip': {'path': '', 04:10:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:10:29 INFO - Running post-action listener: _resource_record_post_action 04:10:29 INFO - ##### 04:10:29 INFO - ##### Finished populate-webroot step (success) 04:10:29 INFO - ##### 04:10:29 INFO - ##### 04:10:29 INFO - ##### Running create-virtualenv step. 04:10:29 INFO - ##### 04:10:29 INFO - Running pre-action listener: _resource_record_pre_action 04:10:29 INFO - Running main action method: create_virtualenv 04:10:29 INFO - Creating virtualenv /builds/slave/test/build/venv 04:10: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 04:10:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:10:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:10:29 INFO - Using real prefix '/usr' 04:10:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:10:30 INFO - Installing distribute.............................................................................................................................................................................................done. 04:10:32 INFO - Installing pip.................done. 04:10:32 INFO - Return code: 0 04:10:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:10: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')]} 04:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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')]} 04:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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 0x7f7b98518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', '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 04:10: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 04:10: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 04:10:32 INFO - Using env: {'DISPLAY': ':0', 04:10:32 INFO - 'HOME': '/home/cltbld', 04:10:32 INFO - 'LANG': 'en_US.UTF-8', 04:10:32 INFO - 'LANGUAGE': 'en_US:en', 04:10:32 INFO - 'LOGNAME': 'cltbld', 04:10:32 INFO - 'MAIL': '/var/mail/cltbld', 04:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:32 INFO - 'MOZ_NO_REMOTE': '1', 04:10:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:32 INFO - 'NO_EM_RESTART': '1', 04:10:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:32 INFO - 'PWD': '/builds/slave/test', 04:10:32 INFO - 'SHELL': '/bin/bash', 04:10:32 INFO - 'SHLVL': '1', 04:10:32 INFO - 'TERM': 'linux', 04:10:32 INFO - 'TMOUT': '86400', 04:10:32 INFO - 'USER': 'cltbld', 04:10:32 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', 04:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:32 INFO - '_': '/tools/buildbot/bin/python'} 04:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10: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 04:10:32 INFO - Cleaning up... 04:10:32 INFO - Return code: 0 04:10:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:10: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')]} 04:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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')]} 04:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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 0x7f7b98518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', '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 04:10: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 04:10: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 04:10:32 INFO - Using env: {'DISPLAY': ':0', 04:10:32 INFO - 'HOME': '/home/cltbld', 04:10:32 INFO - 'LANG': 'en_US.UTF-8', 04:10:32 INFO - 'LANGUAGE': 'en_US:en', 04:10:32 INFO - 'LOGNAME': 'cltbld', 04:10:32 INFO - 'MAIL': '/var/mail/cltbld', 04:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:32 INFO - 'MOZ_NO_REMOTE': '1', 04:10:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:32 INFO - 'NO_EM_RESTART': '1', 04:10:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:32 INFO - 'PWD': '/builds/slave/test', 04:10:32 INFO - 'SHELL': '/bin/bash', 04:10:32 INFO - 'SHLVL': '1', 04:10:32 INFO - 'TERM': 'linux', 04:10:32 INFO - 'TMOUT': '86400', 04:10:32 INFO - 'USER': 'cltbld', 04:10:32 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', 04:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:32 INFO - '_': '/tools/buildbot/bin/python'} 04:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:32 INFO - Downloading/unpacking psutil>=3.1.1 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:10:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:10:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:10:34 INFO - Installing collected packages: psutil 04:10:34 INFO - Running setup.py install for psutil 04:10:34 INFO - building 'psutil._psutil_linux' extension 04:10: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 04:10:35 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 04:10:35 INFO - building 'psutil._psutil_posix' extension 04:10:35 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 04:10:35 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 04:10:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:10:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:10:35 INFO - Successfully installed psutil 04:10:35 INFO - Cleaning up... 04:10:35 INFO - Return code: 0 04:10:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:10: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')]} 04:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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')]} 04:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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 0x7f7b98518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', '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 04:10: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 04:10: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 04:10:35 INFO - Using env: {'DISPLAY': ':0', 04:10:35 INFO - 'HOME': '/home/cltbld', 04:10:35 INFO - 'LANG': 'en_US.UTF-8', 04:10:35 INFO - 'LANGUAGE': 'en_US:en', 04:10:35 INFO - 'LOGNAME': 'cltbld', 04:10:35 INFO - 'MAIL': '/var/mail/cltbld', 04:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:35 INFO - 'MOZ_NO_REMOTE': '1', 04:10:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:35 INFO - 'NO_EM_RESTART': '1', 04:10:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:35 INFO - 'PWD': '/builds/slave/test', 04:10:35 INFO - 'SHELL': '/bin/bash', 04:10:35 INFO - 'SHLVL': '1', 04:10:35 INFO - 'TERM': 'linux', 04:10:35 INFO - 'TMOUT': '86400', 04:10:35 INFO - 'USER': 'cltbld', 04:10:35 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', 04:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:35 INFO - '_': '/tools/buildbot/bin/python'} 04:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:10:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:10:37 INFO - Installing collected packages: mozsystemmonitor 04:10:37 INFO - Running setup.py install for mozsystemmonitor 04:10:37 INFO - Successfully installed mozsystemmonitor 04:10:37 INFO - Cleaning up... 04:10:37 INFO - Return code: 0 04:10:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:10: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')]} 04:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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')]} 04:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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 0x7f7b98518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', '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 04:10: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 04:10: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 04:10:37 INFO - Using env: {'DISPLAY': ':0', 04:10:37 INFO - 'HOME': '/home/cltbld', 04:10:37 INFO - 'LANG': 'en_US.UTF-8', 04:10:37 INFO - 'LANGUAGE': 'en_US:en', 04:10:37 INFO - 'LOGNAME': 'cltbld', 04:10:37 INFO - 'MAIL': '/var/mail/cltbld', 04:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:37 INFO - 'MOZ_NO_REMOTE': '1', 04:10:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:37 INFO - 'NO_EM_RESTART': '1', 04:10:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:37 INFO - 'PWD': '/builds/slave/test', 04:10:37 INFO - 'SHELL': '/bin/bash', 04:10:37 INFO - 'SHLVL': '1', 04:10:37 INFO - 'TERM': 'linux', 04:10:37 INFO - 'TMOUT': '86400', 04:10:37 INFO - 'USER': 'cltbld', 04:10:37 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', 04:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:37 INFO - '_': '/tools/buildbot/bin/python'} 04:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:37 INFO - Downloading/unpacking jsonschema==2.5.1 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:10:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10:40 INFO - Downloading functools32-3.2.3-2.tar.gz 04:10:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:10:40 INFO - warning: no files found matching '*.txt' 04:10:40 INFO - no previously-included directories found matching 'build' 04:10:40 INFO - no previously-included directories found matching 'dist' 04:10:40 INFO - no previously-included directories found matching '.git*' 04:10:40 INFO - Installing collected packages: jsonschema, functools32 04:10:40 INFO - Running setup.py install for functools32 04:10:40 INFO - warning: no files found matching '*.txt' 04:10:40 INFO - no previously-included directories found matching 'build' 04:10:40 INFO - no previously-included directories found matching 'dist' 04:10:40 INFO - no previously-included directories found matching '.git*' 04:10:40 INFO - Successfully installed jsonschema functools32 04:10:40 INFO - Cleaning up... 04:10:40 INFO - Return code: 0 04:10:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:10: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')]} 04:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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')]} 04:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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 0x7f7b98518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', '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 04:10: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 04:10: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 04:10:40 INFO - Using env: {'DISPLAY': ':0', 04:10:40 INFO - 'HOME': '/home/cltbld', 04:10:40 INFO - 'LANG': 'en_US.UTF-8', 04:10:40 INFO - 'LANGUAGE': 'en_US:en', 04:10:40 INFO - 'LOGNAME': 'cltbld', 04:10:40 INFO - 'MAIL': '/var/mail/cltbld', 04:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:40 INFO - 'MOZ_NO_REMOTE': '1', 04:10:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:40 INFO - 'NO_EM_RESTART': '1', 04:10:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:40 INFO - 'PWD': '/builds/slave/test', 04:10:40 INFO - 'SHELL': '/bin/bash', 04:10:40 INFO - 'SHLVL': '1', 04:10:40 INFO - 'TERM': 'linux', 04:10:40 INFO - 'TMOUT': '86400', 04:10:40 INFO - 'USER': 'cltbld', 04:10:40 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', 04:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:40 INFO - '_': '/tools/buildbot/bin/python'} 04:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:40 INFO - Downloading/unpacking blobuploader==1.2.4 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10:42 INFO - Downloading blobuploader-1.2.4.tar.gz 04:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:10:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:10:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10:43 INFO - Downloading docopt-0.6.1.tar.gz 04:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:10:43 INFO - Installing collected packages: blobuploader, requests, docopt 04:10:43 INFO - Running setup.py install for blobuploader 04:10:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:10:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:10:43 INFO - Running setup.py install for requests 04:10:43 INFO - Running setup.py install for docopt 04:10:43 INFO - Successfully installed blobuploader requests docopt 04:10:43 INFO - Cleaning up... 04:10:43 INFO - Return code: 0 04:10:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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 0x7f7b98518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', '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 04:10: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 04:10: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 04:10:43 INFO - Using env: {'DISPLAY': ':0', 04:10:43 INFO - 'HOME': '/home/cltbld', 04:10:43 INFO - 'LANG': 'en_US.UTF-8', 04:10:43 INFO - 'LANGUAGE': 'en_US:en', 04:10:43 INFO - 'LOGNAME': 'cltbld', 04:10:43 INFO - 'MAIL': '/var/mail/cltbld', 04:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:43 INFO - 'MOZ_NO_REMOTE': '1', 04:10:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:43 INFO - 'NO_EM_RESTART': '1', 04:10:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:43 INFO - 'PWD': '/builds/slave/test', 04:10:43 INFO - 'SHELL': '/bin/bash', 04:10:43 INFO - 'SHLVL': '1', 04:10:43 INFO - 'TERM': 'linux', 04:10:43 INFO - 'TMOUT': '86400', 04:10:43 INFO - 'USER': 'cltbld', 04:10:43 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', 04:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:43 INFO - '_': '/tools/buildbot/bin/python'} 04:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:10:44 INFO - Running setup.py (path:/tmp/pip-VZjK1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:10:44 INFO - Running setup.py (path:/tmp/pip-yAfPDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:10:44 INFO - Running setup.py (path:/tmp/pip-AiytUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:10:44 INFO - Running setup.py (path:/tmp/pip-8qvk2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:10:44 INFO - Running setup.py (path:/tmp/pip-NJlh3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:10:44 INFO - Running setup.py (path:/tmp/pip-9tmbnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:10:44 INFO - Running setup.py (path:/tmp/pip-2kpHkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:10:44 INFO - Running setup.py (path:/tmp/pip-jggref-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:10:44 INFO - Running setup.py (path:/tmp/pip-mLdrnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:10:44 INFO - Running setup.py (path:/tmp/pip-15HJyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:10:44 INFO - Running setup.py (path:/tmp/pip-s2ywig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:10:44 INFO - Running setup.py (path:/tmp/pip-gX2JdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:10:44 INFO - Running setup.py (path:/tmp/pip-1xBPeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:10:44 INFO - Running setup.py (path:/tmp/pip-3jJHkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:45 INFO - Running setup.py (path:/tmp/pip-eEkifp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:10:45 INFO - Running setup.py (path:/tmp/pip-GLVITL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:10:45 INFO - Running setup.py (path:/tmp/pip-pXr0OC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:10:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:10:45 INFO - Running setup.py install for manifestparser 04:10:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:10:45 INFO - Running setup.py install for mozcrash 04:10:45 INFO - Running setup.py install for mozdebug 04:10:45 INFO - Running setup.py install for mozdevice 04:10:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:10:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:10:45 INFO - Running setup.py install for mozfile 04:10:45 INFO - Running setup.py install for mozhttpd 04:10:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:10:45 INFO - Running setup.py install for mozinfo 04:10:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:10:45 INFO - Running setup.py install for mozInstall 04:10:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:10:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:10:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:10:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:10:46 INFO - Running setup.py install for mozleak 04:10:46 INFO - Running setup.py install for mozlog 04:10:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:10:46 INFO - Running setup.py install for moznetwork 04:10:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:10:46 INFO - Running setup.py install for mozprocess 04:10:46 INFO - Running setup.py install for mozprofile 04:10:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:10:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:10:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:10:46 INFO - Running setup.py install for mozrunner 04:10:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:10:46 INFO - Running setup.py install for mozscreenshot 04:10:46 INFO - Running setup.py install for moztest 04:10:46 INFO - Running setup.py install for mozversion 04:10:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:10:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:10:46 INFO - Cleaning up... 04:10:47 INFO - Return code: 0 04:10:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:47 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 0x7f7b98518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', '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 04:10:47 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 04:10:47 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 04:10:47 INFO - Using env: {'DISPLAY': ':0', 04:10:47 INFO - 'HOME': '/home/cltbld', 04:10:47 INFO - 'LANG': 'en_US.UTF-8', 04:10:47 INFO - 'LANGUAGE': 'en_US:en', 04:10:47 INFO - 'LOGNAME': 'cltbld', 04:10:47 INFO - 'MAIL': '/var/mail/cltbld', 04:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:47 INFO - 'MOZ_NO_REMOTE': '1', 04:10:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:47 INFO - 'NO_EM_RESTART': '1', 04:10:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:47 INFO - 'PWD': '/builds/slave/test', 04:10:47 INFO - 'SHELL': '/bin/bash', 04:10:47 INFO - 'SHLVL': '1', 04:10:47 INFO - 'TERM': 'linux', 04:10:47 INFO - 'TMOUT': '86400', 04:10:47 INFO - 'USER': 'cltbld', 04:10:47 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', 04:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:47 INFO - '_': '/tools/buildbot/bin/python'} 04:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:10:47 INFO - Running setup.py (path:/tmp/pip-vnfEN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:10: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)) 04:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:10:47 INFO - Running setup.py (path:/tmp/pip-AcRBE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:10: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)) 04:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:10:47 INFO - Running setup.py (path:/tmp/pip-B_7mZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:10: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)) 04:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:10:47 INFO - Running setup.py (path:/tmp/pip-zOW1mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:10: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)) 04:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:10:47 INFO - Running setup.py (path:/tmp/pip-TgWM3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:10: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)) 04:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:10:47 INFO - Running setup.py (path:/tmp/pip-ayryw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:10: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)) 04:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:10:47 INFO - Running setup.py (path:/tmp/pip-X8SrL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:10: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)) 04:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:10:47 INFO - Running setup.py (path:/tmp/pip-QuOzF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:10: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)) 04:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:10:47 INFO - Running setup.py (path:/tmp/pip-7mlkv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:10: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)) 04:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:10:47 INFO - Running setup.py (path:/tmp/pip-6r2wCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:10: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)) 04:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:10:47 INFO - Running setup.py (path:/tmp/pip-sFybAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:10:48 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)) 04:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:10:48 INFO - Running setup.py (path:/tmp/pip-m9hkR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:10:48 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)) 04:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:10:48 INFO - Running setup.py (path:/tmp/pip-HwvL0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:10:48 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)) 04:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:10:48 INFO - Running setup.py (path:/tmp/pip-PEuiA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:10:48 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)) 04:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:10:48 INFO - Running setup.py (path:/tmp/pip-DROiqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:10: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)) 04:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:10:48 INFO - Running setup.py (path:/tmp/pip-BIR_AY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:10: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)) 04:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:10:48 INFO - Running setup.py (path:/tmp/pip-2FbBdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:10: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)) 04:10: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)) 04:10: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)) 04:10: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)) 04:10: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)) 04:10: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)) 04:10:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10:50 INFO - Downloading blessings-1.6.tar.gz 04:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:10:50 INFO - Installing collected packages: blessings 04:10:50 INFO - Running setup.py install for blessings 04:10:50 INFO - Successfully installed blessings 04:10:50 INFO - Cleaning up... 04:10:50 INFO - Return code: 0 04:10:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:10:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:10:50 INFO - Reading from file tmpfile_stdout 04:10:50 INFO - Current package versions: 04:10:50 INFO - argparse == 1.2.1 04:10:50 INFO - blessings == 1.6 04:10:50 INFO - blobuploader == 1.2.4 04:10:50 INFO - docopt == 0.6.1 04:10:50 INFO - functools32 == 3.2.3-2 04:10:50 INFO - jsonschema == 2.5.1 04:10:50 INFO - manifestparser == 1.1 04:10:50 INFO - mozInstall == 1.12 04:10:50 INFO - mozcrash == 0.17 04:10:50 INFO - mozdebug == 0.1 04:10:50 INFO - mozdevice == 0.48 04:10:50 INFO - mozfile == 1.2 04:10:50 INFO - mozhttpd == 0.7 04:10:50 INFO - mozinfo == 0.9 04:10:50 INFO - mozleak == 0.1 04:10:50 INFO - mozlog == 3.2 04:10:50 INFO - moznetwork == 0.27 04:10:50 INFO - mozprocess == 0.22 04:10:50 INFO - mozprofile == 0.28 04:10:50 INFO - mozrunner == 6.11 04:10:50 INFO - mozscreenshot == 0.1 04:10:50 INFO - mozsystemmonitor == 0.3 04:10:50 INFO - moztest == 0.7 04:10:50 INFO - mozversion == 1.4 04:10:50 INFO - psutil == 3.1.1 04:10:50 INFO - requests == 1.2.3 04:10:50 INFO - wsgiref == 0.1.2 04:10:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:10: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')]} 04:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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')]} 04:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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 0x7f7b98518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', '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 04:10: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 04:10: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 04:10:50 INFO - Using env: {'DISPLAY': ':0', 04:10:50 INFO - 'HOME': '/home/cltbld', 04:10:50 INFO - 'LANG': 'en_US.UTF-8', 04:10:50 INFO - 'LANGUAGE': 'en_US:en', 04:10:50 INFO - 'LOGNAME': 'cltbld', 04:10:50 INFO - 'MAIL': '/var/mail/cltbld', 04:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:50 INFO - 'MOZ_NO_REMOTE': '1', 04:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:50 INFO - 'NO_EM_RESTART': '1', 04:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:50 INFO - 'PWD': '/builds/slave/test', 04:10:50 INFO - 'SHELL': '/bin/bash', 04:10:50 INFO - 'SHLVL': '1', 04:10:50 INFO - 'TERM': 'linux', 04:10:50 INFO - 'TMOUT': '86400', 04:10:50 INFO - 'USER': 'cltbld', 04:10:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', 04:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:50 INFO - '_': '/tools/buildbot/bin/python'} 04:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10: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)) 04:10: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)) 04:10: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)) 04:10: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)) 04:10: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)) 04:10: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)) 04:10: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)) 04:10: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)) 04:10: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)) 04:10: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)) 04:10: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)) 04:10:50 INFO - Cleaning up... 04:10:51 INFO - Return code: 0 04:10:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:51 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 0x7f7b98518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', '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 04:10:51 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 04:10:51 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 04:10:51 INFO - Using env: {'DISPLAY': ':0', 04:10:51 INFO - 'HOME': '/home/cltbld', 04:10:51 INFO - 'LANG': 'en_US.UTF-8', 04:10:51 INFO - 'LANGUAGE': 'en_US:en', 04:10:51 INFO - 'LOGNAME': 'cltbld', 04:10:51 INFO - 'MAIL': '/var/mail/cltbld', 04:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:51 INFO - 'MOZ_NO_REMOTE': '1', 04:10:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:51 INFO - 'NO_EM_RESTART': '1', 04:10:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:51 INFO - 'PWD': '/builds/slave/test', 04:10:51 INFO - 'SHELL': '/bin/bash', 04:10:51 INFO - 'SHLVL': '1', 04:10:51 INFO - 'TERM': 'linux', 04:10:51 INFO - 'TMOUT': '86400', 04:10:51 INFO - 'USER': 'cltbld', 04:10:51 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', 04:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:51 INFO - '_': '/tools/buildbot/bin/python'} 04:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:10:51 INFO - Cleaning up... 04:10:51 INFO - Return code: 0 04:10:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:51 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 0x7f7b98518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22fb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', '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 04:10:51 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 04:10:51 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 04:10:51 INFO - Using env: {'DISPLAY': ':0', 04:10:51 INFO - 'HOME': '/home/cltbld', 04:10:51 INFO - 'LANG': 'en_US.UTF-8', 04:10:51 INFO - 'LANGUAGE': 'en_US:en', 04:10:51 INFO - 'LOGNAME': 'cltbld', 04:10:51 INFO - 'MAIL': '/var/mail/cltbld', 04:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:51 INFO - 'MOZ_NO_REMOTE': '1', 04:10:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:51 INFO - 'NO_EM_RESTART': '1', 04:10:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:51 INFO - 'PWD': '/builds/slave/test', 04:10:51 INFO - 'SHELL': '/bin/bash', 04:10:51 INFO - 'SHLVL': '1', 04:10:51 INFO - 'TERM': 'linux', 04:10:51 INFO - 'TMOUT': '86400', 04:10:51 INFO - 'USER': 'cltbld', 04:10:51 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', 04:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:51 INFO - '_': '/tools/buildbot/bin/python'} 04:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:51 INFO - Downloading/unpacking flake8 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:10:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:10:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10: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 04:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:10:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:10:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:10:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:10:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:10:54 INFO - no previously-included directories found matching 'docs/_build' 04:10:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:10:54 INFO - Running setup.py install for pep8 04:10:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:10:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:10:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:10:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:10:54 INFO - no previously-included directories found matching 'docs/_build' 04:10:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:10:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:10:54 INFO - Cleaning up... 04:10:54 INFO - Return code: 0 04:10:54 INFO - Running post-action listener: _resource_record_post_action 04:10:54 INFO - Running post-action listener: _start_resource_monitoring 04:10:54 INFO - Starting resource monitoring. 04:10:54 INFO - ##### 04:10:54 INFO - ##### Finished create-virtualenv step (success) 04:10:54 INFO - ##### 04:10:54 INFO - ##### 04:10:54 INFO - ##### Running install step. 04:10:54 INFO - ##### 04:10:54 INFO - Running pre-action listener: _resource_record_pre_action 04:10:54 INFO - Running main action method: install 04:10:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:10:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:10:54 INFO - Reading from file tmpfile_stdout 04:10:54 INFO - Detecting whether we're running mozinstall >=1.0... 04:10:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:10:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:10:54 INFO - Reading from file tmpfile_stdout 04:10:54 INFO - Output received: 04:10:54 INFO - Usage: mozinstall [options] installer 04:10:54 INFO - Options: 04:10:54 INFO - -h, --help show this help message and exit 04:10:54 INFO - -d DEST, --destination=DEST 04:10:54 INFO - Directory to install application into. [default: 04:10:54 INFO - "/builds/slave/test"] 04:10:54 INFO - --app=APP Application being installed. [default: firefox] 04:10:54 INFO - mkdir: /builds/slave/test/build/application 04:10: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'] 04:10: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 04:11:10 INFO - Reading from file tmpfile_stdout 04:11:10 INFO - Output received: 04:11:10 INFO - /builds/slave/test/build/application/firefox/firefox 04:11:10 INFO - Running post-action listener: _resource_record_post_action 04:11:10 INFO - ##### 04:11:10 INFO - ##### Finished install step (success) 04:11:10 INFO - ##### 04:11:10 INFO - ##### 04:11:10 INFO - ##### Running run-tests step. 04:11:10 INFO - ##### 04:11:10 INFO - Running pre-action listener: _resource_record_pre_action 04:11:10 INFO - Running main action method: run_tests 04:11:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:11:10 INFO - Python 2.7.3 04:11:10 INFO - Return code: 0 04:11:10 INFO - grabbing minidump binary from tooltool 04:11:10 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')]} 04:11:10 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 0x238a1c0>, '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 0x238b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:11:10 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 04:11:10 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 04:11:10 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 04:11:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:11:10 INFO - Return code: 0 04:11:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:11:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:11:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:11:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:11:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:11:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:11:11 INFO - Return code: 0 04:11:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 04:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 04:11:11 INFO - Using env: {'DISPLAY': ':0', 04:11:11 INFO - 'HOME': '/home/cltbld', 04:11:11 INFO - 'LANG': 'en_US.UTF-8', 04:11:11 INFO - 'LANGUAGE': 'en_US:en', 04:11:11 INFO - 'LOGNAME': 'cltbld', 04:11:11 INFO - 'MAIL': '/var/mail/cltbld', 04:11:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:11:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:11 INFO - 'MOZ_NO_REMOTE': '1', 04:11:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:11 INFO - 'NO_EM_RESTART': '1', 04:11:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:11 INFO - 'PWD': '/builds/slave/test', 04:11:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:11:11 INFO - 'SHELL': '/bin/bash', 04:11:11 INFO - 'SHLVL': '1', 04:11:11 INFO - 'TERM': 'linux', 04:11:11 INFO - 'TMOUT': '86400', 04:11:11 INFO - 'USER': 'cltbld', 04:11:11 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108', 04:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:11 INFO - '_': '/tools/buildbot/bin/python'} 04:11:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 04:11:11 INFO - mozversion application_buildid: 20160609025931 04:11:11 INFO - mozversion application_changeset: cb493102af8a50946ac601a86cc3d076703faa57 04:11:11 INFO - mozversion application_display_name: Nightly 04:11:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:11:11 INFO - mozversion application_name: Firefox 04:11:11 INFO - mozversion application_remotingname: firefox 04:11:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:11:11 INFO - mozversion application_vendor: Mozilla 04:11:11 INFO - mozversion application_version: 50.0a1 04:11:11 INFO - mozversion platform_buildid: 20160609025931 04:11:11 INFO - mozversion platform_changeset: cb493102af8a50946ac601a86cc3d076703faa57 04:11:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:11:11 INFO - mozversion platform_version: 50.0a1 04:11:11 INFO - using testdate: 1465470671 04:11:11 INFO - actual date: 1465470671 04:11:11 INFO - starting webserver on 'localhost:39745' 04:11:11 INFO - SUITE-START | Running 2 tests 04:11:11 INFO - TEST-START | dromaeo_css 04:11:11 INFO - operating with platform_type : linux_ 04:11:11 INFO - Initialising browser for dromaeo_css test... 04:11:11 INFO - TEST-INFO | started process 11745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCXhizS/profile http://localhost:39745/getInfo.html) 04:11:19 INFO - PROCESS | 11745 | __metrics Screen width/height:1600/1200 04:11:19 INFO - PROCESS | 11745 | colorDepth:24 04:11:19 INFO - PROCESS | 11745 | Browser inner width/height: 1024/697 04:11:19 INFO - PROCESS | 11745 | __metrics 04:11:20 ERROR - PROCESS | 11745 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:11:21 INFO - TEST-INFO | 11745: exit 0 04:11:21 INFO - Browser initialized. 04:11:21 INFO - Running cycle 1/1 for dromaeo_css test... 04:11:21 INFO - TEST-INFO | started process 11864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCXhizS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:11:33 INFO - PROCESS | 11864 | RSS: Main: 185610240 04:11:33 INFO - PROCESS | 11864 | 04:12:23 INFO - PROCESS | 11864 | 1465470743095 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] 04:14:34 INFO - PROCESS | 11864 | Cycle 1(1): loaded http://localhost:39745/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39745/tests/dromaeo/cssquery-ext.html) 04:14:35 INFO - PROCESS | 11864 | RSS: Main: 188796928 04:14:35 INFO - PROCESS | 11864 | 04:17:37 INFO - PROCESS | 11864 | Cycle 1(1): loaded http://localhost:39745/tests/dromaeo/cssquery-ext.html (next: http://localhost:39745/tests/dromaeo/cssquery-jquery.html) 04:17:38 INFO - PROCESS | 11864 | RSS: Main: 186777600 04:17:38 INFO - PROCESS | 11864 | 04:20:40 INFO - PROCESS | 11864 | Cycle 1(1): loaded http://localhost:39745/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39745/tests/dromaeo/cssquery-mootools.html) 04:20:40 INFO - PROCESS | 11864 | RSS: Main: 188821504 04:20:40 INFO - PROCESS | 11864 | 04:23:42 INFO - PROCESS | 11864 | Cycle 1(1): loaded http://localhost:39745/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39745/tests/dromaeo/cssquery-prototype.html) 04:23:43 INFO - PROCESS | 11864 | RSS: Main: 185749504 04:23:43 INFO - PROCESS | 11864 | 04:26:46 INFO - PROCESS | 11864 | Cycle 1(1): loaded http://localhost:39745/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39745/tests/dromaeo/cssquery-yui.html) 04:26:46 INFO - PROCESS | 11864 | RSS: Main: 188096512 04:26:46 INFO - PROCESS | 11864 | 04:29:48 INFO - PROCESS | 11864 | Cycle 1(1): loaded http://localhost:39745/tests/dromaeo/cssquery-yui.html (next: http://localhost:39745/tests/dromaeo/cssquery-dojo.html) 04:29:49 INFO - PROCESS | 11864 | RSS: Main: 189403136 04:29:49 INFO - PROCESS | 11864 | 04:29:49 INFO - PROCESS | 11864 | __start_tp_report 04:29:49 INFO - PROCESS | 11864 | _x_x_mozilla_page_load 04:29:49 INFO - PROCESS | 11864 | _x_x_mozilla_page_load_details 04:29:49 INFO - PROCESS | 11864 | |i|pagename|runs| 04:29:49 INFO - PROCESS | 11864 | |0;dojo.html;2568.7045989711182;2642.0752736542213;2642.6696662917134;2657.7873770098395;2665.5735082386823;4550.863474095774;4634.119517291717;4672.789724462399;4737.218358970775;4770.522947705228;4562.201614717428;4608.055348653526;4610.124076425477;4625.098105869357;4644.6748727589;4272.401863739079;4293.9999999999845;4371.825126994916;4404.163208990281;4407.184670835905;4102.690436372772;4381.189479946204;4400.7579583122915;4405.757683327416;4428.1807865544815;4237.512686041114;4262.211490874198;4272.060146767706;4312.202242585116;4351.608355248011;4277.871663850089;4287.421198138242;4298.527162012208;4301.548337424557;4341.02326976431;4289.24938135825;4294.613484786384;4303.849365272201;4309.288967320388;4335.306350983859;4596.471405788344;4625.468071171825;4634.189016922025;4634.814607415699;4681.5318468153255;4934.654574179809;4959;4966.354373931365;4971.204607262821;5019.5231453012275;4859.07677541266;4955.083309587738;4977.352944117241;4985.177445721488;5031.220160875034;4642;4676.181668208084;4676.625869930397;4687.1328804171335;4711.246200607886;5160.612954028463;5162.199859021857;5177.534021938043;5184.662996905189;5196.298499702568;4747.335373047776;4844.079624871334;4935.333729946483;4935.827246046371;4992.326035985096;4993.775280112403;5035.924461133086;5046.369203849519;5089.51649593288;5105.591552675777;4858.076965376567;4886.584640305614;4905.828296009694;4907.2393778964315;4959.752012399365;4809.95190048102;4900.607951363882;4948.4061912570005;4959.578435832923;5010.774515146827;4169.124483858363;4217.135487225111;4217.472815898012;4220.725652832556;4227.196832601796;3699.6300369962787;3701.5002974598624;3708.8516459341863;3733.701303895682;3742.681872040907;4336.739795612273;4388.253996820548;4389.846355377546;4395.208862404734;4449.466064072332;5042.369703787027;5092.643514953992;5093.617978651616;5104.744762761847;5120.539151476385;4417.60241578253;4419.756913369795;4431.401760762255;4451.443569553806;4482.5069242383315;4383.3863259143745;4495.527969563214;4513.323001549794;4538.591526762541;4549.363089167519;4780.4741478437345;4782.426108866958;4792.760361981887;4815.759212039314;4817.614590832725;5056.165732654218;5068.873278167928;5069.898602028013;5070.949290507047;5081.7713202905215;4634.559716826896;4740.9051818962735;4813.7352445615825;4822.180229361087;4831.9275210871165;4961.206207006861;4974.129527332775;4980.302757613865;4982.128127577587;5026.170681837602;5050.72221027847;5056.64603477753;5057.671251368649;5058.570021548209;5116.9744151279;4732.19552676039;4787.904241915073;4901.240307752304;4907.263910413324;4922.556969872729;4830.227163653799;4860.17377045896;4865.56209941107;4903.901921961612;4926.753662316942;4810;4843.975780121218;4847.127517046824;4849.102915960559;4870.025994800983;4811.27830825379;4881.072596206709;4936.7284799336385;4940.75296235194;4949.109160351171;4825.179719447772;4826.855194344175;4845.53967373099;4846.733429661403;4884.023195361013 04:29:49 INFO - PROCESS | 11864 | |1;ext.html;567.4750855458701;573.9942600573993;585.3122580967364;588.0092044904336;599.5952731905962;35443.82278088609;39571.81284561468;39580;39890.8005459973;39907.60092399075;38931.22137557247;39030;39312;39547;39550;7699.461037727361;7837.882431763528;7847.411444141684;7848.4113691473085;7861.449698521106;7787.221277872196;7815.335696465779;7821.178776228471;7822.569758663271;7840.803979900491;7798.883016754753;7834.608269586526;7868.6852525899185;7879.251471110236;7883.211678832128;7805.804854878645;7842.333401660866;7850.725224617111;7868.370530357558;7881.487703299267;7730.729424470116;7768.53388796674;7792.688292468351;7803.375729941591;7818.921810781876;37591.436128458095;37844.43233351502;37921.81039094814;38025.42961855575;38029.80985095084;3020.275133967854;3273;3656.725745569093;3720.572134204574;3744.662980331756;29430.411391772046;30178.84910575455;30351.696483035106;30367.392652146835;30409.391812163853;2911.7525010374143;2959.1122663200954;3038.6353637563634;3049.862756175977;3081.2142903559447;244603;244826;245636;245687;245731;27883.860580696968;28854.855725721656;28897.711022889922;53112.54768440039;53721;33975.83012084973;34322.31355372879;34367.312653747285;34392.82803585966;34534;13668.863311366958;13688.65778355549;13803.2408217547;13847.930760346133;13872.861271387359;11150.386728729998;11196.776064478829;11278.492467838967;11283.435828208556;11304.830427543593;7860.6855725771475;7904.565248911365;7997.160298168725;8012.318952888953;8040.678372865137;3122.9219269518444;3124.218945263684;3151.385479831411;3163.4622114240633;3193.5209718542405;851.3784936996028;856.5117882806865;890.7817584691792;929.7117893453051;960.5869476125193;27821.304467388072;27897.860510697315;28347.149585512467;28674.569881451796;28702.569461458093;941.6892425499568;954.2985905359556;975.5268694683073;1007.808516381885;1056.799208150449;14515.85484145145;14827.332770025374;15070.698586028437;15214;15353.539393818204;385358;385650;387050;389440;390246;50354.24468632974;50687.746561266955;50888.23667644988;50910.74544627253;50967.74516127395;1176.2472017908544;1198.2271434924426;1205.2045649871043;1219.7192947405367;1220.1885745978825;26763.33091672724;27361;27424.45151097007;27524.174274770987;27770.5834412488;43019;43228.351574727036;43560.78219608882;43654.34518482162;43893.561064390226;325360;325742;327172;327491;328193;25376.238712838644;25530.361740956625;25847.741522585286;25996.22011339663;26060.34849128787;42268.788656056524;43138;43341.3498797512;43378.783106084265;43581.564184357754;36734.57144999668;37068;37299.254014920094;37405.2518949614;37505.437418439295;35990.28019439649;36128.819355903055;36155.45766813447;36225.63774362328;36811.44782828313;33698.66301336955;35725.64274357223;35952.82023589865;36798.264034719694;39661.80169099136;31820.204494886886;32453.241509152955;32644.020679379657;33018.834905825315;33166.17084572905;24878;24944;25445.87277063603;25782.742172578033;25948.74051259463 04:29:49 INFO - PROCESS | 11864 | |2;jquery.html;346.5667915106117;349.58224921219147;353.4927379210831;362.64641974075295;367.8951498822836;15601.453949111783;16209.432669856542;16866.915665421686;16898.225686302947;16945.491635250946;15097.169655668933;16032.83967160328;16099.758503622426;16101.275442605081;16130.354785808553;4554.134714404261;4927.876803079916;4930.161872481669;4935.087008903364;4947.579455746248;3693.9445908311395;4903.558679718824;5505.752241149138;5804.245448091763;5806.535477161838;5816.214811000525;5820.35976042635;5836.533077353823;5838.41615838417;5856.707164641773;5593.188987596796;5814.040683287252;5815.79644712433;5819.33077696064;5830.183774271605;4933.358663373774;5062.1900495920845;5078.695278283315;5082.33929589151;5093.694378337274;19985.400437986882;20512.897435512878;20615.5876882463;20743.170273189204;20764.06561704727;1978.9901050494655;1991.6315481635943;2098.412444515538;2233.3300009996938;2299.0688771047753;13318.933405333008;13452.529161479399;13540.255285959269;13625.659358516017;13768.105073170313;1622.3105180298444;1688.9950479464699;1743.041327270009;1805.7923338816072;1812.5831058856536;43473.56526434727;66361.33638663648;68057.65971170162;68332.3166768336;68450.65774671144;8070.435069545076;8676.6529338827;8723.345749068845;8994.955025224963;9072.727818165466;11866.940665296619;11962.162648614514;11997;12018.4591693374;12036.939815300868;7090.645467726593;7105.827538456097;7160.677769500385;7241.927580724126;7255.165655949528;6928.237893831674;6991.30086991307;7002.544834585736;7082.362587367162;7185.748498802517;3700.3709369407266;3715.405535114369;3727.8881633551036;3785;3833.195029043932;1658.4742037325689;1689.662067586463;1766.5760217547695;1827.6984297590748;1829.6432195721973;753.3859904178078;773.0414286285079;803.5781214862244;814.6619153051536;856.3491746272878;16170.353185872433;16307.918460407622;16508.68878357031;16616.916915415586;16638.58403539897;857.100044952797;870.4777133719717;914.6021480655936;938.3290946972811;949.4540639132526;9358.57886395114;9442.339036267394;9501.954784973648;9557.665481708107;9646.855297170549;359590;362031;393801;400375;404938;80979.59510202412;83957;86139;87514.56242718745;87572;905.8550631898864;947.7062110745553;965.3628605120587;978.6770365779275;985.8176237395961;15133.470328538448;15234;15473.84526154769;15648.530544083696;15709.057456552644;35699.46450803188;36147.819260903525;36461.27077458489;37814.810925945196;37817.432738508396;50151.49848501468;50612.49387506225;50838.23742643937;50850.491495086055;51395.48604514057;7689.538627682357;7724.266194711493;7729.111152217567;7754.263344982218;7921.128675845767;9045.909540904508;11828.349440780496;11868.76262474763;11913.16607837443;12165.75668486643;9627.133557979536;10135.898641013791;10298.176145908159;10315.535800888827;10839.241253112206;10084;10777.51501182433;10781.299215550964;10879.891201088205;10884.510197040994;10318.380897146195;10622.946885265834;10777.407242601732;10871.945640271748;10898.07366373867;7683.462157648911;7911.327537159175;7918.535071011881;7974.641141148546;8018.639161237875;10327.32872363294;10473;10506.789864202521;10577.100946419641;10662.466876656292 04:29:49 INFO - PROCESS | 11864 | |3;mootools.html;1344.126317893369;1364.2360278244184;1443.2062365698862;1663.550841272857;1683.107952785023;6383.39357761012;6980;7098.467614928882;7516.736914208004;7536.020317358736;7078.292170782919;7259.7822065338;7357.484976051678;7360.300771426706;7378.446616503757;2135.967960480598;2163.275302773565;2163.9026243819067;2165.5344101018277;2167.5339801942578;2045.9386218413472;2122.490602255455;2135.2206444647745;2154.3859999900033;2160.5138843760187;2141.507453285745;2151.8816465094415;2156.6872803443493;2161;2177.9891100544473;2110.2719561751173;2143.3141394753684;2143.7641859395453;2146.957060858774;2149.054416056938;2070.234013415031;2095.1409921932086;2127.4362293992103;2150.3441450357636;2150.9784902150936;7325;7340.889886651705;7403.666834992438;7437;7454.36637885775;4202.348635961431;4306.310990241577;4312.827486900552;4326.718763280408;4338.828516300613;2731.508328500869;2773.5700966350046;2789.860506974643;2796.49663060649;2839.5456726923594;833.6748668019477;839.9962045355802;856.9742907712779;859.6776208921655;861.5003298087157;9685.41887486746;9767.365121267096;9856.556454959544;9876.703698888972;9888.505574721235;3840;3893.2992061429213;3972.940405893914;3985.083430810872;3986.5216174059296;8436.493810371398;8443.957780211182;8447.493150410872;8450.19723126302;8451;4285.764282964405;4315.78421078951;4318.157959197989;4326.069894972533;4344.23975804233;3469.115375579211;3929.5677475477673;3977.980110099431;4001.079751657077;4053.8175782089875;3409.2499650076943;3414.4878268259463;3459.39460594395;3508.4211105167874;3525.7884526927955;1102.399192440122;1107.2747350485445;1120.7814476177068;1125.8480105185859;1137.2721458266717;705.530822003362;813.7314686153674;830.5681045856121;834.7871292820292;847.3221422861686;5023.673461225008;5030.170021946411;5065.062963351792;5083.694978301313;5146.202338637442;381.6755757606068;402.1394216376956;408.7343226902537;414.1530569984389;418.7215501691341;3364.7308215342714;3381.8309084546167;3389.49157626358;3464.6535346465657;3489.860405583748;8720.825583488295;8775.122487751301;9069.77325566866;9074.86387704185;9095.772605684911;8970.237529809909;8976.281897448189;9005.279577633904;9033.954830225939;9041.276697864156;6983.546069505466;6995.650217489105;7055.435565154775;7074.045003924404;7111.075560177143;5184.844454666366;5192.818251361185;5194.168932970707;5195.246689230116;5204.063268611686;8274.379421543528;8289.088200297841;8505.489670619783;8560.48637081777;8578.571071446278;8449.704260350858;8477.406581539233;8496.787580310542;8500.574971251537;8529.104444033288;5645.887082258414;6234.906476402948;6359.713812878339;6456.7740129095255;6475.740970361133;7164.641767911479;7212.4951253411755;7228.277172282729;7296.941943418281;7313.926860731324;6340.1123842661145;6577.934220657924;6610.900836487553;6671.099401580725;6728.629925354153;6529.640869752209;6554.80335589933;6574.309697481695;6607.3062328456745;6711.765088221889;5952.285725712942;5989.670568118795;5999.9100013498955;6013.308469525886;6020.759169633341;4259.169461954889;4390.1878152541885;4449.844255451044;4463.486699029523;4488.887777805581;4403.5376285489565;4420.668449866209;4456.821727131008;4511.255642818898;4527.479339875825 04:29:49 INFO - PROCESS | 11864 | |4;prototype.html;286.2528799832437;294.3259934749423;294.53022429225376;299.21456177533975;299.63594233006893;4913.53321434464;4979.975100124494;4983.800647974082;4992.176290911995;5004.049230646175;4932.580730637891;4939.950600493994;4946.851594452163;4954.876128096799;4986.950130498694;3629.510016147826;3761.736678432511;3864.130570621616;3874.8643797467093;3875.4574359589537;3812.6759225465867;3830.9042273943096;3855.7108216883707;3866.8839934802;3883.1262965832743;3855.4409610606585;3869.8839034829;3872.1674839909415;3877.185790983897;3877.5734669186368;3797.145642230476;3810.504634397538;3863.864764733249;3883.184531248427;3883.650471457568;3382.7124694401004;3383.306422183471;3392.355452464024;3411.1301618087477;3412.3687117883023;4852.757362131914;4861.951380486185;4863.221884498499;4871.025794841046;4906.337644417994;4406.493253275882;4421.801018954155;4439.2675208590545;4456.5766252205985;4466.39703640011;4953.752312384367;5187.221916712486;5205.765740541647;5217.973910130463;5224.843254702365;3614.2952124335766;3631.273745250934;3632.7820330779973;3643.508126402928;3658.4512323151475;5489.890202195974;5497.642653227567;5505.311836020457;5516.834494965157;5542.86142846428;3567.3222087803233;3605.6214097519905;3611;3619.4932709420177;3624.8187590620364;3670.6145854685406;3680.227152297994;3687.391580389206;3690.4833323334756;3699.9825048111447;4262.914741705148;4305.354196870432;4318.330658747899;4332.415123958288;4356.934645980313;4981.4769449207315;5184.170532714747;5200.9078093600765;5221.545873439477;5246.868828279247;1275.9617211483671;1287.8068289756611;1291.4059532614915;1297.8312819333614;1301.1672529581076;773.1302284929454;805.2752522729473;807.3621838747324;826.8098337382436;831.0567505880748;4545.568171023748;4633.976830115827;4654.394928659252;4670.594643758467;4692.671512994058;5410.403006556875;5422.6140498180675;5451.48210919962;5453.182022696627;5464.836054918359;4537.321191159226;4649.674522783373;4660.510646382081;4686.484486706459;4711.505291944365;2848.9857550712113;2868.934367255573;2883.1927060423113;2896.768258539312;2906.854657267128;5058.848234552969;5081.517255860761;5107.8723031923755;5116.104681680691;5120.641555091108;5306.92039619406;5531.474509921551;5554.0835762099605;5558.138488534284;5624.578156638268;5107.336046313955;5139.7687104080405;5140.049090918192;5155.690658560498;5159.561437277874;5483.972580137074;5503.559715222693;5504.559635229092;5511.173324001432;5514.779408823602;5131.958239362024;5287.233351164136;5301.151815709468;5304.549113325411;5361.169018801936;5088.244555628302;5105.540501354896;5112.207607820794;5113.667611605234;5120.231965205249;3849.8075096245634;3878.7284890057426;3880.573136954989;3895.2793733159456;3899.161680238762;5334.813281535127;5360.383555891122;5404.78380864761;5434.891302173855;5471.398146203994;5199.844004679866;5241.641261432294;5244.711540865289;5247.4490178530705;5249.055170069271;5243.23973023917;5252.606054545848;5253.973730131325;5274.235235890697;5279.841604751864;4936.580390666833;5132.7433628317685;5160.638755287094;5163.251328557263;5175.948240517547;5045.217991211368;5157.974210128926;5287.206918962186;5299;5301.496357845998;5153.123968925367;5165;5168.276441298146;5189.299444574934;5193.506616871391 04:29:49 INFO - PROCESS | 11864 | |5;yui.html;644.5037321262628;656.9770058047969;660.6993817812896;730.6091241185964;754.2645920227778;12833.42249598768;12913.612591622243;13651.385687644068;13660.726785464285;13677.794833077513;12445.937770311135;12460.626181214579;12550.623481295575;12572.811407828889;13328.46686132556;776.3323541754102;794.9841003179932;795.0935933036343;795.9721409750659;797.18288754027;774.9651265693029;778.1595876453445;785.0187265917604;785.8546168958761;786.5870418030522;830.9293710034624;831.2560258568577;831.6507067031831;831.9417640765149;833.7790485521342;824.2458150792019;825.0676735289145;825.7894236969595;826.3843436639681;827.3422629009922;597.4533302028639;602.1329285828393;603.9667818269993;604.4318340759672;606.2906399512581;11664.416779161093;11688.298702077902;11737.119716021247;11742.706432339175;11755.294682319089;10799.5680172793;10983.835242471368;11367.658970230907;11510.884891151149;11724.062075033977;9368.578413971387;9561.139497445194;9598.472084035375;9605.087516685973;9659.951700241523;3268.542404063433;3350.597928248626;3356.781809182395;3360.4119279126057;3403.081168084603;56669.433305666826;58796.11805822916;59397.40602593962;59400;59584.10623840646;8198.221168988937;8300.584970751439;8522.019967703669;8587.613557389932;8594.216158160647;17184.312627495012;17265.913670431568;17283.481495555152;17316.826831731774;17331.220095095752;6636.701348439332;6644.368784965421;6747.359000894907;6795.082663840417;7130.322619351154;3536.522569453091;3571.8749843755863;3586.946195807065;3588.2464682416985;3738.2710371477847;2710.457908418324;2822.1251412062325;2825.477286701967;2826.886924523037;2829.5472724364004;471.86080106368706;494.03662857428156;496.54318027414865;497.7685376300038;499.54790914222684;517.3791450259704;520.3677531798883;551.7599844067844;598.8921994041027;631.7851930343705;7938.126806051329;8008.919910800934;8070.817221189489;8133.837323253501;8332;527.209186220669;605.6259462905333;628.6950828848005;632.225523733432;642.4860111910547;3704.49989251453;3926.980365098156;3933.1543718100174;3970.920581588352;4007.0583412897945;54152.72923635357;55005;55349.446505535234;55383;87272;51329.743351283;58691.70654146787;62804;69331.65334173296;70005;67873.66063169751;69387.65306173437;71178.2882171182;71213;73666;8197.795055123432;8202.589870506332;8285.4200205985;8340.165983401612;8420.115887831935;43367;44297.55702442934;45245.321320179566;45756.31365529453;45813.31280030736;52564.47435525596;52661.7366913163;54025.45974540204;60056.699716501134;61144;10326.948365258126;10681.46592670379;10880.891191087987;10928.398938058164;10986.505607247533;12918.741625167631;13048.282344471145;13217.537386191438;13280.667983300109;13377.799333009818;11658.125640576822;11750.471228794553;11766.352850593299;11973.521059157885;12244.081693872817;11868.762624747284;11875.940620296844;11964.222325548812;12034.157608967289;12041.939790300992;11999.16005879615;11999.340036298088;12012.279263244232;12021.939890300493;12099.455524501594;10170.440625765357;10323;10450.790984180121;10468.424236667057;10821.891781082088;9294.535273236446;9847.901520984698;9897.851532227167;9944.701658950244;9963.750906227402 04:29:49 INFO - PROCESS | 11864 | __end_tp_report 04:29:49 INFO - PROCESS | 11864 | __start_cc_report 04:29:49 INFO - PROCESS | 11864 | _x_x_mozilla_cycle_collect,405 04:29:49 INFO - PROCESS | 11864 | __end_cc_report 04:29:49 INFO - PROCESS | 11864 | __startTimestamp1465471789173__endTimestamp 04:29:49 INFO - PROCESS | 11864 | 04:29:49 INFO - PROCESS | 11864 | ------- Summary: start ------- 04:29:49 INFO - PROCESS | 11864 | Number of tests: 6 04:29:49 INFO - PROCESS | 11864 | 04:29:49 INFO - PROCESS | 11864 | [#0] dojo.html Cycles:165 Average:4638.17 Median:4792.76 stddev:482.82 (10.1%) stddev-sans-first:456.19 04:29:49 INFO - PROCESS | 11864 | Values: 2568.7 2642.1 2642.7 2657.8 2665.6 4550.9 4634.1 4672.8 4737.2 4770.5 4562.2 4608.1 4610.1 4625.1 4644.7 4272.4 4294.0 4371.8 4404.2 4407.2 4102.7 4381.2 4400.8 4405.8 4428.2 4237.5 4262.2 4272.1 4312.2 4351.6 4277.9 4287.4 4298.5 4301.5 4341.0 4289.2 4294.6 4303.8 4309.3 4335.3 4596.5 4625.5 4634.2 4634.8 4681.5 4934.7 4959.0 4966.4 4971.2 5019.5 4859.1 4955.1 4977.4 4985.2 5031.2 4642.0 4676.2 4676.6 4687.1 4711.2 5160.6 5162.2 5177.5 5184.7 5196.3 4747.3 4844.1 4935.3 4935.8 4992.3 4993.8 5035.9 5046.4 5089.5 5105.6 4858.1 4886.6 4905.8 4907.2 4959.8 4810.0 4900.6 4948.4 4959.6 5010.8 4169.1 4217.1 4217.5 4220.7 4227.2 3699.6 3701.5 3708.9 3733.7 3742.7 4336.7 4388.3 4389.8 4395.2 4449.5 5042.4 5092.6 5093.6 5104.7 5120.5 4417.6 4419.8 4431.4 4451.4 4482.5 4383.4 4495.5 4513.3 4538.6 4549.4 4780.5 4782.4 4792.8 4815.8 4817.6 5056.2 5068.9 5069.9 5070.9 5081.8 4634.6 4740.9 4813.7 4822.2 4831.9 4961.2 4974.1 4980.3 4982.1 5026.2 5050.7 5056.6 5057.7 5058.6 5117.0 4732.2 4787.9 4901.2 4907.3 4922.6 4830.2 4860.2 4865.6 4903.9 4926.8 4810.0 4844.0 4847.1 4849.1 4870.0 4811.3 4881.1 4936.7 4940.8 4949.1 4825.2 4826.9 4845.5 4846.7 4884.0 04:29:49 INFO - PROCESS | 11864 | 04:29:49 INFO - PROCESS | 11864 | [#1] ext.html Cycles:180 Average:46269.27 Median:20195.65 stddev:85796.22 (424.8%) stddev-sans-first:85968.28 04:29:49 INFO - PROCESS | 11864 | Values: 567.5 574.0 585.3 588.0 599.6 35443.8 39571.8 39580.0 39890.8 39907.6 38931.2 39030.0 39312.0 39547.0 39550.0 7699.5 7837.9 7847.4 7848.4 7861.4 7787.2 7815.3 7821.2 7822.6 7840.8 7798.9 7834.6 7868.7 7879.3 7883.2 7805.8 7842.3 7850.7 7868.4 7881.5 7730.7 7768.5 7792.7 7803.4 7818.9 37591.4 37844.4 37921.8 38025.4 38029.8 3020.3 3273.0 3656.7 3720.6 3744.7 29430.4 30178.8 30351.7 30367.4 30409.4 2911.8 2959.1 3038.6 3049.9 3081.2 244603.0 244826.0 245636.0 245687.0 245731.0 27883.9 28854.9 28897.7 53112.5 53721.0 33975.8 34322.3 34367.3 34392.8 34534.0 13668.9 13688.7 13803.2 13847.9 13872.9 11150.4 11196.8 11278.5 11283.4 11304.8 7860.7 7904.6 7997.2 8012.3 8040.7 3122.9 3124.2 3151.4 3163.5 3193.5 851.4 856.5 890.8 929.7 960.6 27821.3 27897.9 28347.1 28674.6 28702.6 941.7 954.3 975.5 1007.8 1056.8 14515.9 14827.3 15070.7 15214.0 15353.5 385358.0 385650.0 387050.0 389440.0 390246.0 50354.2 50687.7 50888.2 50910.7 50967.7 1176.2 1198.2 1205.2 1219.7 1220.2 26763.3 27361.0 27424.5 27524.2 27770.6 43019.0 43228.4 43560.8 43654.3 43893.6 325360.0 325742.0 327172.0 327491.0 328193.0 25376.2 25530.4 25847.7 25996.2 26060.3 42268.8 43138.0 43341.3 43378.8 43581.6 36734.6 37068.0 37299.3 37405.3 37505.4 35990.3 36128.8 36155.5 36225.6 36811.4 33698.7 35725.6 35952.8 36798.3 39661.8 31820.2 32453.2 32644.0 33018.8 33166.2 24878.0 24944.0 25445.9 25782.7 25948.7 04:29:49 INFO - PROCESS | 11864 | 04:29:49 INFO - PROCESS | 11864 | [#2] jquery.html Cycles:180 Average:24189.40 Median:198817.10 stddev:63654.38 (32.0%) stddev-sans-first:63807.77 04:29:49 INFO - PROCESS | 11864 | Values: 346.6 349.6 353.5 362.6 367.9 15601.5 16209.4 16866.9 16898.2 16945.5 15097.2 16032.8 16099.8 16101.3 16130.4 4554.1 4927.9 4930.2 4935.1 4947.6 3693.9 4903.6 5505.8 5804.2 5806.5 5816.2 5820.4 5836.5 5838.4 5856.7 5593.2 5814.0 5815.8 5819.3 5830.2 4933.4 5062.2 5078.7 5082.3 5093.7 19985.4 20512.9 20615.6 20743.2 20764.1 1979.0 1991.6 2098.4 2233.3 2299.1 13318.9 13452.5 13540.3 13625.7 13768.1 1622.3 1689.0 1743.0 1805.8 1812.6 43473.6 66361.3 68057.7 68332.3 68450.7 8070.4 8676.7 8723.3 8995.0 9072.7 11866.9 11962.2 11997.0 12018.5 12036.9 7090.6 7105.8 7160.7 7241.9 7255.2 6928.2 6991.3 7002.5 7082.4 7185.7 3700.4 3715.4 3727.9 3785.0 3833.2 1658.5 1689.7 1766.6 1827.7 1829.6 753.4 773.0 803.6 814.7 856.3 16170.4 16307.9 16508.7 16616.9 16638.6 857.1 870.5 914.6 938.3 949.5 9358.6 9442.3 9502.0 9557.7 9646.9 359590.0 362031.0 393801.0 400375.0 404938.0 80979.6 83957.0 86139.0 87514.6 87572.0 905.9 947.7 965.4 978.7 985.8 15133.5 15234.0 15473.8 15648.5 15709.1 35699.5 36147.8 36461.3 37814.8 37817.4 50151.5 50612.5 50838.2 50850.5 51395.5 7689.5 7724.3 7729.1 7754.3 7921.1 9045.9 11828.3 11868.8 11913.2 12165.8 9627.1 10135.9 10298.2 10315.5 10839.2 10084.0 10777.5 10781.3 10879.9 10884.5 10318.4 10622.9 10777.4 10871.9 10898.1 7683.5 7911.3 7918.5 7974.6 8018.6 10327.3 10473.0 10506.8 10577.1 10662.5 04:29:49 INFO - PROCESS | 11864 | 04:29:49 INFO - PROCESS | 11864 | [#3] mootools.html Cycles:180 Average:4867.99 Median:5188.83 stddev:2698.16 (52.0%) stddev-sans-first:2692.73 04:29:49 INFO - PROCESS | 11864 | Values: 1344.1 1364.2 1443.2 1663.6 1683.1 6383.4 6980.0 7098.5 7516.7 7536.0 7078.3 7259.8 7357.5 7360.3 7378.4 2136.0 2163.3 2163.9 2165.5 2167.5 2045.9 2122.5 2135.2 2154.4 2160.5 2141.5 2151.9 2156.7 2161.0 2178.0 2110.3 2143.3 2143.8 2147.0 2149.1 2070.2 2095.1 2127.4 2150.3 2151.0 7325.0 7340.9 7403.7 7437.0 7454.4 4202.3 4306.3 4312.8 4326.7 4338.8 2731.5 2773.6 2789.9 2796.5 2839.5 833.7 840.0 857.0 859.7 861.5 9685.4 9767.4 9856.6 9876.7 9888.5 3840.0 3893.3 3972.9 3985.1 3986.5 8436.5 8444.0 8447.5 8450.2 8451.0 4285.8 4315.8 4318.2 4326.1 4344.2 3469.1 3929.6 3978.0 4001.1 4053.8 3409.2 3414.5 3459.4 3508.4 3525.8 1102.4 1107.3 1120.8 1125.8 1137.3 705.5 813.7 830.6 834.8 847.3 5023.7 5030.2 5065.1 5083.7 5146.2 381.7 402.1 408.7 414.2 418.7 3364.7 3381.8 3389.5 3464.7 3489.9 8720.8 8775.1 9069.8 9074.9 9095.8 8970.2 8976.3 9005.3 9034.0 9041.3 6983.5 6995.7 7055.4 7074.0 7111.1 5184.8 5192.8 5194.2 5195.2 5204.1 8274.4 8289.1 8505.5 8560.5 8578.6 8449.7 8477.4 8496.8 8500.6 8529.1 5645.9 6234.9 6359.7 6456.8 6475.7 7164.6 7212.5 7228.3 7296.9 7313.9 6340.1 6577.9 6610.9 6671.1 6728.6 6529.6 6554.8 6574.3 6607.3 6711.8 5952.3 5989.7 5999.9 6013.3 6020.8 4259.2 4390.2 4449.8 4463.5 4488.9 4403.5 4420.7 4456.8 4511.3 4527.5 04:29:49 INFO - PROCESS | 11864 | 04:29:49 INFO - PROCESS | 11864 | [#4] prototype.html Cycles:180 Average:4333.62 Median:4954.31 stddev:1287.55 (26.0%) stddev-sans-first:1254.81 04:29:49 INFO - PROCESS | 11864 | Values: 286.3 294.3 294.5 299.2 299.6 4913.5 4980.0 4983.8 4992.2 5004.0 4932.6 4940.0 4946.9 4954.9 4987.0 3629.5 3761.7 3864.1 3874.9 3875.5 3812.7 3830.9 3855.7 3866.9 3883.1 3855.4 3869.9 3872.2 3877.2 3877.6 3797.1 3810.5 3863.9 3883.2 3883.7 3382.7 3383.3 3392.4 3411.1 3412.4 4852.8 4862.0 4863.2 4871.0 4906.3 4406.5 4421.8 4439.3 4456.6 4466.4 4953.8 5187.2 5205.8 5218.0 5224.8 3614.3 3631.3 3632.8 3643.5 3658.5 5489.9 5497.6 5505.3 5516.8 5542.9 3567.3 3605.6 3611.0 3619.5 3624.8 3670.6 3680.2 3687.4 3690.5 3700.0 4262.9 4305.4 4318.3 4332.4 4356.9 4981.5 5184.2 5200.9 5221.5 5246.9 1276.0 1287.8 1291.4 1297.8 1301.2 773.1 805.3 807.4 826.8 831.1 4545.6 4634.0 4654.4 4670.6 4692.7 5410.4 5422.6 5451.5 5453.2 5464.8 4537.3 4649.7 4660.5 4686.5 4711.5 2849.0 2868.9 2883.2 2896.8 2906.9 5058.8 5081.5 5107.9 5116.1 5120.6 5306.9 5531.5 5554.1 5558.1 5624.6 5107.3 5139.8 5140.0 5155.7 5159.6 5484.0 5503.6 5504.6 5511.2 5514.8 5132.0 5287.2 5301.2 5304.5 5361.2 5088.2 5105.5 5112.2 5113.7 5120.2 3849.8 3878.7 3880.6 3895.3 3899.2 5334.8 5360.4 5404.8 5434.9 5471.4 5199.8 5241.6 5244.7 5247.4 5249.1 5243.2 5252.6 5254.0 5274.2 5279.8 4936.6 5132.7 5160.6 5163.3 5175.9 5045.2 5158.0 5287.2 5299.0 5301.5 5153.1 5165.0 5168.3 5189.3 5193.5 04:29:49 INFO - PROCESS | 11864 | 04:29:49 INFO - PROCESS | 11864 | [#5] yui.html Cycles:180 Average:15600.82 Median:27276.33 stddev:20451.78 (75.0%) stddev-sans-first:20478.32 04:29:49 INFO - PROCESS | 11864 | Values: 644.5 657.0 660.7 730.6 754.3 12833.4 12913.6 13651.4 13660.7 13677.8 12445.9 12460.6 12550.6 12572.8 13328.5 776.3 795.0 795.1 796.0 797.2 775.0 778.2 785.0 785.9 786.6 830.9 831.3 831.7 831.9 833.8 824.2 825.1 825.8 826.4 827.3 597.5 602.1 604.0 604.4 606.3 11664.4 11688.3 11737.1 11742.7 11755.3 10799.6 10983.8 11367.7 11510.9 11724.1 9368.6 9561.1 9598.5 9605.1 9660.0 3268.5 3350.6 3356.8 3360.4 3403.1 56669.4 58796.1 59397.4 59400.0 59584.1 8198.2 8300.6 8522.0 8587.6 8594.2 17184.3 17265.9 17283.5 17316.8 17331.2 6636.7 6644.4 6747.4 6795.1 7130.3 3536.5 3571.9 3586.9 3588.2 3738.3 2710.5 2822.1 2825.5 2826.9 2829.5 471.9 494.0 496.5 497.8 499.5 517.4 520.4 551.8 598.9 631.8 7938.1 8008.9 8070.8 8133.8 8332.0 527.2 605.6 628.7 632.2 642.5 3704.5 3927.0 3933.2 3970.9 4007.1 54152.7 55005.0 55349.4 55383.0 87272.0 51329.7 58691.7 62804.0 69331.7 70005.0 67873.7 69387.7 71178.3 71213.0 73666.0 8197.8 8202.6 8285.4 8340.2 8420.1 43367.0 44297.6 45245.3 45756.3 45813.3 52564.5 52661.7 54025.5 60056.7 61144.0 10326.9 10681.5 10880.9 10928.4 10986.5 12918.7 13048.3 13217.5 13280.7 13377.8 11658.1 11750.5 11766.4 11973.5 12244.1 11868.8 11875.9 11964.2 12034.2 12041.9 11999.2 11999.3 12012.3 12021.9 12099.5 10170.4 10323.0 10450.8 10468.4 10821.9 9294.5 9847.9 9897.9 9944.7 9963.8 04:29:49 INFO - PROCESS | 11864 | -------- Summary: end -------- 04:29:49 INFO - PROCESS | 11864 | 04:29:50 INFO - TEST-INFO | 11864: exit 0 04:29:50 INFO - TEST-OK | dromaeo_css | took 1118181ms 04:29:50 INFO - TEST-START | kraken 04:29:50 INFO - operating with platform_type : linux_ 04:29:50 INFO - Initialising browser for kraken test... 04:29:50 INFO - TEST-INFO | started process 12103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1FDfv2/profile http://localhost:39745/getInfo.html) 04:29:56 INFO - PROCESS | 12103 | __metrics Screen width/height:1600/1200 04:29:56 INFO - PROCESS | 12103 | colorDepth:24 04:29:56 INFO - PROCESS | 12103 | Browser inner width/height: 1024/697 04:29:56 INFO - PROCESS | 12103 | __metrics 04:29:57 ERROR - PROCESS | 12103 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:29:58 INFO - TEST-INFO | 12103: exit 0 04:29:58 INFO - Browser initialized. 04:29:58 INFO - Running cycle 1/1 for kraken test... 04:29:58 INFO - TEST-INFO | started process 12221 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1FDfv2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:30:10 INFO - PROCESS | 12221 | RSS: Main: 185163776 04:30:10 INFO - PROCESS | 12221 | 04:30:13 INFO - PROCESS | 12221 | Cycle 1(1): loaded http://localhost:39745/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39745/tests/kraken/driver.html?testName=audio-beat-detection) 04:30:14 INFO - PROCESS | 12221 | RSS: Main: 189620224 04:30:14 INFO - PROCESS | 12221 | 04:30:17 INFO - PROCESS | 12221 | Cycle 1(1): loaded http://localhost:39745/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39745/tests/kraken/driver.html?testName=audio-dft) 04:30:18 INFO - PROCESS | 12221 | RSS: Main: 189595648 04:30:18 INFO - PROCESS | 12221 | 04:30:20 INFO - PROCESS | 12221 | Cycle 1(1): loaded http://localhost:39745/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39745/tests/kraken/driver.html?testName=audio-fft) 04:30:21 INFO - PROCESS | 12221 | RSS: Main: 185073664 04:30:21 INFO - PROCESS | 12221 | 04:30:23 INFO - PROCESS | 12221 | Cycle 1(1): loaded http://localhost:39745/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39745/tests/kraken/driver.html?testName=audio-oscillator) 04:30:24 INFO - PROCESS | 12221 | RSS: Main: 185692160 04:30:24 INFO - PROCESS | 12221 | 04:30:26 INFO - PROCESS | 12221 | Cycle 1(1): loaded http://localhost:39745/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39745/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:30:27 INFO - PROCESS | 12221 | RSS: Main: 185839616 04:30:27 INFO - PROCESS | 12221 | 04:30:30 INFO - PROCESS | 12221 | Cycle 1(1): loaded http://localhost:39745/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39745/tests/kraken/driver.html?testName=imaging-darkroom) 04:30:31 INFO - PROCESS | 12221 | RSS: Main: 186273792 04:30:31 INFO - PROCESS | 12221 | 04:30:34 INFO - PROCESS | 12221 | Cycle 1(1): loaded http://localhost:39745/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39745/tests/kraken/driver.html?testName=imaging-desaturate) 04:30:35 INFO - PROCESS | 12221 | RSS: Main: 183468032 04:30:35 INFO - PROCESS | 12221 | 04:30:38 INFO - PROCESS | 12221 | Cycle 1(1): loaded http://localhost:39745/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39745/tests/kraken/driver.html?testName=json-parse-financial) 04:30:38 INFO - PROCESS | 12221 | RSS: Main: 184991744 04:30:38 INFO - PROCESS | 12221 | 04:30:40 INFO - PROCESS | 12221 | Cycle 1(1): loaded http://localhost:39745/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39745/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:30:41 INFO - PROCESS | 12221 | RSS: Main: 185384960 04:30:41 INFO - PROCESS | 12221 | 04:30:43 INFO - PROCESS | 12221 | Cycle 1(1): loaded http://localhost:39745/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39745/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:30:43 INFO - PROCESS | 12221 | RSS: Main: 185671680 04:30:43 INFO - PROCESS | 12221 | 04:30:46 INFO - PROCESS | 12221 | Cycle 1(1): loaded http://localhost:39745/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39745/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:30:46 INFO - PROCESS | 12221 | RSS: Main: 185556992 04:30:46 INFO - PROCESS | 12221 | 04:30:49 INFO - PROCESS | 12221 | Cycle 1(1): loaded http://localhost:39745/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39745/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:30:50 INFO - PROCESS | 12221 | RSS: Main: 186195968 04:30:50 INFO - PROCESS | 12221 | 04:30:53 INFO - PROCESS | 12221 | Cycle 1(1): loaded http://localhost:39745/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39745/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:30:53 INFO - PROCESS | 12221 | RSS: Main: 185946112 04:30:53 INFO - PROCESS | 12221 | 04:30:55 INFO - PROCESS | 12221 | Cycle 1(1): loaded http://localhost:39745/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39745/tests/kraken/driver.html?testName=ai-astar) 04:30:55 INFO - PROCESS | 12221 | RSS: Main: 186892288 04:30:55 INFO - PROCESS | 12221 | 04:30:55 INFO - PROCESS | 12221 | __start_tp_report 04:30:55 INFO - PROCESS | 12221 | _x_x_mozilla_page_load 04:30:55 INFO - PROCESS | 12221 | _x_x_mozilla_page_load_details 04:30:55 INFO - PROCESS | 12221 | |i|pagename|runs| 04:30:55 INFO - PROCESS | 12221 | |0;ai-astar;118;108;113;114;114;115;116;116;114;113 04:30:55 INFO - PROCESS | 12221 | |1;audio-beat-detection;167;135;155;182;143;163;153;143;201;132 04:30:55 INFO - PROCESS | 12221 | |2;audio-dft;165;169;171;164;164;162;165;164;163;162 04:30:55 INFO - PROCESS | 12221 | |3;audio-fft;76;76;76;166;76;78;75;78;175;76 04:30:55 INFO - PROCESS | 12221 | |4;audio-oscillator;87;88;163;86;86;87;138;91;87;135 04:30:55 INFO - PROCESS | 12221 | |5;imaging-gaussian-blur;118;117;118;117;118;118;118;118;119;121 04:30:55 INFO - PROCESS | 12221 | |6;imaging-darkroom;149;148;149;148;147;148;149;148;150;148 04:30:55 INFO - PROCESS | 12221 | |7;imaging-desaturate;96;96;96;95;95;96;96;96;96;96 04:30:55 INFO - PROCESS | 12221 | |8;json-parse-financial;67;65;65;65;65;65;67;64;65;66 04:30:55 INFO - PROCESS | 12221 | |9;json-stringify-tinderbox;64;64;66;66;65;65;65;65;66;66 04:30:55 INFO - PROCESS | 12221 | |10;stanford-crypto-aes;85;85;85;84;92;85;85;85;118;91 04:30:55 INFO - PROCESS | 12221 | |11;stanford-crypto-ccm;140;130;157;129;132;154;132;146;147;131 04:30:55 INFO - PROCESS | 12221 | |12;stanford-crypto-pbkdf2;182;175;179;176;171;170;170;172;167;178 04:30:55 INFO - PROCESS | 12221 | |13;stanford-crypto-sha256-iterative;68;67;68;68;67;67;67;67;66;70 04:30:55 INFO - PROCESS | 12221 | __end_tp_report 04:30:55 INFO - PROCESS | 12221 | __start_cc_report 04:30:55 INFO - PROCESS | 12221 | _x_x_mozilla_cycle_collect,959 04:30:55 INFO - PROCESS | 12221 | __end_cc_report 04:30:55 INFO - PROCESS | 12221 | __startTimestamp1465471855807__endTimestamp 04:30:55 INFO - PROCESS | 12221 | 04:30:55 INFO - PROCESS | 12221 | ------- Summary: start ------- 04:30:55 INFO - PROCESS | 12221 | Number of tests: 14 04:30:55 INFO - PROCESS | 12221 | 04:30:55 INFO - PROCESS | 12221 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.50 stddev:2.64 (2.3%) stddev-sans-first:2.40 04:30:55 INFO - PROCESS | 12221 | Values: 118.0 108.0 113.0 114.0 114.0 115.0 116.0 116.0 114.0 113.0 04:30:55 INFO - PROCESS | 12221 | 04:30:55 INFO - PROCESS | 12221 | [#1] audio-beat-detection Cycles:10 Average:157.40 Median:159.00 stddev:21.64 (13.6%) stddev-sans-first:22.68 04:30:55 INFO - PROCESS | 12221 | Values: 167.0 135.0 155.0 182.0 143.0 163.0 153.0 143.0 201.0 132.0 04:30:55 INFO - PROCESS | 12221 | 04:30:55 INFO - PROCESS | 12221 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.50 stddev:2.92 (1.8%) stddev-sans-first:3.10 04:30:55 INFO - PROCESS | 12221 | Values: 165.0 169.0 171.0 164.0 164.0 162.0 165.0 164.0 163.0 162.0 04:30:55 INFO - PROCESS | 12221 | 04:30:55 INFO - PROCESS | 12221 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.00 stddev:39.75 (52.3%) stddev-sans-first:41.55 04:30:55 INFO - PROCESS | 12221 | Values: 76.0 76.0 76.0 166.0 76.0 78.0 75.0 78.0 175.0 76.0 04:30:55 INFO - PROCESS | 12221 | 04:30:55 INFO - PROCESS | 12221 | [#4] audio-oscillator Cycles:10 Average:104.80 Median:87.00 stddev:28.93 (33.3%) stddev-sans-first:29.96 04:30:55 INFO - PROCESS | 12221 | Values: 87.0 88.0 163.0 86.0 86.0 87.0 138.0 91.0 87.0 135.0 04:30:55 INFO - PROCESS | 12221 | 04:30:55 INFO - PROCESS | 12221 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.14 (1.0%) stddev-sans-first:1.20 04:30:55 INFO - PROCESS | 12221 | Values: 118.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 119.0 121.0 04:30:55 INFO - PROCESS | 12221 | 04:30:55 INFO - PROCESS | 12221 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 04:30:55 INFO - PROCESS | 12221 | Values: 149.0 148.0 149.0 148.0 147.0 148.0 149.0 148.0 150.0 148.0 04:30:55 INFO - PROCESS | 12221 | 04:30:55 INFO - PROCESS | 12221 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:30:55 INFO - PROCESS | 12221 | Values: 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 04:30:55 INFO - PROCESS | 12221 | 04:30:55 INFO - PROCESS | 12221 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:0.83 04:30:55 INFO - PROCESS | 12221 | Values: 67.0 65.0 65.0 65.0 65.0 65.0 67.0 64.0 65.0 66.0 04:30:55 INFO - PROCESS | 12221 | 04:30:55 INFO - PROCESS | 12221 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.50 stddev:0.79 (1.2%) stddev-sans-first:0.71 04:30:55 INFO - PROCESS | 12221 | Values: 64.0 64.0 66.0 66.0 65.0 65.0 65.0 65.0 66.0 66.0 04:30:55 INFO - PROCESS | 12221 | 04:30:55 INFO - PROCESS | 12221 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:85.00 stddev:10.39 (12.2%) stddev-sans-first:10.90 04:30:55 INFO - PROCESS | 12221 | Values: 85.0 85.0 85.0 84.0 92.0 85.0 85.0 85.0 118.0 91.0 04:30:55 INFO - PROCESS | 12221 | 04:30:55 INFO - PROCESS | 12221 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:143.00 stddev:10.54 (7.4%) stddev-sans-first:11.18 04:30:55 INFO - PROCESS | 12221 | Values: 140.0 130.0 157.0 129.0 132.0 154.0 132.0 146.0 147.0 131.0 04:30:55 INFO - PROCESS | 12221 | 04:30:55 INFO - PROCESS | 12221 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:175.50 stddev:4.76 (2.7%) stddev-sans-first:4.08 04:30:55 INFO - PROCESS | 12221 | Values: 182.0 175.0 179.0 176.0 171.0 170.0 170.0 172.0 167.0 178.0 04:30:55 INFO - PROCESS | 12221 | 04:30:55 INFO - PROCESS | 12221 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.08 (1.6%) stddev-sans-first:1.13 04:30:55 INFO - PROCESS | 12221 | Values: 68.0 67.0 68.0 68.0 67.0 67.0 67.0 67.0 66.0 70.0 04:30:55 INFO - PROCESS | 12221 | -------- Summary: end -------- 04:30:55 INFO - PROCESS | 12221 | 04:30:56 INFO - TEST-INFO | 12221: exit 0 04:30:56 INFO - TEST-OK | kraken | took 66895ms 04:30:56 INFO - SUITE-END | took 1185s 04:30:56 INFO - Completed test suite (00:19:45) 04:30:56 INFO - javascript benchmark 04:30:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6245.496886510102, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2568.7045989711182, 2642.0752736542213, 2642.6696662917134, 2657.7873770098395, 2665.5735082386823, 4550.863474095774, 4634.119517291717, 4672.789724462399, 4737.218358970775, 4770.522947705228, 4562.201614717428, 4608.055348653526, 4610.124076425477, 4625.098105869357, 4644.6748727589, 4272.401863739079, 4293.9999999999845, 4371.825126994916, 4404.163208990281, 4407.184670835905, 4102.690436372772, 4381.189479946204, 4400.7579583122915, 4405.757683327416, 4428.1807865544815, 4237.512686041114, 4262.211490874198, 4272.060146767706, 4312.202242585116, 4351.608355248011, 4277.871663850089, 4287.421198138242, 4298.527162012208, 4301.548337424557, 4341.02326976431, 4289.24938135825, 4294.613484786384, 4303.849365272201, 4309.288967320388, 4335.306350983859, 4596.471405788344, 4625.468071171825, 4634.189016922025, 4634.814607415699, 4681.5318468153255, 4934.654574179809, 4959.0, 4966.354373931365, 4971.204607262821, 5019.5231453012275, 4859.07677541266, 4955.083309587738, 4977.352944117241, 4985.177445721488, 5031.220160875034, 4642.0, 4676.181668208084, 4676.625869930397, 4687.1328804171335, 4711.246200607886, 5160.612954028463, 5162.199859021857, 5177.534021938043, 5184.662996905189, 5196.298499702568, 4747.335373047776, 4844.079624871334, 4935.333729946483, 4935.827246046371, 4992.326035985096, 4993.775280112403, 5035.924461133086, 5046.369203849519, 5089.51649593288, 5105.591552675777, 4858.076965376567, 4886.584640305614, 4905.828296009694, 4907.2393778964315, 4959.752012399365, 4809.95190048102, 4900.607951363882, 4948.4061912570005, 4959.578435832923, 5010.774515146827, 4169.124483858363, 4217.135487225111, 4217.472815898012, 4220.725652832556, 4227.196832601796, 3699.6300369962787, 3701.5002974598624, 3708.8516459341863, 3733.701303895682, 3742.681872040907, 4336.739795612273, 4388.253996820548, 4389.846355377546, 4395.208862404734, 4449.466064072332, 5042.369703787027, 5092.643514953992, 5093.617978651616, 5104.744762761847, 5120.539151476385, 4417.60241578253, 4419.756913369795, 4431.401760762255, 4451.443569553806, 4482.5069242383315, 4383.3863259143745, 4495.527969563214, 4513.323001549794, 4538.591526762541, 4549.363089167519, 4780.4741478437345, 4782.426108866958, 4792.760361981887, 4815.759212039314, 4817.614590832725, 5056.165732654218, 5068.873278167928, 5069.898602028013, 5070.949290507047, 5081.7713202905215, 4634.559716826896, 4740.9051818962735, 4813.7352445615825, 4822.180229361087, 4831.9275210871165, 4961.206207006861, 4974.129527332775, 4980.302757613865, 4982.128127577587, 5026.170681837602, 5050.72221027847, 5056.64603477753, 5057.671251368649, 5058.570021548209, 5116.9744151279, 4732.19552676039, 4787.904241915073, 4901.240307752304, 4907.263910413324, 4922.556969872729, 4830.227163653799, 4860.17377045896, 4865.56209941107, 4903.901921961612, 4926.753662316942, 4810.0, 4843.975780121218, 4847.127517046824, 4849.102915960559, 4870.025994800983, 4811.27830825379, 4881.072596206709, 4936.7284799336385, 4940.75296235194, 4949.109160351171, 4825.179719447772, 4826.855194344175, 4845.53967373099, 4846.733429661403, 4884.023195361013], "value": 4607.626776052233, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.4750855458701, 573.9942600573993, 585.3122580967364, 588.0092044904336, 599.5952731905962, 35443.82278088609, 39571.81284561468, 39580.0, 39890.8005459973, 39907.60092399075, 38931.22137557247, 39030.0, 39312.0, 39547.0, 39550.0, 7699.461037727361, 7837.882431763528, 7847.411444141684, 7848.4113691473085, 7861.449698521106, 7787.221277872196, 7815.335696465779, 7821.178776228471, 7822.569758663271, 7840.803979900491, 7798.883016754753, 7834.608269586526, 7868.6852525899185, 7879.251471110236, 7883.211678832128, 7805.804854878645, 7842.333401660866, 7850.725224617111, 7868.370530357558, 7881.487703299267, 7730.729424470116, 7768.53388796674, 7792.688292468351, 7803.375729941591, 7818.921810781876, 37591.436128458095, 37844.43233351502, 37921.81039094814, 38025.42961855575, 38029.80985095084, 3020.275133967854, 3273.0, 3656.725745569093, 3720.572134204574, 3744.662980331756, 29430.411391772046, 30178.84910575455, 30351.696483035106, 30367.392652146835, 30409.391812163853, 2911.7525010374143, 2959.1122663200954, 3038.6353637563634, 3049.862756175977, 3081.2142903559447, 244603.0, 244826.0, 245636.0, 245687.0, 245731.0, 27883.860580696968, 28854.855725721656, 28897.711022889922, 53112.54768440039, 53721.0, 33975.83012084973, 34322.31355372879, 34367.312653747285, 34392.82803585966, 34534.0, 13668.863311366958, 13688.65778355549, 13803.2408217547, 13847.930760346133, 13872.861271387359, 11150.386728729998, 11196.776064478829, 11278.492467838967, 11283.435828208556, 11304.830427543593, 7860.6855725771475, 7904.565248911365, 7997.160298168725, 8012.318952888953, 8040.678372865137, 3122.9219269518444, 3124.218945263684, 3151.385479831411, 3163.4622114240633, 3193.5209718542405, 851.3784936996028, 856.5117882806865, 890.7817584691792, 929.7117893453051, 960.5869476125193, 27821.304467388072, 27897.860510697315, 28347.149585512467, 28674.569881451796, 28702.569461458093, 941.6892425499568, 954.2985905359556, 975.5268694683073, 1007.808516381885, 1056.799208150449, 14515.85484145145, 14827.332770025374, 15070.698586028437, 15214.0, 15353.539393818204, 385358.0, 385650.0, 387050.0, 389440.0, 390246.0, 50354.24468632974, 50687.746561266955, 50888.23667644988, 50910.74544627253, 50967.74516127395, 1176.2472017908544, 1198.2271434924426, 1205.2045649871043, 1219.7192947405367, 1220.1885745978825, 26763.33091672724, 27361.0, 27424.45151097007, 27524.174274770987, 27770.5834412488, 43019.0, 43228.351574727036, 43560.78219608882, 43654.34518482162, 43893.561064390226, 325360.0, 325742.0, 327172.0, 327491.0, 328193.0, 25376.238712838644, 25530.361740956625, 25847.741522585286, 25996.22011339663, 26060.34849128787, 42268.788656056524, 43138.0, 43341.3498797512, 43378.783106084265, 43581.564184357754, 36734.57144999668, 37068.0, 37299.254014920094, 37405.2518949614, 37505.437418439295, 35990.28019439649, 36128.819355903055, 36155.45766813447, 36225.63774362328, 36811.44782828313, 33698.66301336955, 35725.64274357223, 35952.82023589865, 36798.264034719694, 39661.80169099136, 31820.204494886886, 32453.241509152955, 32644.020679379657, 33018.834905825315, 33166.17084572905, 24878.0, 24944.0, 25445.87277063603, 25782.742172578033, 25948.74051259463], "value": 16459.704829302485, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.5667915106117, 349.58224921219147, 353.4927379210831, 362.64641974075295, 367.8951498822836, 15601.453949111783, 16209.432669856542, 16866.915665421686, 16898.225686302947, 16945.491635250946, 15097.169655668933, 16032.83967160328, 16099.758503622426, 16101.275442605081, 16130.354785808553, 4554.134714404261, 4927.876803079916, 4930.161872481669, 4935.087008903364, 4947.579455746248, 3693.9445908311395, 4903.558679718824, 5505.752241149138, 5804.245448091763, 5806.535477161838, 5816.214811000525, 5820.35976042635, 5836.533077353823, 5838.41615838417, 5856.707164641773, 5593.188987596796, 5814.040683287252, 5815.79644712433, 5819.33077696064, 5830.183774271605, 4933.358663373774, 5062.1900495920845, 5078.695278283315, 5082.33929589151, 5093.694378337274, 19985.400437986882, 20512.897435512878, 20615.5876882463, 20743.170273189204, 20764.06561704727, 1978.9901050494655, 1991.6315481635943, 2098.412444515538, 2233.3300009996938, 2299.0688771047753, 13318.933405333008, 13452.529161479399, 13540.255285959269, 13625.659358516017, 13768.105073170313, 1622.3105180298444, 1688.9950479464699, 1743.041327270009, 1805.7923338816072, 1812.5831058856536, 43473.56526434727, 66361.33638663648, 68057.65971170162, 68332.3166768336, 68450.65774671144, 8070.435069545076, 8676.6529338827, 8723.345749068845, 8994.955025224963, 9072.727818165466, 11866.940665296619, 11962.162648614514, 11997.0, 12018.4591693374, 12036.939815300868, 7090.645467726593, 7105.827538456097, 7160.677769500385, 7241.927580724126, 7255.165655949528, 6928.237893831674, 6991.30086991307, 7002.544834585736, 7082.362587367162, 7185.748498802517, 3700.3709369407266, 3715.405535114369, 3727.8881633551036, 3785.0, 3833.195029043932, 1658.4742037325689, 1689.662067586463, 1766.5760217547695, 1827.6984297590748, 1829.6432195721973, 753.3859904178078, 773.0414286285079, 803.5781214862244, 814.6619153051536, 856.3491746272878, 16170.353185872433, 16307.918460407622, 16508.68878357031, 16616.916915415586, 16638.58403539897, 857.100044952797, 870.4777133719717, 914.6021480655936, 938.3290946972811, 949.4540639132526, 9358.57886395114, 9442.339036267394, 9501.954784973648, 9557.665481708107, 9646.855297170549, 359590.0, 362031.0, 393801.0, 400375.0, 404938.0, 80979.59510202412, 83957.0, 86139.0, 87514.56242718745, 87572.0, 905.8550631898864, 947.7062110745553, 965.3628605120587, 978.6770365779275, 985.8176237395961, 15133.470328538448, 15234.0, 15473.84526154769, 15648.530544083696, 15709.057456552644, 35699.46450803188, 36147.819260903525, 36461.27077458489, 37814.810925945196, 37817.432738508396, 50151.49848501468, 50612.49387506225, 50838.23742643937, 50850.491495086055, 51395.48604514057, 7689.538627682357, 7724.266194711493, 7729.111152217567, 7754.263344982218, 7921.128675845767, 9045.909540904508, 11828.349440780496, 11868.76262474763, 11913.16607837443, 12165.75668486643, 9627.133557979536, 10135.898641013791, 10298.176145908159, 10315.535800888827, 10839.241253112206, 10084.0, 10777.51501182433, 10781.299215550964, 10879.891201088205, 10884.510197040994, 10318.380897146195, 10622.946885265834, 10777.407242601732, 10871.945640271748, 10898.07366373867, 7683.462157648911, 7911.327537159175, 7918.535071011881, 7974.641141148546, 8018.639161237875, 10327.32872363294, 10473.0, 10506.789864202521, 10577.100946419641, 10662.466876656292], "value": 8197.713205133905, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.126317893369, 1364.2360278244184, 1443.2062365698862, 1663.550841272857, 1683.107952785023, 6383.39357761012, 6980.0, 7098.467614928882, 7516.736914208004, 7536.020317358736, 7078.292170782919, 7259.7822065338, 7357.484976051678, 7360.300771426706, 7378.446616503757, 2135.967960480598, 2163.275302773565, 2163.9026243819067, 2165.5344101018277, 2167.5339801942578, 2045.9386218413472, 2122.490602255455, 2135.2206444647745, 2154.3859999900033, 2160.5138843760187, 2141.507453285745, 2151.8816465094415, 2156.6872803443493, 2161.0, 2177.9891100544473, 2110.2719561751173, 2143.3141394753684, 2143.7641859395453, 2146.957060858774, 2149.054416056938, 2070.234013415031, 2095.1409921932086, 2127.4362293992103, 2150.3441450357636, 2150.9784902150936, 7325.0, 7340.889886651705, 7403.666834992438, 7437.0, 7454.36637885775, 4202.348635961431, 4306.310990241577, 4312.827486900552, 4326.718763280408, 4338.828516300613, 2731.508328500869, 2773.5700966350046, 2789.860506974643, 2796.49663060649, 2839.5456726923594, 833.6748668019477, 839.9962045355802, 856.9742907712779, 859.6776208921655, 861.5003298087157, 9685.41887486746, 9767.365121267096, 9856.556454959544, 9876.703698888972, 9888.505574721235, 3840.0, 3893.2992061429213, 3972.940405893914, 3985.083430810872, 3986.5216174059296, 8436.493810371398, 8443.957780211182, 8447.493150410872, 8450.19723126302, 8451.0, 4285.764282964405, 4315.78421078951, 4318.157959197989, 4326.069894972533, 4344.23975804233, 3469.115375579211, 3929.5677475477673, 3977.980110099431, 4001.079751657077, 4053.8175782089875, 3409.2499650076943, 3414.4878268259463, 3459.39460594395, 3508.4211105167874, 3525.7884526927955, 1102.399192440122, 1107.2747350485445, 1120.7814476177068, 1125.8480105185859, 1137.2721458266717, 705.530822003362, 813.7314686153674, 830.5681045856121, 834.7871292820292, 847.3221422861686, 5023.673461225008, 5030.170021946411, 5065.062963351792, 5083.694978301313, 5146.202338637442, 381.6755757606068, 402.1394216376956, 408.7343226902537, 414.1530569984389, 418.7215501691341, 3364.7308215342714, 3381.8309084546167, 3389.49157626358, 3464.6535346465657, 3489.860405583748, 8720.825583488295, 8775.122487751301, 9069.77325566866, 9074.86387704185, 9095.772605684911, 8970.237529809909, 8976.281897448189, 9005.279577633904, 9033.954830225939, 9041.276697864156, 6983.546069505466, 6995.650217489105, 7055.435565154775, 7074.045003924404, 7111.075560177143, 5184.844454666366, 5192.818251361185, 5194.168932970707, 5195.246689230116, 5204.063268611686, 8274.379421543528, 8289.088200297841, 8505.489670619783, 8560.48637081777, 8578.571071446278, 8449.704260350858, 8477.406581539233, 8496.787580310542, 8500.574971251537, 8529.104444033288, 5645.887082258414, 6234.906476402948, 6359.713812878339, 6456.7740129095255, 6475.740970361133, 7164.641767911479, 7212.4951253411755, 7228.277172282729, 7296.941943418281, 7313.926860731324, 6340.1123842661145, 6577.934220657924, 6610.900836487553, 6671.099401580725, 6728.629925354153, 6529.640869752209, 6554.80335589933, 6574.309697481695, 6607.3062328456745, 6711.765088221889, 5952.285725712942, 5989.670568118795, 5999.9100013498955, 6013.308469525886, 6020.759169633341, 4259.169461954889, 4390.1878152541885, 4449.844255451044, 4463.486699029523, 4488.887777805581, 4403.5376285489565, 4420.668449866209, 4456.821727131008, 4511.255642818898, 4527.479339875825], "value": 3877.7821664265966, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.2528799832437, 294.3259934749423, 294.53022429225376, 299.21456177533975, 299.63594233006893, 4913.53321434464, 4979.975100124494, 4983.800647974082, 4992.176290911995, 5004.049230646175, 4932.580730637891, 4939.950600493994, 4946.851594452163, 4954.876128096799, 4986.950130498694, 3629.510016147826, 3761.736678432511, 3864.130570621616, 3874.8643797467093, 3875.4574359589537, 3812.6759225465867, 3830.9042273943096, 3855.7108216883707, 3866.8839934802, 3883.1262965832743, 3855.4409610606585, 3869.8839034829, 3872.1674839909415, 3877.185790983897, 3877.5734669186368, 3797.145642230476, 3810.504634397538, 3863.864764733249, 3883.184531248427, 3883.650471457568, 3382.7124694401004, 3383.306422183471, 3392.355452464024, 3411.1301618087477, 3412.3687117883023, 4852.757362131914, 4861.951380486185, 4863.221884498499, 4871.025794841046, 4906.337644417994, 4406.493253275882, 4421.801018954155, 4439.2675208590545, 4456.5766252205985, 4466.39703640011, 4953.752312384367, 5187.221916712486, 5205.765740541647, 5217.973910130463, 5224.843254702365, 3614.2952124335766, 3631.273745250934, 3632.7820330779973, 3643.508126402928, 3658.4512323151475, 5489.890202195974, 5497.642653227567, 5505.311836020457, 5516.834494965157, 5542.86142846428, 3567.3222087803233, 3605.6214097519905, 3611.0, 3619.4932709420177, 3624.8187590620364, 3670.6145854685406, 3680.227152297994, 3687.391580389206, 3690.4833323334756, 3699.9825048111447, 4262.914741705148, 4305.354196870432, 4318.330658747899, 4332.415123958288, 4356.934645980313, 4981.4769449207315, 5184.170532714747, 5200.9078093600765, 5221.545873439477, 5246.868828279247, 1275.9617211483671, 1287.8068289756611, 1291.4059532614915, 1297.8312819333614, 1301.1672529581076, 773.1302284929454, 805.2752522729473, 807.3621838747324, 826.8098337382436, 831.0567505880748, 4545.568171023748, 4633.976830115827, 4654.394928659252, 4670.594643758467, 4692.671512994058, 5410.403006556875, 5422.6140498180675, 5451.48210919962, 5453.182022696627, 5464.836054918359, 4537.321191159226, 4649.674522783373, 4660.510646382081, 4686.484486706459, 4711.505291944365, 2848.9857550712113, 2868.934367255573, 2883.1927060423113, 2896.768258539312, 2906.854657267128, 5058.848234552969, 5081.517255860761, 5107.8723031923755, 5116.104681680691, 5120.641555091108, 5306.92039619406, 5531.474509921551, 5554.0835762099605, 5558.138488534284, 5624.578156638268, 5107.336046313955, 5139.7687104080405, 5140.049090918192, 5155.690658560498, 5159.561437277874, 5483.972580137074, 5503.559715222693, 5504.559635229092, 5511.173324001432, 5514.779408823602, 5131.958239362024, 5287.233351164136, 5301.151815709468, 5304.549113325411, 5361.169018801936, 5088.244555628302, 5105.540501354896, 5112.207607820794, 5113.667611605234, 5120.231965205249, 3849.8075096245634, 3878.7284890057426, 3880.573136954989, 3895.2793733159456, 3899.161680238762, 5334.813281535127, 5360.383555891122, 5404.78380864761, 5434.891302173855, 5471.398146203994, 5199.844004679866, 5241.641261432294, 5244.711540865289, 5247.4490178530705, 5249.055170069271, 5243.23973023917, 5252.606054545848, 5253.973730131325, 5274.235235890697, 5279.841604751864, 4936.580390666833, 5132.7433628317685, 5160.638755287094, 5163.251328557263, 5175.948240517547, 5045.217991211368, 5157.974210128926, 5287.206918962186, 5299.0, 5301.496357845998, 5153.123968925367, 5165.0, 5168.276441298146, 5189.299444574934, 5193.506616871391], "value": 3913.71964933131, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.5037321262628, 656.9770058047969, 660.6993817812896, 730.6091241185964, 754.2645920227778, 12833.42249598768, 12913.612591622243, 13651.385687644068, 13660.726785464285, 13677.794833077513, 12445.937770311135, 12460.626181214579, 12550.623481295575, 12572.811407828889, 13328.46686132556, 776.3323541754102, 794.9841003179932, 795.0935933036343, 795.9721409750659, 797.18288754027, 774.9651265693029, 778.1595876453445, 785.0187265917604, 785.8546168958761, 786.5870418030522, 830.9293710034624, 831.2560258568577, 831.6507067031831, 831.9417640765149, 833.7790485521342, 824.2458150792019, 825.0676735289145, 825.7894236969595, 826.3843436639681, 827.3422629009922, 597.4533302028639, 602.1329285828393, 603.9667818269993, 604.4318340759672, 606.2906399512581, 11664.416779161093, 11688.298702077902, 11737.119716021247, 11742.706432339175, 11755.294682319089, 10799.5680172793, 10983.835242471368, 11367.658970230907, 11510.884891151149, 11724.062075033977, 9368.578413971387, 9561.139497445194, 9598.472084035375, 9605.087516685973, 9659.951700241523, 3268.542404063433, 3350.597928248626, 3356.781809182395, 3360.4119279126057, 3403.081168084603, 56669.433305666826, 58796.11805822916, 59397.40602593962, 59400.0, 59584.10623840646, 8198.221168988937, 8300.584970751439, 8522.019967703669, 8587.613557389932, 8594.216158160647, 17184.312627495012, 17265.913670431568, 17283.481495555152, 17316.826831731774, 17331.220095095752, 6636.701348439332, 6644.368784965421, 6747.359000894907, 6795.082663840417, 7130.322619351154, 3536.522569453091, 3571.8749843755863, 3586.946195807065, 3588.2464682416985, 3738.2710371477847, 2710.457908418324, 2822.1251412062325, 2825.477286701967, 2826.886924523037, 2829.5472724364004, 471.86080106368706, 494.03662857428156, 496.54318027414865, 497.7685376300038, 499.54790914222684, 517.3791450259704, 520.3677531798883, 551.7599844067844, 598.8921994041027, 631.7851930343705, 7938.126806051329, 8008.919910800934, 8070.817221189489, 8133.837323253501, 8332.0, 527.209186220669, 605.6259462905333, 628.6950828848005, 632.225523733432, 642.4860111910547, 3704.49989251453, 3926.980365098156, 3933.1543718100174, 3970.920581588352, 4007.0583412897945, 54152.72923635357, 55005.0, 55349.446505535234, 55383.0, 87272.0, 51329.743351283, 58691.70654146787, 62804.0, 69331.65334173296, 70005.0, 67873.66063169751, 69387.65306173437, 71178.2882171182, 71213.0, 73666.0, 8197.795055123432, 8202.589870506332, 8285.4200205985, 8340.165983401612, 8420.115887831935, 43367.0, 44297.55702442934, 45245.321320179566, 45756.31365529453, 45813.31280030736, 52564.47435525596, 52661.7366913163, 54025.45974540204, 60056.699716501134, 61144.0, 10326.948365258126, 10681.46592670379, 10880.891191087987, 10928.398938058164, 10986.505607247533, 12918.741625167631, 13048.282344471145, 13217.537386191438, 13280.667983300109, 13377.799333009818, 11658.125640576822, 11750.471228794553, 11766.352850593299, 11973.521059157885, 12244.081693872817, 11868.762624747284, 11875.940620296844, 11964.222325548812, 12034.157608967289, 12041.939790300992, 11999.16005879615, 11999.340036298088, 12012.279263244232, 12021.939890300493, 12099.455524501594, 10170.440625765357, 10323.0, 10450.790984180121, 10468.424236667057, 10821.891781082088, 9294.535273236446, 9847.901520984698, 9897.851532227167, 9944.701658950244, 9963.750906227402], "value": 6289.098556777623, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1600.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 108.0, 113.0, 114.0, 114.0, 115.0, 116.0, 116.0, 114.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 135.0, 155.0, 182.0, 143.0, 163.0, 153.0, 143.0, 201.0, 132.0], "value": 157.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 169.0, 171.0, 164.0, 164.0, 162.0, 165.0, 164.0, 163.0, 162.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 166.0, 76.0, 78.0, 75.0, 78.0, 175.0, 76.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 163.0, 86.0, 86.0, 87.0, 138.0, 91.0, 87.0, 135.0], "value": 104.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 119.0, 121.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 148.0, 147.0, 148.0, 149.0, 148.0, 150.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 65.0, 65.0, 65.0, 67.0, 64.0, 65.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 92.0, 85.0, 85.0, 85.0, 118.0, 91.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 130.0, 157.0, 129.0, 132.0, 154.0, 132.0, 146.0, 147.0, 131.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 175.0, 179.0, 176.0, 171.0, 170.0, 170.0, 172.0, 167.0, 178.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 66.0, 70.0], "value": 67.5, "unit": "score"}]}]} 04:30:57 INFO - Return code: 0 04:30:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:30:57 ERROR - # TBPL SUCCESS # 04:30:57 INFO - Running post-action listener: _resource_record_post_action 04:30:57 INFO - ##### 04:30:57 INFO - ##### Finished run-tests step (success) 04:30:57 INFO - ##### 04:30:57 INFO - Running post-run listener: _resource_record_post_run 04:30:57 INFO - Total resource usage - Wall time: 1202s; CPU: 14.0%; Read bytes: 0; Write bytes: 531734528; Read time: 0; Write time: 1641268 04:30:57 INFO - TinderboxPrint: CPU usage
13.6% 04:30:57 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:30:57 INFO - TinderboxPrint: I/O write bytes / time
531,734,528 / 1,641,268 04:30:57 INFO - TinderboxPrint: CPU idle
8,284.1 (86.4%) 04:30:57 INFO - TinderboxPrint: CPU user
1,226.0 (12.8%) 04:30:57 INFO - TinderboxPrint: Swap in / out
0 / 0 04:30:57 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 237801472; Read time: 0; Write time: 603108 04:30:57 INFO - run-tests - Wall time: 1186s; CPU: 14.0%; Read bytes: 0; Write bytes: 293933056; Read time: 0; Write time: 1038160 04:30:57 INFO - Running post-run listener: _upload_blobber_files 04:30:57 INFO - Blob upload gear active. 04:30:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:30:57 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 04:30:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:30:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:30:58 INFO - (blobuploader) - INFO - Open directory for files ... 04:30:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:30:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:30:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:59 INFO - (blobuploader) - INFO - Done attempting. 04:30:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:30:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:31:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:03 INFO - (blobuploader) - INFO - Done attempting. 04:31:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:31:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:31:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:03 INFO - (blobuploader) - INFO - Done attempting. 04:31:03 INFO - (blobuploader) - INFO - Iteration through files over. 04:31:03 INFO - Return code: 0 04:31:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:31:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:31:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8611c22e010cfa645c1ad8b4659a3aa09806e52884c5b1c4c9713afc35d3a54c0286c4e07590df5ac671b363dde34d84aaf6b3b2da8b16cff89ddc53345484d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86062640036bab4acd7e0188ae79377e30c0e3bb452aa29ea19df59685bbcc2d24ee4c0b49008f50a2032818d0e469fbef9fa137574c990fb4eef98a9a765590", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad4df752ffbc4cdd1b3d97f1ba9e675860346348d8f2cb5b271c847802e2af75b1693bda64b98fdee9236c6edf0f43e8c50d835424525957e4c6ecca4b098869"} 04:31:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:31:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:31:03 INFO - Contents: 04:31:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8611c22e010cfa645c1ad8b4659a3aa09806e52884c5b1c4c9713afc35d3a54c0286c4e07590df5ac671b363dde34d84aaf6b3b2da8b16cff89ddc53345484d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86062640036bab4acd7e0188ae79377e30c0e3bb452aa29ea19df59685bbcc2d24ee4c0b49008f50a2032818d0e469fbef9fa137574c990fb4eef98a9a765590", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad4df752ffbc4cdd1b3d97f1ba9e675860346348d8f2cb5b271c847802e2af75b1693bda64b98fdee9236c6edf0f43e8c50d835424525957e4c6ecca4b098869"} 04:31:03 INFO - Running post-run listener: copy_logs_to_upload_dir 04:31:03 INFO - Copying logs to upload dir... 04:31:03 INFO - mkdir: /builds/slave/test/build/upload/logs 04:31:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.049388 ========= master_lag: 23.94 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-06-09 04:31:27.598945) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 04:31:27.602726) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8611c22e010cfa645c1ad8b4659a3aa09806e52884c5b1c4c9713afc35d3a54c0286c4e07590df5ac671b363dde34d84aaf6b3b2da8b16cff89ddc53345484d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86062640036bab4acd7e0188ae79377e30c0e3bb452aa29ea19df59685bbcc2d24ee4c0b49008f50a2032818d0e469fbef9fa137574c990fb4eef98a9a765590", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad4df752ffbc4cdd1b3d97f1ba9e675860346348d8f2cb5b271c847802e2af75b1693bda64b98fdee9236c6edf0f43e8c50d835424525957e4c6ecca4b098869"} build_url:https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010448 build_url: 'https://queue.taskcluster.net/v1/task/dGeUCIvaTC-yhn-fZQ-qbA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8611c22e010cfa645c1ad8b4659a3aa09806e52884c5b1c4c9713afc35d3a54c0286c4e07590df5ac671b363dde34d84aaf6b3b2da8b16cff89ddc53345484d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/86062640036bab4acd7e0188ae79377e30c0e3bb452aa29ea19df59685bbcc2d24ee4c0b49008f50a2032818d0e469fbef9fa137574c990fb4eef98a9a765590", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad4df752ffbc4cdd1b3d97f1ba9e675860346348d8f2cb5b271c847802e2af75b1693bda64b98fdee9236c6edf0f43e8c50d835424525957e4c6ecca4b098869"}' ========= master_lag: 0.23 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 04:31:27.841338) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:31:27.841716) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1465469316.636908-742833108 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004643 ========= master_lag: 0.14 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:31:27.984826) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 04:31:27.985185) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 04:31:27.985546) ========= ========= Total master_lag: 24.38 =========