builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1465059677.89 results: success (0) buildid: 20160604073132 builduid: 89936be38e294413b5af9017be76da6d revision: 3e8ee3599a67edd971770af4982ad4b0fe77f073 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:17.888286) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:17.888677) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:17.889031) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:17.936856) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:17.937170) ========= 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=8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-04 10:01:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 72.4M=0s 2016-06-04 10:01:18 (72.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077149 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:18.032020) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:18.032328) ========= 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=8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016987 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:18.084014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:18.084342) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3e8ee3599a67edd971770af4982ad4b0fe77f073 --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 3e8ee3599a67edd971770af4982ad4b0fe77f073 --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=8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-04 10:01:18,156 truncating revision to first 12 chars 2016-06-04 10:01:18,157 Setting DEBUG logging. 2016-06-04 10:01:18,157 attempt 1/10 2016-06-04 10:01:18,157 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3e8ee3599a67?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-04 10:01:18,615 unpacking tar archive at: mozilla-central-3e8ee3599a67/testing/mozharness/ program finished with exit code 0 elapsedTime=0.787639 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:18.887405) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:18.887694) ========= script_repo_revision: 3e8ee3599a67edd971770af4982ad4b0fe77f073 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:18.888068) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:18.888360) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 10:01:18.901073) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-04 10:01:18.901363) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:01:19 INFO - MultiFileLogger online at 20160604 10:01:19 in /builds/slave/test 10:01:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:01:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:01:19 INFO - {'append_to_log': False, 10:01:19 INFO - 'base_work_dir': '/builds/slave/test', 10:01:19 INFO - 'blob_upload_branch': 'Firefox', 10:01:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:01:19 INFO - 'branch': 'Firefox', 10:01:19 INFO - 'buildbot_json_path': 'buildprops.json', 10:01:19 INFO - 'config_files': ('talos/linux_config.py',), 10:01:19 INFO - 'default_actions': ('clobber', 10:01:19 INFO - 'read-buildbot-config', 10:01:19 INFO - 'download-and-extract', 10:01:19 INFO - 'populate-webroot', 10:01:19 INFO - 'create-virtualenv', 10:01:19 INFO - 'install', 10:01:19 INFO - 'run-tests'), 10:01:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:01:19 INFO - 'download_minidump_stackwalk': True, 10:01:19 INFO - 'download_symbols': 'ondemand', 10:01:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:01:19 INFO - 'tooltool.py': '/tools/tooltool.py', 10:01:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:01:19 INFO - '/tools/misc-python/virtualenv.py')}, 10:01:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:01:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:01:19 INFO - 'installer_path': 'installer.exe', 10:01:19 INFO - 'log_level': 'info', 10:01:19 INFO - 'log_name': 'talos', 10:01:19 INFO - 'log_to_console': True, 10:01:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:01:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:01:19 INFO - 'opt_config_files': (), 10:01:19 INFO - 'pip_index': False, 10:01:19 INFO - 'sps_profile': False, 10:01:19 INFO - 'sps_profile_interval': 0, 10:01:19 INFO - 'suite': 'dromaeojs-e10s', 10:01:19 INFO - 'system_bits': '32', 10:01:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:01:19 INFO - 'title': 'talos-linux64-ix-038', 10:01:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:01:19 INFO - 'use_talos_json': True, 10:01:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:01:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:01:19 INFO - 'work_dir': 'build'} 10:01:19 INFO - ##### 10:01:19 INFO - ##### Running clobber step. 10:01:19 INFO - ##### 10:01:19 INFO - Running pre-action listener: _resource_record_pre_action 10:01:19 INFO - Running main action method: clobber 10:01:19 INFO - rmtree: /builds/slave/test/build 10:01:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:01:20 INFO - Running post-action listener: _resource_record_post_action 10:01:20 INFO - ##### 10:01:20 INFO - ##### Finished clobber step (success) 10:01:20 INFO - ##### 10:01:20 INFO - ##### 10:01:20 INFO - ##### Running read-buildbot-config step. 10:01:20 INFO - ##### 10:01:20 INFO - Running pre-action listener: _resource_record_pre_action 10:01:20 INFO - Running main action method: read_buildbot_config 10:01:20 INFO - Using buildbot properties: 10:01:20 INFO - { 10:01:20 INFO - "project": "", 10:01:20 INFO - "product": "firefox", 10:01:20 INFO - "script_repo_revision": "production", 10:01:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:01:20 INFO - "repository": "", 10:01:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 10:01:20 INFO - "buildid": "20160604073132", 10:01:20 INFO - "pgo_build": "True", 10:01:20 INFO - "basedir": "/builds/slave/test", 10:01:20 INFO - "buildnumber": 237, 10:01:20 INFO - "slavename": "talos-linux64-ix-038", 10:01:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:01:20 INFO - "platform": "ubuntu64_hw", 10:01:20 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:01:20 INFO - "branch": "mozilla-central", 10:01:20 INFO - "repo_path": "mozilla-central", 10:01:20 INFO - "revision": "3e8ee3599a67edd971770af4982ad4b0fe77f073", 10:01:20 INFO - "stage_platform": "linux64-pgo", 10:01:20 INFO - "builduid": "89936be38e294413b5af9017be76da6d", 10:01:20 INFO - "slavebuilddir": "test" 10:01:20 INFO - } 10:01:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:01:20 INFO - Running post-action listener: _resource_record_post_action 10:01:20 INFO - ##### 10:01:20 INFO - ##### Finished read-buildbot-config step (success) 10:01:20 INFO - ##### 10:01:20 INFO - ##### 10:01:20 INFO - ##### Running download-and-extract step. 10:01:20 INFO - ##### 10:01:20 INFO - Running pre-action listener: _resource_record_pre_action 10:01:20 INFO - Running main action method: download_and_extract 10:01:20 INFO - mkdir: /builds/slave/test/build/tests 10:01:20 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')]} 10:01:20 INFO - https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:01:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:01:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:01:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:01:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:01:27 INFO - Downloaded 1361 bytes. 10:01:27 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:01:27 INFO - Using the following test package requirements: 10:01:27 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:27 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:01:27 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:01:27 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:27 INFO - u'jsshell-linux-x86_64.zip'], 10:01:27 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:01:27 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:27 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:01:27 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:01:27 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:01:27 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:27 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:01:27 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:01: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')]} 10:01:27 INFO - https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:01:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:01:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:01:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:01:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:01:39 INFO - Downloaded 24440437 bytes. 10:01:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:01:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:01:41 INFO - Return code: 0 10:01:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:01:41 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')]} 10:01:41 INFO - https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:01:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:01:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:01:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:01:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:01:42 INFO - Downloaded 24440437 bytes. 10:01:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:01:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:01:43 INFO - Return code: 0 10:01: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')]} 10:01:43 INFO - https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:01:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:01:44 INFO - Downloaded 10833369 bytes. 10:01:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:01:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:01:44 INFO - Return code: 0 10:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:44 INFO - https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:01:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:01:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:01:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:01:46 INFO - Downloaded 59162600 bytes. 10:01:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:01:46 INFO - mkdir: /builds/slave/test/properties 10:01:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:01:46 INFO - Writing to file /builds/slave/test/properties/build_url 10:01:46 INFO - Contents: 10:01:46 INFO - build_url:https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:01:47 INFO - Running post-action listener: _resource_record_post_action 10:01:47 INFO - Running post-action listener: set_extra_try_arguments 10:01:47 INFO - ##### 10:01:47 INFO - ##### Finished download-and-extract step (success) 10:01:47 INFO - ##### 10:01:47 INFO - ##### 10:01:47 INFO - ##### Running populate-webroot step. 10:01:47 INFO - ##### 10:01:47 INFO - Running pre-action listener: _resource_record_pre_action 10:01:47 INFO - Running main action method: populate_webroot 10:01:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:01:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:01:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:01:47 INFO - '--tppagecycles', 10:01:47 INFO - '7'], 10:01:47 INFO - 'tests': ['tsvgm']}}, 10:01:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:01:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:01:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:01:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:01:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:01:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:01:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:47 INFO - 'talos_options': ['--disable-e10s'], 10:01:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:47 INFO - 'talos_options': ['--disable-e10s'], 10:01:47 INFO - 'tests': ['damp', 'tps']}, 10:01:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:47 INFO - 'tests': ['damp', 'tps']}, 10:01:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:01:47 INFO - 'tests': ['dromaeo_dom']}, 10:01:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:01:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:01:47 INFO - 'tests': ['a11yr', 10:01:47 INFO - 'ts_paint', 10:01:47 INFO - 'tpaint', 10:01:47 INFO - 'sessionrestore', 10:01:47 INFO - 'sessionrestore_no_auto_restore', 10:01:47 INFO - 'tabpaint']}, 10:01:47 INFO - 'other-e10s': {'tests': ['a11yr', 10:01:47 INFO - 'ts_paint', 10:01:47 INFO - 'tpaint', 10:01:47 INFO - 'sessionrestore', 10:01:47 INFO - 'sessionrestore_no_auto_restore', 10:01:47 INFO - 'tabpaint']}, 10:01:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:01:47 INFO - 'ts_paint', 10:01:47 INFO - 'tpaint', 10:01:47 INFO - 'sessionrestore', 10:01:47 INFO - 'sessionrestore_no_auto_restore', 10:01:47 INFO - 'tabpaint']}, 10:01:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:01:47 INFO - 'ts_paint', 10:01:47 INFO - 'tpaint', 10:01:47 INFO - 'sessionrestore', 10:01:47 INFO - 'sessionrestore_no_auto_restore', 10:01:47 INFO - 'tabpaint']}, 10:01:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:01:47 INFO - 'tests': ['a11yr', 10:01:47 INFO - 'ts_paint', 10:01:47 INFO - 'tpaint', 10:01:47 INFO - 'sessionrestore', 10:01:47 INFO - 'sessionrestore_no_auto_restore', 10:01:47 INFO - 'tabpaint']}, 10:01:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:01:47 INFO - 'tests': ['a11yr', 10:01:47 INFO - 'ts_paint', 10:01:47 INFO - 'tpaint', 10:01:47 INFO - 'sessionrestore', 10:01:47 INFO - 'sessionrestore_no_auto_restore', 10:01:47 INFO - 'tabpaint']}, 10:01:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:01:47 INFO - 'tests': ['tsvgx', 10:01:47 INFO - 'tsvgr_opacity', 10:01:47 INFO - 'tart', 10:01:47 INFO - 'tscrollx', 10:01:47 INFO - 'cart']}, 10:01:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:01:47 INFO - 'tsvgr_opacity', 10:01:47 INFO - 'tart', 10:01:47 INFO - 'tscrollx', 10:01:47 INFO - 'cart']}, 10:01:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:47 INFO - 'talos_options': ['--disable-e10s'], 10:01:47 INFO - 'tests': ['tp5o']}, 10:01:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:47 INFO - 'tests': ['tp5o']}, 10:01:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:47 INFO - 'talos_options': ['--disable-e10s', 10:01:47 INFO - '--xperf_path', 10:01:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:47 INFO - 'tests': ['tp5n']}, 10:01:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:47 INFO - 'talos_options': ['--xperf_path', 10:01:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:47 INFO - 'tests': ['tp5n']}}, 10:01:47 INFO - 'talos.zip': {'path': '', 10:01:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:01:47 INFO - Running post-action listener: _resource_record_post_action 10:01:47 INFO - ##### 10:01:47 INFO - ##### Finished populate-webroot step (success) 10:01:47 INFO - ##### 10:01:47 INFO - ##### 10:01:47 INFO - ##### Running create-virtualenv step. 10:01:47 INFO - ##### 10:01:47 INFO - Running pre-action listener: _resource_record_pre_action 10:01:47 INFO - Running main action method: create_virtualenv 10:01:47 INFO - Creating virtualenv /builds/slave/test/build/venv 10:01:47 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 10:01:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:01:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:01:47 INFO - Using real prefix '/usr' 10:01:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:01:47 INFO - Installing distribute.............................................................................................................................................................................................done. 10:01:49 INFO - Installing pip.................done. 10:01:49 INFO - Return code: 0 10:01:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:49 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 0x7f3f72b8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc43b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d56990>, '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 0x1cc2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc2900>, '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': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', '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 10:01:49 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 10:01:49 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 10:01:49 INFO - Using env: {'DISPLAY': ':0', 10:01:49 INFO - 'HOME': '/home/cltbld', 10:01:49 INFO - 'LANG': 'en_US.UTF-8', 10:01:49 INFO - 'LANGUAGE': 'en_US:en', 10:01:49 INFO - 'LOGNAME': 'cltbld', 10:01:49 INFO - 'MAIL': '/var/mail/cltbld', 10:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:49 INFO - 'MOZ_NO_REMOTE': '1', 10:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:49 INFO - 'NO_EM_RESTART': '1', 10:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:49 INFO - 'PWD': '/builds/slave/test', 10:01:49 INFO - 'SHELL': '/bin/bash', 10:01:49 INFO - 'SHLVL': '1', 10:01:49 INFO - 'TERM': 'linux', 10:01:49 INFO - 'TMOUT': '86400', 10:01:49 INFO - 'USER': 'cltbld', 10:01:49 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', 10:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:49 INFO - '_': '/tools/buildbot/bin/python'} 10:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:49 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 10:01:49 INFO - Cleaning up... 10:01:49 INFO - Return code: 0 10:01:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:49 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 0x7f3f72b8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc43b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d56990>, '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 0x1cc2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc2900>, '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': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', '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 10:01:49 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 10:01:49 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 10:01:49 INFO - Using env: {'DISPLAY': ':0', 10:01:49 INFO - 'HOME': '/home/cltbld', 10:01:49 INFO - 'LANG': 'en_US.UTF-8', 10:01:49 INFO - 'LANGUAGE': 'en_US:en', 10:01:49 INFO - 'LOGNAME': 'cltbld', 10:01:49 INFO - 'MAIL': '/var/mail/cltbld', 10:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:49 INFO - 'MOZ_NO_REMOTE': '1', 10:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:49 INFO - 'NO_EM_RESTART': '1', 10:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:49 INFO - 'PWD': '/builds/slave/test', 10:01:49 INFO - 'SHELL': '/bin/bash', 10:01:49 INFO - 'SHLVL': '1', 10:01:49 INFO - 'TERM': 'linux', 10:01:49 INFO - 'TMOUT': '86400', 10:01:49 INFO - 'USER': 'cltbld', 10:01:49 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', 10:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:49 INFO - '_': '/tools/buildbot/bin/python'} 10:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:50 INFO - Downloading/unpacking psutil>=3.1.1 10:01:50 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 10:01:50 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 10:01:50 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 10:01:50 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 10:01:50 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 10:01:50 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 10:01:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:01:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:01:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:01:52 INFO - Installing collected packages: psutil 10:01:52 INFO - Running setup.py install for psutil 10:01:52 INFO - building 'psutil._psutil_linux' extension 10:01:52 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 10:01:52 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 10:01:52 INFO - building 'psutil._psutil_posix' extension 10:01:52 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 10:01:52 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 10:01:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:01:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:01:52 INFO - Successfully installed psutil 10:01:52 INFO - Cleaning up... 10:01:52 INFO - Return code: 0 10:01:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:01:52 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')]} 10:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:52 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')]} 10:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:52 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 0x7f3f72b8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc43b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d56990>, '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 0x1cc2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc2900>, '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': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', '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 10:01:52 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 10:01:52 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 10:01:52 INFO - Using env: {'DISPLAY': ':0', 10:01:52 INFO - 'HOME': '/home/cltbld', 10:01:52 INFO - 'LANG': 'en_US.UTF-8', 10:01:52 INFO - 'LANGUAGE': 'en_US:en', 10:01:52 INFO - 'LOGNAME': 'cltbld', 10:01:52 INFO - 'MAIL': '/var/mail/cltbld', 10:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:52 INFO - 'MOZ_NO_REMOTE': '1', 10:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:52 INFO - 'NO_EM_RESTART': '1', 10:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:52 INFO - 'PWD': '/builds/slave/test', 10:01:52 INFO - 'SHELL': '/bin/bash', 10:01:52 INFO - 'SHLVL': '1', 10:01:52 INFO - 'TERM': 'linux', 10:01:52 INFO - 'TMOUT': '86400', 10:01:52 INFO - 'USER': 'cltbld', 10:01:52 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', 10:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:52 INFO - '_': '/tools/buildbot/bin/python'} 10:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:01:52 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 10:01:52 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 10:01:52 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 10:01:52 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 10:01:52 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 10:01:52 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 10:01:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:01:54 INFO - Installing collected packages: mozsystemmonitor 10:01:54 INFO - Running setup.py install for mozsystemmonitor 10:01:54 INFO - Successfully installed mozsystemmonitor 10:01:54 INFO - Cleaning up... 10:01:54 INFO - Return code: 0 10:01:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:01:54 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')]} 10:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:54 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')]} 10:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:54 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 0x7f3f72b8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc43b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d56990>, '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 0x1cc2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc2900>, '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': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', '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 10:01:54 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 10:01:54 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 10:01:54 INFO - Using env: {'DISPLAY': ':0', 10:01:54 INFO - 'HOME': '/home/cltbld', 10:01:54 INFO - 'LANG': 'en_US.UTF-8', 10:01:54 INFO - 'LANGUAGE': 'en_US:en', 10:01:54 INFO - 'LOGNAME': 'cltbld', 10:01:54 INFO - 'MAIL': '/var/mail/cltbld', 10:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:54 INFO - 'MOZ_NO_REMOTE': '1', 10:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:54 INFO - 'NO_EM_RESTART': '1', 10:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:54 INFO - 'PWD': '/builds/slave/test', 10:01:54 INFO - 'SHELL': '/bin/bash', 10:01:54 INFO - 'SHLVL': '1', 10:01:54 INFO - 'TERM': 'linux', 10:01:54 INFO - 'TMOUT': '86400', 10:01:54 INFO - 'USER': 'cltbld', 10:01:54 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', 10:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:54 INFO - '_': '/tools/buildbot/bin/python'} 10:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:55 INFO - Downloading/unpacking jsonschema==2.5.1 10:01:55 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 10:01:55 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 10:01:55 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 10:01:55 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 10:01:55 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 10:01:55 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 10:01:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:01:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:57 INFO - Downloading functools32-3.2.3-2.tar.gz 10:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:01:57 INFO - warning: no files found matching '*.txt' 10:01:57 INFO - no previously-included directories found matching 'build' 10:01:57 INFO - no previously-included directories found matching 'dist' 10:01:57 INFO - no previously-included directories found matching '.git*' 10:01:57 INFO - Installing collected packages: jsonschema, functools32 10:01:57 INFO - Running setup.py install for functools32 10:01:57 INFO - warning: no files found matching '*.txt' 10:01:57 INFO - no previously-included directories found matching 'build' 10:01:57 INFO - no previously-included directories found matching 'dist' 10:01:57 INFO - no previously-included directories found matching '.git*' 10:01:57 INFO - Successfully installed jsonschema functools32 10:01:57 INFO - Cleaning up... 10:01:57 INFO - Return code: 0 10:01:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3f72b8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc43b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d56990>, '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 0x1cc2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc2900>, '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': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', '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 10:01:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:01:57 INFO - Using env: {'DISPLAY': ':0', 10:01:57 INFO - 'HOME': '/home/cltbld', 10:01:57 INFO - 'LANG': 'en_US.UTF-8', 10:01:57 INFO - 'LANGUAGE': 'en_US:en', 10:01:57 INFO - 'LOGNAME': 'cltbld', 10:01:57 INFO - 'MAIL': '/var/mail/cltbld', 10:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:57 INFO - 'MOZ_NO_REMOTE': '1', 10:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:57 INFO - 'NO_EM_RESTART': '1', 10:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:57 INFO - 'PWD': '/builds/slave/test', 10:01:57 INFO - 'SHELL': '/bin/bash', 10:01:57 INFO - 'SHLVL': '1', 10:01:57 INFO - 'TERM': 'linux', 10:01:57 INFO - 'TMOUT': '86400', 10:01:57 INFO - 'USER': 'cltbld', 10:01:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', 10:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:57 INFO - '_': '/tools/buildbot/bin/python'} 10:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:57 INFO - Downloading/unpacking blobuploader==1.2.4 10:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:59 INFO - Downloading blobuploader-1.2.4.tar.gz 10:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:01:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:01:59 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 10:01:59 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 10:01:59 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 10:01:59 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 10:01:59 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 10:01:59 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 10:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:01:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:01:59 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 10:01:59 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 10:01:59 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 10:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:00 INFO - Downloading docopt-0.6.1.tar.gz 10:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:02:00 INFO - Installing collected packages: blobuploader, requests, docopt 10:02:00 INFO - Running setup.py install for blobuploader 10:02:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:02:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:02:00 INFO - Running setup.py install for requests 10:02:00 INFO - Running setup.py install for docopt 10:02:00 INFO - Successfully installed blobuploader requests docopt 10:02:00 INFO - Cleaning up... 10:02:00 INFO - Return code: 0 10:02:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:00 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')]} 10:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:00 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')]} 10:02:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:00 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 0x7f3f72b8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc43b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d56990>, '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 0x1cc2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc2900>, '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': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', '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 10:02:00 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 10:02:00 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 10:02:00 INFO - Using env: {'DISPLAY': ':0', 10:02:00 INFO - 'HOME': '/home/cltbld', 10:02:00 INFO - 'LANG': 'en_US.UTF-8', 10:02:00 INFO - 'LANGUAGE': 'en_US:en', 10:02:00 INFO - 'LOGNAME': 'cltbld', 10:02:00 INFO - 'MAIL': '/var/mail/cltbld', 10:02:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:00 INFO - 'MOZ_NO_REMOTE': '1', 10:02:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:00 INFO - 'NO_EM_RESTART': '1', 10:02:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:00 INFO - 'PWD': '/builds/slave/test', 10:02:00 INFO - 'SHELL': '/bin/bash', 10:02:00 INFO - 'SHLVL': '1', 10:02:00 INFO - 'TERM': 'linux', 10:02:00 INFO - 'TMOUT': '86400', 10:02:00 INFO - 'USER': 'cltbld', 10:02:00 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', 10:02:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:00 INFO - '_': '/tools/buildbot/bin/python'} 10:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:01 INFO - Running setup.py (path:/tmp/pip-ALDzGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:01 INFO - Running setup.py (path:/tmp/pip-HKzJFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:01 INFO - Running setup.py (path:/tmp/pip-B843JW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:01 INFO - Running setup.py (path:/tmp/pip-VXTpxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:01 INFO - Running setup.py (path:/tmp/pip-g4lbCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:01 INFO - Running setup.py (path:/tmp/pip-EDAFIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:01 INFO - Running setup.py (path:/tmp/pip-gsOOWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:01 INFO - Running setup.py (path:/tmp/pip-06Uvma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:01 INFO - Running setup.py (path:/tmp/pip-JPVojV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:01 INFO - Running setup.py (path:/tmp/pip-aBPRcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:01 INFO - Running setup.py (path:/tmp/pip-yXd3EU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:01 INFO - Running setup.py (path:/tmp/pip-OW1if2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:01 INFO - Running setup.py (path:/tmp/pip-L8XlhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:02 INFO - Running setup.py (path:/tmp/pip-18Dqpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:02 INFO - Running setup.py (path:/tmp/pip-fReUAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:02 INFO - Running setup.py (path:/tmp/pip-uHp50_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:02 INFO - Running setup.py (path:/tmp/pip-Qa2cFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:02:02 INFO - Running setup.py install for manifestparser 10:02:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:02:02 INFO - Running setup.py install for mozcrash 10:02:02 INFO - Running setup.py install for mozdebug 10:02:02 INFO - Running setup.py install for mozdevice 10:02:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:02:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:02:02 INFO - Running setup.py install for mozfile 10:02:02 INFO - Running setup.py install for mozhttpd 10:02:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:02:02 INFO - Running setup.py install for mozinfo 10:02:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:02:02 INFO - Running setup.py install for mozInstall 10:02:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:02:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:02:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:02:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:02:03 INFO - Running setup.py install for mozleak 10:02:03 INFO - Running setup.py install for mozlog 10:02:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:02:03 INFO - Running setup.py install for moznetwork 10:02:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:02:03 INFO - Running setup.py install for mozprocess 10:02:03 INFO - Running setup.py install for mozprofile 10:02:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:02:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:02:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:02:03 INFO - Running setup.py install for mozrunner 10:02:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:02:03 INFO - Running setup.py install for mozscreenshot 10:02:03 INFO - Running setup.py install for moztest 10:02:03 INFO - Running setup.py install for mozversion 10:02:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:02:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:02:04 INFO - Cleaning up... 10:02:04 INFO - Return code: 0 10:02:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:04 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 0x7f3f72b8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc43b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d56990>, '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 0x1cc2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc2900>, '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': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', '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 10:02:04 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 10:02:04 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 10:02:04 INFO - Using env: {'DISPLAY': ':0', 10:02:04 INFO - 'HOME': '/home/cltbld', 10:02:04 INFO - 'LANG': 'en_US.UTF-8', 10:02:04 INFO - 'LANGUAGE': 'en_US:en', 10:02:04 INFO - 'LOGNAME': 'cltbld', 10:02:04 INFO - 'MAIL': '/var/mail/cltbld', 10:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:04 INFO - 'MOZ_NO_REMOTE': '1', 10:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:04 INFO - 'NO_EM_RESTART': '1', 10:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:04 INFO - 'PWD': '/builds/slave/test', 10:02:04 INFO - 'SHELL': '/bin/bash', 10:02:04 INFO - 'SHLVL': '1', 10:02:04 INFO - 'TERM': 'linux', 10:02:04 INFO - 'TMOUT': '86400', 10:02:04 INFO - 'USER': 'cltbld', 10:02:04 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', 10:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:04 INFO - '_': '/tools/buildbot/bin/python'} 10:02:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:04 INFO - Running setup.py (path:/tmp/pip-mIpZPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:04 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)) 10:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:04 INFO - Running setup.py (path:/tmp/pip-VwxGyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:04 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)) 10:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:04 INFO - Running setup.py (path:/tmp/pip-h8P2cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:04 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)) 10:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:04 INFO - Running setup.py (path:/tmp/pip-GsuIUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:04 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)) 10:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:04 INFO - Running setup.py (path:/tmp/pip-dIGBaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:04 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)) 10:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:04 INFO - Running setup.py (path:/tmp/pip-Le1Dzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:04 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)) 10:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:04 INFO - Running setup.py (path:/tmp/pip-d15Wbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:04 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)) 10:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:04 INFO - Running setup.py (path:/tmp/pip-A11gxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:04 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)) 10:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:04 INFO - Running setup.py (path:/tmp/pip-8OftjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:04 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)) 10:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:04 INFO - Running setup.py (path:/tmp/pip-tRRBhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:05 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)) 10:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:05 INFO - Running setup.py (path:/tmp/pip-lafAac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:05 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)) 10:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:05 INFO - Running setup.py (path:/tmp/pip-uDGJdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:05 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)) 10:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:05 INFO - Running setup.py (path:/tmp/pip-4Y5PXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:05 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)) 10:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:05 INFO - Running setup.py (path:/tmp/pip-10ZJ5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:05 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)) 10:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:05 INFO - Running setup.py (path:/tmp/pip-KFnr3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:05 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)) 10:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:05 INFO - Running setup.py (path:/tmp/pip-T4cRlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:05 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)) 10:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:05 INFO - Running setup.py (path:/tmp/pip-Yk0DA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:05 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)) 10:02:05 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)) 10:02:05 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)) 10:02:05 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)) 10:02:05 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)) 10:02:05 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)) 10:02:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:02:05 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 10:02:05 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 10:02:05 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 10:02:05 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 10:02:05 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 10:02:05 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 10:02:07 INFO - Downloading blessings-1.6.tar.gz 10:02:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:02:07 INFO - Installing collected packages: blessings 10:02:07 INFO - Running setup.py install for blessings 10:02:07 INFO - Successfully installed blessings 10:02:07 INFO - Cleaning up... 10:02:07 INFO - Return code: 0 10:02:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:02:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:08 INFO - Reading from file tmpfile_stdout 10:02:08 INFO - Current package versions: 10:02:08 INFO - argparse == 1.2.1 10:02:08 INFO - blessings == 1.6 10:02:08 INFO - blobuploader == 1.2.4 10:02:08 INFO - docopt == 0.6.1 10:02:08 INFO - functools32 == 3.2.3-2 10:02:08 INFO - jsonschema == 2.5.1 10:02:08 INFO - manifestparser == 1.1 10:02:08 INFO - mozInstall == 1.12 10:02:08 INFO - mozcrash == 0.17 10:02:08 INFO - mozdebug == 0.1 10:02:08 INFO - mozdevice == 0.48 10:02:08 INFO - mozfile == 1.2 10:02:08 INFO - mozhttpd == 0.7 10:02:08 INFO - mozinfo == 0.9 10:02:08 INFO - mozleak == 0.1 10:02:08 INFO - mozlog == 3.2 10:02:08 INFO - moznetwork == 0.27 10:02:08 INFO - mozprocess == 0.22 10:02:08 INFO - mozprofile == 0.28 10:02:08 INFO - mozrunner == 6.11 10:02:08 INFO - mozscreenshot == 0.1 10:02:08 INFO - mozsystemmonitor == 0.3 10:02:08 INFO - moztest == 0.7 10:02:08 INFO - mozversion == 1.4 10:02:08 INFO - psutil == 3.1.1 10:02:08 INFO - requests == 1.2.3 10:02:08 INFO - wsgiref == 0.1.2 10:02:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02: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')]} 10:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02: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')]} 10:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:08 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 0x7f3f72b8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc43b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d56990>, '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 0x1cc2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc2900>, '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': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', '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 10:02:08 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 10:02:08 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 10:02:08 INFO - Using env: {'DISPLAY': ':0', 10:02:08 INFO - 'HOME': '/home/cltbld', 10:02:08 INFO - 'LANG': 'en_US.UTF-8', 10:02:08 INFO - 'LANGUAGE': 'en_US:en', 10:02:08 INFO - 'LOGNAME': 'cltbld', 10:02:08 INFO - 'MAIL': '/var/mail/cltbld', 10:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:08 INFO - 'MOZ_NO_REMOTE': '1', 10:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:08 INFO - 'NO_EM_RESTART': '1', 10:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:08 INFO - 'PWD': '/builds/slave/test', 10:02:08 INFO - 'SHELL': '/bin/bash', 10:02:08 INFO - 'SHLVL': '1', 10:02:08 INFO - 'TERM': 'linux', 10:02:08 INFO - 'TMOUT': '86400', 10:02:08 INFO - 'USER': 'cltbld', 10:02:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', 10:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:08 INFO - '_': '/tools/buildbot/bin/python'} 10:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:08 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)) 10:02:08 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)) 10:02:08 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)) 10:02:08 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)) 10:02:08 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)) 10:02:08 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)) 10:02:08 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)) 10:02:08 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)) 10:02:08 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)) 10:02:08 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)) 10:02:08 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)) 10:02:08 INFO - Cleaning up... 10:02:08 INFO - Return code: 0 10:02:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:02: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')]} 10:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02: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')]} 10:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:08 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 0x7f3f72b8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc43b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d56990>, '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 0x1cc2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc2900>, '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': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', '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 10:02:08 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 10:02:08 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 10:02:08 INFO - Using env: {'DISPLAY': ':0', 10:02:08 INFO - 'HOME': '/home/cltbld', 10:02:08 INFO - 'LANG': 'en_US.UTF-8', 10:02:08 INFO - 'LANGUAGE': 'en_US:en', 10:02:08 INFO - 'LOGNAME': 'cltbld', 10:02:08 INFO - 'MAIL': '/var/mail/cltbld', 10:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:08 INFO - 'MOZ_NO_REMOTE': '1', 10:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:08 INFO - 'NO_EM_RESTART': '1', 10:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:08 INFO - 'PWD': '/builds/slave/test', 10:02:08 INFO - 'SHELL': '/bin/bash', 10:02:08 INFO - 'SHLVL': '1', 10:02:08 INFO - 'TERM': 'linux', 10:02:08 INFO - 'TMOUT': '86400', 10:02:08 INFO - 'USER': 'cltbld', 10:02:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', 10:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:08 INFO - '_': '/tools/buildbot/bin/python'} 10:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:02:08 INFO - Cleaning up... 10:02:08 INFO - Return code: 0 10:02:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:02: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')]} 10:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02: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')]} 10:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:02:08 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 0x7f3f72b8af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc43b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d56990>, '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 0x1cc2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc2900>, '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': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', '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 10:02:08 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 10:02:08 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 10:02:08 INFO - Using env: {'DISPLAY': ':0', 10:02:08 INFO - 'HOME': '/home/cltbld', 10:02:08 INFO - 'LANG': 'en_US.UTF-8', 10:02:08 INFO - 'LANGUAGE': 'en_US:en', 10:02:08 INFO - 'LOGNAME': 'cltbld', 10:02:08 INFO - 'MAIL': '/var/mail/cltbld', 10:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:08 INFO - 'MOZ_NO_REMOTE': '1', 10:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:08 INFO - 'NO_EM_RESTART': '1', 10:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:08 INFO - 'PWD': '/builds/slave/test', 10:02:08 INFO - 'SHELL': '/bin/bash', 10:02:08 INFO - 'SHLVL': '1', 10:02:08 INFO - 'TERM': 'linux', 10:02:08 INFO - 'TMOUT': '86400', 10:02:08 INFO - 'USER': 'cltbld', 10:02:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', 10:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:08 INFO - '_': '/tools/buildbot/bin/python'} 10:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:08 INFO - Downloading/unpacking flake8 10:02:08 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 10:02:08 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 10:02:08 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 10:02:08 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 10:02:08 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 10:02:08 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 10:02:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:02:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:02:10 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 10:02:10 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 10:02:10 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 10:02:10 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 10:02:10 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 10:02:10 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 10:02:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:02:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:02:10 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 10:02:10 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 10:02:10 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 10:02:10 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 10:02:10 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 10:02:10 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 10:02:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:02:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:02:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:02:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:02:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:02:11 INFO - no previously-included directories found matching 'docs/_build' 10:02:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:02:11 INFO - Running setup.py install for pep8 10:02:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:02:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:02:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:02:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:02:11 INFO - no previously-included directories found matching 'docs/_build' 10:02:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:02:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:02:11 INFO - Cleaning up... 10:02:11 INFO - Return code: 0 10:02:11 INFO - Running post-action listener: _resource_record_post_action 10:02:11 INFO - Running post-action listener: _start_resource_monitoring 10:02:11 INFO - Starting resource monitoring. 10:02:11 INFO - ##### 10:02:11 INFO - ##### Finished create-virtualenv step (success) 10:02:11 INFO - ##### 10:02:11 INFO - ##### 10:02:11 INFO - ##### Running install step. 10:02:11 INFO - ##### 10:02:11 INFO - Running pre-action listener: _resource_record_pre_action 10:02:11 INFO - Running main action method: install 10:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:12 INFO - Reading from file tmpfile_stdout 10:02:12 INFO - Detecting whether we're running mozinstall >=1.0... 10:02:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:02:12 INFO - Reading from file tmpfile_stdout 10:02:12 INFO - Output received: 10:02:12 INFO - Usage: mozinstall [options] installer 10:02:12 INFO - Options: 10:02:12 INFO - -h, --help show this help message and exit 10:02:12 INFO - -d DEST, --destination=DEST 10:02:12 INFO - Directory to install application into. [default: 10:02:12 INFO - "/builds/slave/test"] 10:02:12 INFO - --app=APP Application being installed. [default: firefox] 10:02:12 INFO - mkdir: /builds/slave/test/build/application 10:02:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:02:28 INFO - Reading from file tmpfile_stdout 10:02:28 INFO - Output received: 10:02:28 INFO - /builds/slave/test/build/application/firefox/firefox 10:02:28 INFO - Running post-action listener: _resource_record_post_action 10:02:28 INFO - ##### 10:02:28 INFO - ##### Finished install step (success) 10:02:28 INFO - ##### 10:02:28 INFO - ##### 10:02:28 INFO - ##### Running run-tests step. 10:02:28 INFO - ##### 10:02:28 INFO - Running pre-action listener: _resource_record_pre_action 10:02:28 INFO - Running main action method: run_tests 10:02:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:02:28 INFO - Python 2.7.3 10:02:28 INFO - Return code: 0 10:02:28 INFO - grabbing minidump binary from tooltool 10:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:28 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 0x1d56990>, '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 0x1cc2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cc2900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:02:28 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 10:02:28 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 10:02:28 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 10:02:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:02:28 INFO - Return code: 0 10:02:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:02:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:02:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:02:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:02:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:02:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:02:29 INFO - Return code: 0 10:02:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 10:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 10:02:29 INFO - Using env: {'DISPLAY': ':0', 10:02:29 INFO - 'HOME': '/home/cltbld', 10:02:29 INFO - 'LANG': 'en_US.UTF-8', 10:02:29 INFO - 'LANGUAGE': 'en_US:en', 10:02:29 INFO - 'LOGNAME': 'cltbld', 10:02:29 INFO - 'MAIL': '/var/mail/cltbld', 10:02:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:02:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:29 INFO - 'MOZ_NO_REMOTE': '1', 10:02:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:29 INFO - 'NO_EM_RESTART': '1', 10:02:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:29 INFO - 'PWD': '/builds/slave/test', 10:02:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:02:29 INFO - 'SHELL': '/bin/bash', 10:02:29 INFO - 'SHLVL': '1', 10:02:29 INFO - 'TERM': 'linux', 10:02:29 INFO - 'TMOUT': '86400', 10:02:29 INFO - 'USER': 'cltbld', 10:02:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410', 10:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:29 INFO - '_': '/tools/buildbot/bin/python'} 10:02:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 10:02:30 INFO - mozversion application_buildid: 20160604073132 10:02:30 INFO - mozversion application_changeset: 3e8ee3599a67edd971770af4982ad4b0fe77f073 10:02:30 INFO - mozversion application_display_name: Nightly 10:02:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:02:30 INFO - mozversion application_name: Firefox 10:02:30 INFO - mozversion application_remotingname: firefox 10:02:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:02:30 INFO - mozversion application_vendor: Mozilla 10:02:30 INFO - mozversion application_version: 49.0a1 10:02:30 INFO - mozversion platform_buildid: 20160604073132 10:02:30 INFO - mozversion platform_changeset: 3e8ee3599a67edd971770af4982ad4b0fe77f073 10:02:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:02:30 INFO - mozversion platform_version: 49.0a1 10:02:30 INFO - using testdate: 1465059750 10:02:30 INFO - actual date: 1465059750 10:02:30 INFO - starting webserver on 'localhost:50023' 10:02:30 INFO - SUITE-START | Running 2 tests 10:02:30 INFO - TEST-START | dromaeo_css 10:02:30 INFO - operating with platform_type : linux_ 10:02:30 INFO - Initialising browser for dromaeo_css test... 10:02:30 INFO - TEST-INFO | started process 10778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVgKR0r/profile http://localhost:50023/getInfo.html) 10:02:36 INFO - PROCESS | 10778 | __metrics Screen width/height:1600/1200 10:02:36 INFO - PROCESS | 10778 | colorDepth:24 10:02:36 INFO - PROCESS | 10778 | Browser inner width/height: 1024/697 10:02:36 INFO - PROCESS | 10778 | __metrics 10:02:37 ERROR - PROCESS | 10778 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 10:02:38 INFO - TEST-INFO | 10778: exit 0 10:02:38 INFO - Browser initialized. 10:02:38 INFO - Running cycle 1/1 for dromaeo_css test... 10:02:38 INFO - TEST-INFO | started process 10895 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVgKR0r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:02:50 INFO - PROCESS | 10895 | RSS: Main: 167301120 10:02:50 INFO - PROCESS | 10895 | 10:03:39 INFO - PROCESS | 10895 | 1465059819696 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] 10:05:46 INFO - PROCESS | 10895 | Cycle 1(1): loaded http://localhost:50023/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50023/tests/dromaeo/cssquery-ext.html) 10:05:48 INFO - PROCESS | 10895 | RSS: Main: 170627072 10:05:48 INFO - PROCESS | 10895 | 10:08:49 INFO - PROCESS | 10895 | Cycle 1(1): loaded http://localhost:50023/tests/dromaeo/cssquery-ext.html (next: http://localhost:50023/tests/dromaeo/cssquery-jquery.html) 10:08:50 INFO - PROCESS | 10895 | RSS: Main: 170446848 10:08:50 INFO - PROCESS | 10895 | 10:11:52 INFO - PROCESS | 10895 | Cycle 1(1): loaded http://localhost:50023/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50023/tests/dromaeo/cssquery-mootools.html) 10:11:53 INFO - PROCESS | 10895 | RSS: Main: 170950656 10:11:53 INFO - PROCESS | 10895 | 10:14:54 INFO - PROCESS | 10895 | Cycle 1(1): loaded http://localhost:50023/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50023/tests/dromaeo/cssquery-prototype.html) 10:14:55 INFO - PROCESS | 10895 | RSS: Main: 168402944 10:14:55 INFO - PROCESS | 10895 | 10:17:58 INFO - PROCESS | 10895 | Cycle 1(1): loaded http://localhost:50023/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50023/tests/dromaeo/cssquery-yui.html) 10:17:58 INFO - PROCESS | 10895 | RSS: Main: 171057152 10:17:58 INFO - PROCESS | 10895 | 10:21:01 INFO - PROCESS | 10895 | Cycle 1(1): loaded http://localhost:50023/tests/dromaeo/cssquery-yui.html (next: http://localhost:50023/tests/dromaeo/cssquery-dojo.html) 10:21:01 INFO - PROCESS | 10895 | RSS: Main: 172310528 10:21:01 INFO - PROCESS | 10895 | 10:21:01 INFO - PROCESS | 10895 | __start_tp_report 10:21:01 INFO - PROCESS | 10895 | _x_x_mozilla_page_load 10:21:01 INFO - PROCESS | 10895 | _x_x_mozilla_page_load_details 10:21:01 INFO - PROCESS | 10895 | |i|pagename|runs| 10:21:01 INFO - PROCESS | 10895 | |0;dojo.html;3057.2662560985364;3116.3923035008183;3131.577237072996;3141.6072990876155;3149.1969547765316;5456.372517160527;5472.699001554913;5491.478309560585;5493.478119578644;5502.174673798932;5287.365516138068;5287.973560132204;5369.40936496986;5423.2136340230645;5440.9934162179925;4900.362952816146;4906.607471402297;5053.898922021557;5086.3387759591205;5134.075866344076;854.350115446037;4888.902221955559;4892.633052521075;4985.1774457214515;5041.420236672793;4936.382952131002;4945.9258111128365;4946.950530494685;4977.875553111183;4981.800727970877;4988.052270068675;4994.126027945095;4995.300657907896;5007.4992500749995;5023.296738456583;4897.7795999180125;4945.060438516671;4960.528749768766;4980.377452818398;4980.402351717781;5345.278387417727;5381.623286369956;5398.8920221595745;5409.540189083933;5411;5717.828465146053;5769.365369809318;5833.649981001154;5843.328017277982;5844.912326315109;5798.797042103548;5814.592978491507;5828.03837366834;5849.473547380713;5849.941500585025;5433.130699088167;5436.891262174774;5444.455554444564;5445.455454454523;5447.754851031713;5783.65298082108;5846.444587764241;5902.734376953047;5926.348101708809;5952.821415357546;5700.144978253213;5726.942730572724;5789.536837053026;5799.652020878761;5803.187553742479;5870.706464676835;5884.293884733774;5901.321348044944;5906.143609176731;5910.261217347832;5655.434456554394;5773.88452230953;5783.132530120515;5827;5838.416158384212;5714.314282286069;5716.42835716425;5752.884942301131;5775.422457754275;5829.213056237439;4410.580994805488;4429.446319210098;4443.044745379759;4447.243968525294;4448.532904045093;3871.4773505576386;3904.2581909437117;3927.3127202739406;3949.150932549516;3961.0493481564217;5491.917621235684;5493.066178749622;5515.420880807537;5537.8061767837935;5565.9721701392045;5762.827115186551;5791.739371728198;5833.358330583633;5839.591228613956;5842.036064049469;5434.83695489136;5494.450554944554;5495;5515.4760297771645;5561.638493497991;4966.850994470172;4972.801087956441;4978.303037574742;4981.750912454363;5014.774335154927;5960.284765828042;5981.611195272293;5985.970070149709;5995.46040856325;6033.577649564576;5622.100463925834;5799.913001305068;5811.88376232473;5846.41535846412;5892.234009578728;6075.179850720273;6105.877882442415;6109.6639684817765;6111.633302001894;6124.418180272867;5772.94227057724;5780.5953583248765;5785.218995435563;5788.21859049023;5791;5641.576881733969;5788.9131663024245;5849.61977471463;5865.266841644794;5866.50134738552;5620.578456615688;5677.971610141923;5704.543636509153;5722.914156287742;5726.685032323262;5523.143912693539;5692.573057020657;5743.253377060955;5759.790444006806;5766.192733017465;5530.336359636869;5549.500544950813;5551.084071128219;5580.693061881636;5646.407127251579;5687.715614219355;5726.455986681259;5729.28383952006;5734.197212390185;5748.712564371681;5404.351477822686;5618.634788738719;5623.971880140737;5624.409437009055;5630.155476678531 10:21:01 INFO - PROCESS | 10895 | |1;ext.html;594.1889321076732;630.2625927664632;633.4900405173835;649.2339039932883;652.9999999999999;40798.38802417966;44412.77793611032;44428.11143777122;44465.77767111164;44838.55161448385;45143;45717.085658286815;45725.31412028814;45745.77127114368;45755.31367029497;8763.211310982026;8859.911400885972;8954.955225223865;8959;8959.059298773633;8642.697505587306;8766.254868336198;8771.12288771124;8811.295096392305;8811.854458920363;8852.645894164258;8860.468371897674;8914.732558023237;8916.598753056096;8919.643214271422;8803.60383782728;8841.73474795754;8854.380193386465;8861.867071993958;8878.689245876429;8730.825383492358;8743.825123497494;8805.427647202976;8832.293416526663;8858.689945851864;41403;41799;41805;41818;41819.16361672749;3752.5309336332957;3828.157805282833;3830.0999265172663;3856.633619806114;4157.812898419578;32695.18262043468;32975.50536741951;33117.503237451456;33120;33207.17360545169;4260.25445547028;4298.806553705091;4318.330658747899;4338.414314067623;4350.891227719332;362250;364572;365879;367937;369822.15088924655;56727;57456.42543574594;57803;57884.13173802396;57950;35525.46711799325;36372.27255454876;36486.27027459436;37630;38112.23775524474;15955.521334359988;15986.840131598768;16014;16042.839571604134;16071.598210044842;12678.80981785274;12699.428525716181;12742.936285318514;12783.936080319725;13052.673683157807;19843.107060182327;19856.50358741014;19951.301704440273;19987.800121998884;20072.89963550173;7267.600281984436;7300.233475485104;7403.925960740324;7414.406847452191;7603.125640551297;1018.6689325969089;1109.928918593561;1113.9053180479589;1118.1948996722347;1201.195199216527;31906.680933190833;32616.836915815744;34424.82787586096;35274.70714403556;35989.1002724934;1111.7832022755485;1167.5855071449682;1169.859616845967;1231.8891299783063;1273.0642977411594;16113.758293625606;16359.836401635832;16556.75164872528;16741.330346786235;16904.492865214062;264388;265745;266536;266994;268035;55828;56522.15216771752;56589.43410565924;56774;56835.43164568384;1407.289318893952;1425.6008317670862;1440.4166312643397;1451.6588601678598;1457.1985408025544;30052.84973575118;31880.521792172673;33504.329913402085;34888.302233955685;35254.647453526166;57891.42108579029;58293.4170658288;58622.41377586169;58777.70611146917;58922.11616825837;510786;521320;521398;522745;524023;44643.55356446394;44943.786643288695;44970;45157.09685806331;45172.548274516834;48870;48965.755171223915;49595;50330.748346258035;50410.74794626003;40998.59001410067;41150.58849411467;41471.170576588906;41950.79024604857;43098.353524696526;40439.3934090983;41254.587454125074;41852.790736046125;42146;42813.5718642822;37030.629693702715;41086.178276433704;41915.371269430376;43668.56331436645;45420;34321;35882.64117358793;36218.63781362153;38702.419463707505;38885.61114388933;28604;28717.712822871505;28734;29002.56496152517;29184.27039323949 10:21:01 INFO - PROCESS | 10895 | |2;jquery.html;393.9094008378073;397.3523157253676;397.7017237072197;399.18366939608495;419.29767639204346;14123.929380353109;18317;19692.21231150756;19868.801311986896;20007.299744508928;18469;19076.33232836851;19172.233110675556;19173.616527669474;19452.90273548634;5509.3664228613625;5643.040683083876;5786.942130578704;5828.154917536955;5836.328822185439;5374.3013408256875;5612.158176273571;5823.708814559255;5837.9124313135335;5883.735231914574;5702.942970570303;5730.885382292352;5733.827985160431;5741.19623252745;5747.2241247431475;5684.7157642118145;5725.971370143144;5745.396733343002;5758.654480731169;5771.624844385144;5474.42518535552;5559.360673522516;5562.805301814417;5613.382527921925;5623.100303951348;12772.744545109046;15998.52004439857;21470.71175729461;21491.462713432134;21846.563068738695;2317.2584772872688;2364.574376612209;2416.0818888822137;2797.146870204587;3015.517517197238;9284.767880802967;9871.420572708332;10080.24398170133;10130.493475326279;10286.742831429274;1947.2503086311872;1981.5937732764748;1983.7817840037585;1997.2510308634262;2009.65835807913;76962.23037769606;80128;81135.18864811336;81205;81782.59108704478;10328.277020608635;10641.840372394421;10820.78358432827;11005;11852.229605075643;15135.848641513443;15150.924245378703;15189.468368607046;15267.770983435257;15273;7979.281864632211;8228.917710822934;8265.214804593554;8349.54077525742;8359.080501144868;7901.249381308767;7934.920650793533;8016.79958001043;8079.272865442138;8082.636281367352;4700.2244629635725;4735.171345014609;4759.952400476021;4798.328234047236;4844.8304309349705;1966.2823069579501;1970.148060822822;1992.8405727541763;2015.6674148765583;2050.0774651406628;926.5321012888448;1022.6471867205802;1114.899659030691;1163.9941800291115;1169.8654654714646;18504.484148012103;18703;18715;18850.528736781416;19235;976.545906153642;987.7185002274317;1005.9195264378832;1053.4206186597341;1086.3156211586809;10330.896691033144;10647.84028239577;10672.62645807393;10694.037536621587;10703.625373111903;459570;462777;468509;469267;470418;86106.56946715227;86702.56648716716;87571.56214218888;87925;88750.55624721835;1048.124815778818;1091.7871015151968;1099.99350594207;1104.1718710966775;1109.3122264196088;16370;16525.51270385671;16636.916815415847;16667.166641667627;17361;40374.1925161501;40620.39069413902;41676.58323416727;42516.787416062725;42807.78596107124;56022.1596676042;58071;58621.413785861594;59742;60624.696876515336;8436.282915952213;8558.315334773328;8691.608877600649;8712.39013269065;8830.558472076242;9681.37071090377;12719.109662323548;12862.742745144858;13124.343782811013;13566.659220095577;11632.243904146204;11672;11988.700282492659;12025.037996960047;12086.456109474919;5855.531557475307;10433.530491127765;10998.570185875786;11157.721056973316;11239.494222759831;10688.786224275627;10730.356178629307;10901.509432075418;11606.187566870576;11626.651200463999;8203.917960820316;8264.48745861795;8328.750137495885;8330.583470826556;8382;8702.608382622924;10831.783364332512;11145.554177832795;11841.348725820162;12099.818502722643 10:21:01 INFO - PROCESS | 10895 | |3;mootools.html;1513.8032055832741;1521.2013692811277;1670.7076261654215;1745.485081900839;1781.5011796696922;7422.517536360133;8117.675292988288;8281.544515051677;8797.208251257385;8838.469691818495;8286.047104582974;8493.108223636522;8575.528345940971;8602.18279263469;8611.095834937336;2325.337278875525;2356.5522550715395;2361.9291421257303;2366.9763302367014;2367.3253122859987;2336.2757545161053;2343.16817529777;2374.560706269337;2376.6197408414655;2379.179183181808;2345.6012477878803;2353.4234112642425;2363.1728894886824;2370.3126093432884;2371.1819422299277;2277.191596983072;2294.208498068164;2318.3508617586936;2319.8376113672048;2320.060375547906;2346.378209774411;2358.2807243790635;2363.409147713072;2370.6799582056547;2390.40239940015;8511.063782983867;8522.14778522149;8562.058173600899;8579.399442039059;8582.313414926854;5198.934218485201;5356.4107948125675;5387.0303345397815;5387.757550910218;5392.514673679349;3431.279431319426;3478.843452044664;3504.2641045380246;3537.044997850566;3540.822958852073;1159.3797318434597;1161.1465572803982;1161.7618388230392;1206.849143857018;1222.6637674639455;11894.464749086226;11910.821337679941;11936.940315298369;11938.925496705251;11941.64175074749;4614.838480653161;4652.348671186037;4710.599599034121;4755.762211889391;4767.73777442244;10071;10086.546105425274;10087.546060427298;10095.697129086138;10109.797804044025;5248.763805628756;5264.0261551613075;5285.048691235615;5285.894282114413;5310.123829568155;4075.9796201018803;4681.368015317888;4774.522547745198;4795.688280261772;4842.394700662418;3795.3168429682923;3816.6832442807186;3896.4544963705102;3901.141748815256;3970.265500882288;1242.45332053896;1244.7510497900457;1261.3188878005774;1263.1726219326356;1272.5037235478171;932.7854593443546;992.3004281981185;1017.872765904262;1043.8538604595362;1045.5242864496788;6081.118237855486;6093.238345206849;6101.420365065312;6171.197744293303;6220.284667263232;457.1611093643136;458.589562341709;467.8526264226826;469.19298806053536;473.87679203406674;4184.707070505096;4185.142045880587;4199.076203235283;4231.809568569422;4280.636145927569;10199.643012494527;10595.682129536126;10621.522031508446;10621.575136994588;10632.149428045737;10505.9474702626;10519.94740026295;10525.631602894015;10539.314944528582;10626.734331641615;7673.577953212515;7936.6031698414845;7951.681932722627;7991;8127.187281271944;6167.969160154171;6307.621542707452;6335.334789847;6386.010168423902;6403.391677790602;9665.661701840401;9935.403875767477;10005.299629025898;10101.343412678152;10114.8482772757;9948.950255248677;10063.849042264226;10123.532087847369;10138.08757211825;10175.389476631426;6887.070245516791;7199.280071992759;7355.448341374526;7647.426443016907;7747.92252077472;8159.918400815915;8230.341572674051;8244.505329680238;8274.751757447286;8283.875741863998;7234.457415693949;7448.143463501767;7452.143003554661;7471.775846724607;7577.469577129548;7130;7284.162321333115;7313.488055836253;7345.22875098107;7400.48196626231;6862.279460656559;6890.793276201722;6955;6961.095057642474;6986.54587451814;4919.754012299442;4975.278584605285;5037.319961805109;5166.870828229325;5183.015227106837;5017.12200364942;5146.588272938081;5225.738713064407;5299.364076310713;5328.6802791832615 10:21:01 INFO - PROCESS | 10895 | |4;prototype.html;319.0874100073789;334.5767603980964;334.80581262867537;335.4180496837987;337.789026340569;5547.33431988162;5551.250581171541;5658.745356458959;5751.769929202832;5759.884802303952;5623.859403514914;5637.267155269809;5642.630095359948;5654.491095801377;5658.207850900877;4380.08018316154;4387.890302742425;4390.40729501518;4400.8679739607705;4407.360932664769;4164.292070348033;4411.514733379326;4420.756858372788;4431.135928493945;4442.577955094261;4341.2836881914445;4353.28170851809;4360.585744354281;4365.624828179113;4377.7592232427205;4402.86791396257;4412.602865742067;4413.82344706213;4424.181526417623;4426.9778651106535;3859.807009649506;3898.4542164097047;3900.473436086149;3956.8417263309434;3985.940210896839;5395.29861118056;5450.3732070811575;5459.808906688247;5464.180372944051;5470.972645136789;5024.723640199788;5031.874203144914;5034.723090230036;5058.949410505885;5070;5573.972130139364;5880.911786323209;5883.17635531026;5902.704864756745;5953.434423729739;4210.789460526992;4236.788160591958;4258.318669012974;4261.531231564525;4274.29474136767;6117.296510901214;6131.049687298476;6133.846653833645;6200.286966998808;6226.719797609073;4221.197972385237;4291.262038874261;4298.290782020931;4319.568043195655;4347.782610869507;4335.804888780012;4342.739435633872;4346.7179730641665;4347.869563913087;4355.825766969286;4955.108080545464;4966.751662416865;5017.397912250553;5020.497950205024;5022.246663000579;5624.803131890364;5633.211350410946;5771.913421298684;5893.174955506232;5933.724249286424;1490.9712298513991;1501.797257370263;1514.674345015827;1517.9829514225496;1535.7696345548034;960.7213907966611;965.2663975378763;967.511406739592;983.9212862970945;989.1443901025561;5107.7446127693465;5112;5129.538341549279;5148.871278218075;5155.32980712505;5358.946410535923;5359.973200134053;5377.5852333768335;5379.704116273564;5441.211024401518;4990.830822427784;5168.405633352138;5199.542304367553;5221.895562088813;5246.055709972242;2934.4424559333656;2945.911622651324;2945.9705402946124;2949.675535691072;2954.640865201988;5547.944520554824;5548.86127846799;5554.805581804618;5559.749056462345;5623.325200975909;5052.9747351263;5459.208414779835;5463.951018368112;5465.344158700902;5466.938514431931;5518.475744804237;5527.944720552743;5531.865967476658;5564.998300305902;5572.860678482989;5189.818356357509;5320.733963301896;5398.35219773614;5415.620906536505;5419.832067173163;5296.378292744962;5343.492368225013;5356.3572371315695;5358.794271288929;5435.864103397446;5525.171224316224;5534.889302214014;5583.302087239095;5621.775128994795;5707.914381284367;3852.94220586697;3961.9405708913814;4001.519817621904;4008.899777505469;4025.6376926076796;5381.040427764792;5383.515483606494;5420.891582168256;5971.313298970674;6101.725422355916;5843.2695913010875;5972.70136493165;5983.970080149571;5989.730462129128;5991.3409524953095;5932.377100404396;5951.226340575698;5969.552283578662;5978.8206353809455;5990.580659353804;5670.262865827416;5861.238039054895;5874.5020019894655;5874.823755287348;5880.353161152184;6033.336333003278;6052.939470605237;6053.969730151321;6061.15143879866;6091.512678985582;5613.943860561342;5863.501602363847;5873.647581145145;5879.382664820132;5914.674692891932 10:21:01 INFO - PROCESS | 10895 | |5;yui.html;739.8039519527326;756.1833220122269;826.5330088499998;862.0431321233434;874.8250349930014;13866.37601307941;15828.683426331467;16002.279897404616;16648.417305394312;16684;15350.846491535109;15409.229538523085;15428.460003899865;15516.069035857856;15521.456749013787;683.835879388948;814.5275740070745;836.2557323981662;841.7054031089131;843.0515669871395;815.2092470303826;819.6803246733779;820.3929092471558;824.8432797768435;826.2274773087182;874.3442418186361;876.430320291809;879.7536689726886;880.995595022024;883.9602217900177;863.5034854958393;868.8349213649386;871.5163084488106;874.5583480342418;877.793718476164;639.0446282807186;639.5682914033056;641.3137942401632;642.5566359212129;644.0757512968858;15252.694946101015;15254.542363729106;15263.465778697693;15289.159096249701;15305.311260993281;15803.841961580467;16026.679466410724;16147.677046459123;16273.349066037345;16340.75488867668;11537.653870383901;11757.470913808898;11821;11903.22629029119;11959;3953.5651078381356;3960.5049368828895;3989.740666856645;4073.490813648294;4139.937900931488;72351.63824180898;73831.63084184598;74143;74221.25778742197;75662.62168689231;11361.772764544663;11619.186656934102;11956.58151964677;12270.32513211782;12337.753244935231;20391.694124588143;21159.365219043146;22315.776842231695;22348.664770028463;22429.32712018642;9235.399699019677;9354.485503297385;9386.249100071978;9416.435013899189;9548.140667339972;4844.006978569385;4894.339264199359;4956.826511072095;4974.950250497521;5136.8715782105;3554.3779838528153;3685.594584595692;3708.5364329458816;3710.9257814843554;3713.7400381973002;658.4798009572385;660.3462572053633;661.9635920024444;667.3926726678797;672.1295921781305;774.194837369141;782.5852298281919;792.9127795942442;797.4736673795268;810.9716159934374;10027.247956403298;10102.545385457672;10198.592056317813;10481;10734.248602597743;645.3997782062727;719.6509692798988;755.8752805786984;762.0588573112202;773.4083426178978;4920.655554111249;5006.048850718352;5046.116929537389;5056.216286475602;5060.367454068241;66787;71636;72150.63924680343;72366.63816680988;72414.63792681108;67034.66482667653;74756.62621686856;106958.46520767346;107685.46157269164;107758.46120769346;89505.55247223722;90302.32430243371;90725.6615974139;92482;93513.53243233741;9540;9593.568289426852;9608;9633.181179599533;9721.854172187564;53400;54466.45533544614;54947.450525494234;55455.44544554664;56390.154147687;75397.62301188459;78333.60833195798;80575;80853.59573202331;81782;12714.173578717353;12939.288339141438;13124.475020999053;13254.072214944861;13333.599992000256;14122.916542798623;14150.929245354118;14402.927985360006;14537.273136343352;14576.927115364779;13179.275139867399;13235.404406801525;13308.86691133115;13456.614225791174;14005.929970350084;13325.400356984153;13373.39819708096;13389.263590502227;13436.261005644783;14176.858231417555;13110.737785244433;13128.277944713132;13200.471981120647;13240.735185296433;13541.661458463617;10538.789224215627;10768.623098191525;10862.402567858844;11118.499667515143;11141.331520108819;11297.491612877277;11404.771904562029;11623.88376116228;11692.415379231175;11707.473163707484 10:21:01 INFO - PROCESS | 10895 | __end_tp_report 10:21:01 INFO - PROCESS | 10895 | __start_cc_report 10:21:01 INFO - PROCESS | 10895 | _x_x_mozilla_cycle_collect,358 10:21:01 INFO - PROCESS | 10895 | __end_cc_report 10:21:01 INFO - PROCESS | 10895 | __startTimestamp1465060861320__endTimestamp 10:21:01 INFO - PROCESS | 10895 | 10:21:01 INFO - PROCESS | 10895 | ------- Summary: start ------- 10:21:01 INFO - PROCESS | 10895 | Number of tests: 6 10:21:01 INFO - PROCESS | 10895 | 10:21:01 INFO - PROCESS | 10895 | [#0] dojo.html Cycles:165 Average:5378.13 Median:5622.10 stddev:711.94 (12.7%) stddev-sans-first:690.45 10:21:01 INFO - PROCESS | 10895 | Values: 3057.3 3116.4 3131.6 3141.6 3149.2 5456.4 5472.7 5491.5 5493.5 5502.2 5287.4 5288.0 5369.4 5423.2 5441.0 4900.4 4906.6 5053.9 5086.3 5134.1 854.4 4888.9 4892.6 4985.2 5041.4 4936.4 4945.9 4947.0 4977.9 4981.8 4988.1 4994.1 4995.3 5007.5 5023.3 4897.8 4945.1 4960.5 4980.4 4980.4 5345.3 5381.6 5398.9 5409.5 5411.0 5717.8 5769.4 5833.6 5843.3 5844.9 5798.8 5814.6 5828.0 5849.5 5849.9 5433.1 5436.9 5444.5 5445.5 5447.8 5783.7 5846.4 5902.7 5926.3 5952.8 5700.1 5726.9 5789.5 5799.7 5803.2 5870.7 5884.3 5901.3 5906.1 5910.3 5655.4 5773.9 5783.1 5827.0 5838.4 5714.3 5716.4 5752.9 5775.4 5829.2 4410.6 4429.4 4443.0 4447.2 4448.5 3871.5 3904.3 3927.3 3949.2 3961.0 5491.9 5493.1 5515.4 5537.8 5566.0 5762.8 5791.7 5833.4 5839.6 5842.0 5434.8 5494.5 5495.0 5515.5 5561.6 4966.9 4972.8 4978.3 4981.8 5014.8 5960.3 5981.6 5986.0 5995.5 6033.6 5622.1 5799.9 5811.9 5846.4 5892.2 6075.2 6105.9 6109.7 6111.6 6124.4 5772.9 5780.6 5785.2 5788.2 5791.0 5641.6 5788.9 5849.6 5865.3 5866.5 5620.6 5678.0 5704.5 5722.9 5726.7 5523.1 5692.6 5743.3 5759.8 5766.2 5530.3 5549.5 5551.1 5580.7 5646.4 5687.7 5726.5 5729.3 5734.2 5748.7 5404.4 5618.6 5624.0 5624.4 5630.2 10:21:01 INFO - PROCESS | 10895 | 10:21:01 INFO - PROCESS | 10895 | [#1] ext.html Cycles:180 Average:55782.53 Median:41811.50 stddev:105345.84 (252.0%) stddev-sans-first:105559.87 10:21:01 INFO - PROCESS | 10895 | Values: 594.2 630.3 633.5 649.2 653.0 40798.4 44412.8 44428.1 44465.8 44838.6 45143.0 45717.1 45725.3 45745.8 45755.3 8763.2 8859.9 8955.0 8959.0 8959.1 8642.7 8766.3 8771.1 8811.3 8811.9 8852.6 8860.5 8914.7 8916.6 8919.6 8803.6 8841.7 8854.4 8861.9 8878.7 8730.8 8743.8 8805.4 8832.3 8858.7 41403.0 41799.0 41805.0 41818.0 41819.2 3752.5 3828.2 3830.1 3856.6 4157.8 32695.2 32975.5 33117.5 33120.0 33207.2 4260.3 4298.8 4318.3 4338.4 4350.9 362250.0 364572.0 365879.0 367937.0 369822.2 56727.0 57456.4 57803.0 57884.1 57950.0 35525.5 36372.3 36486.3 37630.0 38112.2 15955.5 15986.8 16014.0 16042.8 16071.6 12678.8 12699.4 12742.9 12783.9 13052.7 19843.1 19856.5 19951.3 19987.8 20072.9 7267.6 7300.2 7403.9 7414.4 7603.1 1018.7 1109.9 1113.9 1118.2 1201.2 31906.7 32616.8 34424.8 35274.7 35989.1 1111.8 1167.6 1169.9 1231.9 1273.1 16113.8 16359.8 16556.8 16741.3 16904.5 264388.0 265745.0 266536.0 266994.0 268035.0 55828.0 56522.2 56589.4 56774.0 56835.4 1407.3 1425.6 1440.4 1451.7 1457.2 30052.8 31880.5 33504.3 34888.3 35254.6 57891.4 58293.4 58622.4 58777.7 58922.1 510786.0 521320.0 521398.0 522745.0 524023.0 44643.6 44943.8 44970.0 45157.1 45172.5 48870.0 48965.8 49595.0 50330.7 50410.7 40998.6 41150.6 41471.2 41950.8 43098.4 40439.4 41254.6 41852.8 42146.0 42813.6 37030.6 41086.2 41915.4 43668.6 45420.0 34321.0 35882.6 36218.6 38702.4 38885.6 28604.0 28717.7 28734.0 29002.6 29184.3 10:21:01 INFO - PROCESS | 10895 | 10:21:01 INFO - PROCESS | 10895 | [#2] jquery.html Cycles:180 Average:27921.41 Median:2906.33 stddev:76926.09 (2646.8%) stddev-sans-first:77114.12 10:21:01 INFO - PROCESS | 10895 | Values: 393.9 397.4 397.7 399.2 419.3 14123.9 18317.0 19692.2 19868.8 20007.3 18469.0 19076.3 19172.2 19173.6 19452.9 5509.4 5643.0 5786.9 5828.2 5836.3 5374.3 5612.2 5823.7 5837.9 5883.7 5702.9 5730.9 5733.8 5741.2 5747.2 5684.7 5726.0 5745.4 5758.7 5771.6 5474.4 5559.4 5562.8 5613.4 5623.1 12772.7 15998.5 21470.7 21491.5 21846.6 2317.3 2364.6 2416.1 2797.1 3015.5 9284.8 9871.4 10080.2 10130.5 10286.7 1947.3 1981.6 1983.8 1997.3 2009.7 76962.2 80128.0 81135.2 81205.0 81782.6 10328.3 10641.8 10820.8 11005.0 11852.2 15135.8 15150.9 15189.5 15267.8 15273.0 7979.3 8228.9 8265.2 8349.5 8359.1 7901.2 7934.9 8016.8 8079.3 8082.6 4700.2 4735.2 4760.0 4798.3 4844.8 1966.3 1970.1 1992.8 2015.7 2050.1 926.5 1022.6 1114.9 1164.0 1169.9 18504.5 18703.0 18715.0 18850.5 19235.0 976.5 987.7 1005.9 1053.4 1086.3 10330.9 10647.8 10672.6 10694.0 10703.6 459570.0 462777.0 468509.0 469267.0 470418.0 86106.6 86702.6 87571.6 87925.0 88750.6 1048.1 1091.8 1100.0 1104.2 1109.3 16370.0 16525.5 16636.9 16667.2 17361.0 40374.2 40620.4 41676.6 42516.8 42807.8 56022.2 58071.0 58621.4 59742.0 60624.7 8436.3 8558.3 8691.6 8712.4 8830.6 9681.4 12719.1 12862.7 13124.3 13566.7 11632.2 11672.0 11988.7 12025.0 12086.5 5855.5 10433.5 10998.6 11157.7 11239.5 10688.8 10730.4 10901.5 11606.2 11626.7 8203.9 8264.5 8328.8 8330.6 8382.0 8702.6 10831.8 11145.6 11841.3 12099.8 10:21:01 INFO - PROCESS | 10895 | 10:21:01 INFO - PROCESS | 10895 | [#3] mootools.html Cycles:180 Average:5702.15 Median:2574.61 stddev:3185.06 (123.7%) stddev-sans-first:3178.45 10:21:01 INFO - PROCESS | 10895 | Values: 1513.8 1521.2 1670.7 1745.5 1781.5 7422.5 8117.7 8281.5 8797.2 8838.5 8286.0 8493.1 8575.5 8602.2 8611.1 2325.3 2356.6 2361.9 2367.0 2367.3 2336.3 2343.2 2374.6 2376.6 2379.2 2345.6 2353.4 2363.2 2370.3 2371.2 2277.2 2294.2 2318.4 2319.8 2320.1 2346.4 2358.3 2363.4 2370.7 2390.4 8511.1 8522.1 8562.1 8579.4 8582.3 5198.9 5356.4 5387.0 5387.8 5392.5 3431.3 3478.8 3504.3 3537.0 3540.8 1159.4 1161.1 1161.8 1206.8 1222.7 11894.5 11910.8 11936.9 11938.9 11941.6 4614.8 4652.3 4710.6 4755.8 4767.7 10071.0 10086.5 10087.5 10095.7 10109.8 5248.8 5264.0 5285.0 5285.9 5310.1 4076.0 4681.4 4774.5 4795.7 4842.4 3795.3 3816.7 3896.5 3901.1 3970.3 1242.5 1244.8 1261.3 1263.2 1272.5 932.8 992.3 1017.9 1043.9 1045.5 6081.1 6093.2 6101.4 6171.2 6220.3 457.2 458.6 467.9 469.2 473.9 4184.7 4185.1 4199.1 4231.8 4280.6 10199.6 10595.7 10621.5 10621.6 10632.1 10505.9 10519.9 10525.6 10539.3 10626.7 7673.6 7936.6 7951.7 7991.0 8127.2 6168.0 6307.6 6335.3 6386.0 6403.4 9665.7 9935.4 10005.3 10101.3 10114.8 9949.0 10063.8 10123.5 10138.1 10175.4 6887.1 7199.3 7355.4 7647.4 7747.9 8159.9 8230.3 8244.5 8274.8 8283.9 7234.5 7448.1 7452.1 7471.8 7577.5 7130.0 7284.2 7313.5 7345.2 7400.5 6862.3 6890.8 6955.0 6961.1 6986.5 4919.8 4975.3 5037.3 5166.9 5183.0 5017.1 5146.6 5225.7 5299.4 5328.7 10:21:01 INFO - PROCESS | 10895 | 10:21:01 INFO - PROCESS | 10895 | [#4] prototype.html Cycles:180 Average:4789.18 Median:5380.37 stddev:1380.96 (25.7%) stddev-sans-first:1343.45 10:21:01 INFO - PROCESS | 10895 | Values: 319.1 334.6 334.8 335.4 337.8 5547.3 5551.3 5658.7 5751.8 5759.9 5623.9 5637.3 5642.6 5654.5 5658.2 4380.1 4387.9 4390.4 4400.9 4407.4 4164.3 4411.5 4420.8 4431.1 4442.6 4341.3 4353.3 4360.6 4365.6 4377.8 4402.9 4412.6 4413.8 4424.2 4427.0 3859.8 3898.5 3900.5 3956.8 3985.9 5395.3 5450.4 5459.8 5464.2 5471.0 5024.7 5031.9 5034.7 5058.9 5070.0 5574.0 5880.9 5883.2 5902.7 5953.4 4210.8 4236.8 4258.3 4261.5 4274.3 6117.3 6131.0 6133.8 6200.3 6226.7 4221.2 4291.3 4298.3 4319.6 4347.8 4335.8 4342.7 4346.7 4347.9 4355.8 4955.1 4966.8 5017.4 5020.5 5022.2 5624.8 5633.2 5771.9 5893.2 5933.7 1491.0 1501.8 1514.7 1518.0 1535.8 960.7 965.3 967.5 983.9 989.1 5107.7 5112.0 5129.5 5148.9 5155.3 5358.9 5360.0 5377.6 5379.7 5441.2 4990.8 5168.4 5199.5 5221.9 5246.1 2934.4 2945.9 2946.0 2949.7 2954.6 5547.9 5548.9 5554.8 5559.7 5623.3 5053.0 5459.2 5464.0 5465.3 5466.9 5518.5 5527.9 5531.9 5565.0 5572.9 5189.8 5320.7 5398.4 5415.6 5419.8 5296.4 5343.5 5356.4 5358.8 5435.9 5525.2 5534.9 5583.3 5621.8 5707.9 3852.9 3961.9 4001.5 4008.9 4025.6 5381.0 5383.5 5420.9 5971.3 6101.7 5843.3 5972.7 5984.0 5989.7 5991.3 5932.4 5951.2 5969.6 5978.8 5990.6 5670.3 5861.2 5874.5 5874.8 5880.4 6033.3 6052.9 6054.0 6061.2 6091.5 5613.9 5863.5 5873.6 5879.4 5914.7 10:21:01 INFO - PROCESS | 10895 | 10:21:01 INFO - PROCESS | 10895 | [#5] yui.html Cycles:180 Average:19881.88 Median:4938.74 stddev:27051.09 (547.7%) stddev-sans-first:27088.78 10:21:01 INFO - PROCESS | 10895 | Values: 739.8 756.2 826.5 862.0 874.8 13866.4 15828.7 16002.3 16648.4 16684.0 15350.8 15409.2 15428.5 15516.1 15521.5 683.8 814.5 836.3 841.7 843.1 815.2 819.7 820.4 824.8 826.2 874.3 876.4 879.8 881.0 884.0 863.5 868.8 871.5 874.6 877.8 639.0 639.6 641.3 642.6 644.1 15252.7 15254.5 15263.5 15289.2 15305.3 15803.8 16026.7 16147.7 16273.3 16340.8 11537.7 11757.5 11821.0 11903.2 11959.0 3953.6 3960.5 3989.7 4073.5 4139.9 72351.6 73831.6 74143.0 74221.3 75662.6 11361.8 11619.2 11956.6 12270.3 12337.8 20391.7 21159.4 22315.8 22348.7 22429.3 9235.4 9354.5 9386.2 9416.4 9548.1 4844.0 4894.3 4956.8 4975.0 5136.9 3554.4 3685.6 3708.5 3710.9 3713.7 658.5 660.3 662.0 667.4 672.1 774.2 782.6 792.9 797.5 811.0 10027.2 10102.5 10198.6 10481.0 10734.2 645.4 719.7 755.9 762.1 773.4 4920.7 5006.0 5046.1 5056.2 5060.4 66787.0 71636.0 72150.6 72366.6 72414.6 67034.7 74756.6 106958.5 107685.5 107758.5 89505.6 90302.3 90725.7 92482.0 93513.5 9540.0 9593.6 9608.0 9633.2 9721.9 53400.0 54466.5 54947.5 55455.4 56390.2 75397.6 78333.6 80575.0 80853.6 81782.0 12714.2 12939.3 13124.5 13254.1 13333.6 14122.9 14150.9 14402.9 14537.3 14576.9 13179.3 13235.4 13308.9 13456.6 14005.9 13325.4 13373.4 13389.3 13436.3 14176.9 13110.7 13128.3 13200.5 13240.7 13541.7 10538.8 10768.6 10862.4 11118.5 11141.3 11297.5 11404.8 11623.9 11692.4 11707.5 10:21:01 INFO - PROCESS | 10895 | -------- Summary: end -------- 10:21:01 INFO - PROCESS | 10895 | 10:21:01 INFO - TEST-INFO | 10895: exit 0 10:21:02 INFO - TEST-OK | dromaeo_css | took 1111928ms 10:21:02 INFO - TEST-START | kraken 10:21:02 INFO - operating with platform_type : linux_ 10:21:02 INFO - Initialising browser for kraken test... 10:21:02 INFO - TEST-INFO | started process 11129 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzYYYci/profile http://localhost:50023/getInfo.html) 10:21:07 INFO - PROCESS | 11129 | __metrics Screen width/height:1600/1200 10:21:07 INFO - PROCESS | 11129 | colorDepth:24 10:21:07 INFO - PROCESS | 11129 | Browser inner width/height: 1024/697 10:21:07 INFO - PROCESS | 11129 | __metrics 10:21:07 ERROR - PROCESS | 11129 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 10:21:08 INFO - TEST-INFO | 11129: exit 0 10:21:08 INFO - Browser initialized. 10:21:08 INFO - Running cycle 1/1 for kraken test... 10:21:08 INFO - TEST-INFO | started process 11251 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzYYYci/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:21:20 INFO - PROCESS | 11251 | RSS: Main: 167411712 10:21:20 INFO - PROCESS | 11251 | 10:21:23 INFO - PROCESS | 11251 | Cycle 1(1): loaded http://localhost:50023/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50023/tests/kraken/driver.html?testName=audio-beat-detection) 10:21:23 INFO - PROCESS | 11251 | RSS: Main: 172589056 10:21:23 INFO - PROCESS | 11251 | 10:21:26 INFO - PROCESS | 11251 | Cycle 1(1): loaded http://localhost:50023/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50023/tests/kraken/driver.html?testName=audio-dft) 10:21:27 INFO - PROCESS | 11251 | RSS: Main: 172183552 10:21:27 INFO - PROCESS | 11251 | 10:21:30 INFO - PROCESS | 11251 | Cycle 1(1): loaded http://localhost:50023/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50023/tests/kraken/driver.html?testName=audio-fft) 10:21:30 INFO - PROCESS | 11251 | RSS: Main: 166658048 10:21:30 INFO - PROCESS | 11251 | 10:21:32 INFO - PROCESS | 11251 | Cycle 1(1): loaded http://localhost:50023/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50023/tests/kraken/driver.html?testName=audio-oscillator) 10:21:33 INFO - PROCESS | 11251 | RSS: Main: 167186432 10:21:33 INFO - PROCESS | 11251 | 10:21:35 INFO - PROCESS | 11251 | Cycle 1(1): loaded http://localhost:50023/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50023/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:21:36 INFO - PROCESS | 11251 | RSS: Main: 167440384 10:21:36 INFO - PROCESS | 11251 | 10:21:39 INFO - PROCESS | 11251 | Cycle 1(1): loaded http://localhost:50023/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50023/tests/kraken/driver.html?testName=imaging-darkroom) 10:21:40 INFO - PROCESS | 11251 | RSS: Main: 167669760 10:21:40 INFO - PROCESS | 11251 | 10:21:43 INFO - PROCESS | 11251 | Cycle 1(1): loaded http://localhost:50023/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50023/tests/kraken/driver.html?testName=imaging-desaturate) 10:21:44 INFO - PROCESS | 11251 | RSS: Main: 168726528 10:21:44 INFO - PROCESS | 11251 | 10:21:46 INFO - PROCESS | 11251 | Cycle 1(1): loaded http://localhost:50023/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50023/tests/kraken/driver.html?testName=json-parse-financial) 10:21:47 INFO - PROCESS | 11251 | RSS: Main: 168333312 10:21:47 INFO - PROCESS | 11251 | 10:21:49 INFO - PROCESS | 11251 | Cycle 1(1): loaded http://localhost:50023/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50023/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:21:49 INFO - PROCESS | 11251 | RSS: Main: 168214528 10:21:49 INFO - PROCESS | 11251 | 10:21:51 INFO - PROCESS | 11251 | Cycle 1(1): loaded http://localhost:50023/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50023/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:21:52 INFO - PROCESS | 11251 | RSS: Main: 168550400 10:21:52 INFO - PROCESS | 11251 | 10:21:54 INFO - PROCESS | 11251 | Cycle 1(1): loaded http://localhost:50023/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50023/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:21:54 INFO - PROCESS | 11251 | RSS: Main: 168845312 10:21:54 INFO - PROCESS | 11251 | 10:21:57 INFO - PROCESS | 11251 | Cycle 1(1): loaded http://localhost:50023/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:21:58 INFO - PROCESS | 11251 | RSS: Main: 168767488 10:21:58 INFO - PROCESS | 11251 | 10:22:00 INFO - PROCESS | 11251 | Cycle 1(1): loaded http://localhost:50023/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:22:01 INFO - PROCESS | 11251 | RSS: Main: 168534016 10:22:01 INFO - PROCESS | 11251 | 10:22:03 INFO - PROCESS | 11251 | Cycle 1(1): loaded http://localhost:50023/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50023/tests/kraken/driver.html?testName=ai-astar) 10:22:03 INFO - PROCESS | 11251 | RSS: Main: 169369600 10:22:03 INFO - PROCESS | 11251 | 10:22:03 INFO - PROCESS | 11251 | __start_tp_report 10:22:03 INFO - PROCESS | 11251 | _x_x_mozilla_page_load 10:22:03 INFO - PROCESS | 11251 | _x_x_mozilla_page_load_details 10:22:03 INFO - PROCESS | 11251 | |i|pagename|runs| 10:22:03 INFO - PROCESS | 11251 | |0;ai-astar;111;105;110;111;112;111;110;109;111;110 10:22:03 INFO - PROCESS | 11251 | |1;audio-beat-detection;155;127;153;192;126;156;159;127;180;127 10:22:03 INFO - PROCESS | 11251 | |2;audio-dft;162;162;164;164;163;166;167;163;163;162 10:22:03 INFO - PROCESS | 11251 | |3;audio-fft;75;75;75;154;76;76;74;76;176;75 10:22:03 INFO - PROCESS | 11251 | |4;audio-oscillator;85;85;155;86;84;84;143;84;84;146 10:22:03 INFO - PROCESS | 11251 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;118;117 10:22:03 INFO - PROCESS | 11251 | |6;imaging-darkroom;146;146;147;147;147;150;147;147;147;147 10:22:03 INFO - PROCESS | 11251 | |7;imaging-desaturate;95;96;95;95;96;97;96;95;95;95 10:22:03 INFO - PROCESS | 11251 | |8;json-parse-financial;53;52;52;53;55;53;54;55;53;54 10:22:03 INFO - PROCESS | 11251 | |9;json-stringify-tinderbox;62;62;62;63;62;62;63;62;61;61 10:22:03 INFO - PROCESS | 11251 | |10;stanford-crypto-aes;80;86;81;81;87;84;80;81;107;81 10:22:03 INFO - PROCESS | 11251 | |11;stanford-crypto-ccm;129;123;123;130;122;135;125;126;138;133 10:22:03 INFO - PROCESS | 11251 | |12;stanford-crypto-pbkdf2;163;157;163;158;166;160;159;157;161;159 10:22:03 INFO - PROCESS | 11251 | |13;stanford-crypto-sha256-iterative;67;62;63;63;63;67;64;71;63;66 10:22:03 INFO - PROCESS | 11251 | __end_tp_report 10:22:03 INFO - PROCESS | 11251 | __start_cc_report 10:22:03 INFO - PROCESS | 11251 | _x_x_mozilla_cycle_collect,886 10:22:03 INFO - PROCESS | 11251 | __end_cc_report 10:22:03 INFO - PROCESS | 11251 | __startTimestamp1465060923304__endTimestamp 10:22:03 INFO - PROCESS | 11251 | 10:22:03 INFO - PROCESS | 11251 | ------- Summary: start ------- 10:22:03 INFO - PROCESS | 11251 | Number of tests: 14 10:22:03 INFO - PROCESS | 11251 | 10:22:03 INFO - PROCESS | 11251 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:1.94 (1.8%) stddev-sans-first:2.03 10:22:03 INFO - PROCESS | 11251 | Values: 111.0 105.0 110.0 111.0 112.0 111.0 110.0 109.0 111.0 110.0 10:22:03 INFO - PROCESS | 11251 | 10:22:03 INFO - PROCESS | 11251 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:155.50 stddev:23.52 (15.1%) stddev-sans-first:24.88 10:22:03 INFO - PROCESS | 11251 | Values: 155.0 127.0 153.0 192.0 126.0 156.0 159.0 127.0 180.0 127.0 10:22:03 INFO - PROCESS | 11251 | 10:22:03 INFO - PROCESS | 11251 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:1.71 (1.0%) stddev-sans-first:1.72 10:22:03 INFO - PROCESS | 11251 | Values: 162.0 162.0 164.0 164.0 163.0 166.0 167.0 163.0 163.0 162.0 10:22:03 INFO - PROCESS | 11251 | 10:22:03 INFO - PROCESS | 11251 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.00 stddev:38.20 (50.9%) stddev-sans-first:39.95 10:22:03 INFO - PROCESS | 11251 | Values: 75.0 75.0 75.0 154.0 76.0 76.0 74.0 76.0 176.0 75.0 10:22:03 INFO - PROCESS | 11251 | 10:22:03 INFO - PROCESS | 11251 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:84.00 stddev:30.79 (36.7%) stddev-sans-first:31.91 10:22:03 INFO - PROCESS | 11251 | Values: 85.0 85.0 155.0 86.0 84.0 84.0 143.0 84.0 84.0 146.0 10:22:03 INFO - PROCESS | 11251 | 10:22:03 INFO - PROCESS | 11251 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:22:03 INFO - PROCESS | 11251 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 10:22:03 INFO - PROCESS | 11251 | 10:22:03 INFO - PROCESS | 11251 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.10 (0.7%) stddev-sans-first:1.09 10:22:03 INFO - PROCESS | 11251 | Values: 146.0 146.0 147.0 147.0 147.0 150.0 147.0 147.0 147.0 147.0 10:22:03 INFO - PROCESS | 11251 | 10:22:03 INFO - PROCESS | 11251 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 10:22:03 INFO - PROCESS | 11251 | Values: 95.0 96.0 95.0 95.0 96.0 97.0 96.0 95.0 95.0 95.0 10:22:03 INFO - PROCESS | 11251 | 10:22:03 INFO - PROCESS | 11251 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.50 stddev:1.07 (2.0%) stddev-sans-first:1.13 10:22:03 INFO - PROCESS | 11251 | Values: 53.0 52.0 52.0 53.0 55.0 53.0 54.0 55.0 53.0 54.0 10:22:03 INFO - PROCESS | 11251 | 10:22:03 INFO - PROCESS | 11251 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 10:22:03 INFO - PROCESS | 11251 | Values: 62.0 62.0 62.0 63.0 62.0 62.0 63.0 62.0 61.0 61.0 10:22:03 INFO - PROCESS | 11251 | 10:22:03 INFO - PROCESS | 11251 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:81.00 stddev:8.19 (10.1%) stddev-sans-first:8.50 10:22:03 INFO - PROCESS | 11251 | Values: 80.0 86.0 81.0 81.0 87.0 84.0 80.0 81.0 107.0 81.0 10:22:03 INFO - PROCESS | 11251 | 10:22:03 INFO - PROCESS | 11251 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:129.50 stddev:5.54 (4.3%) stddev-sans-first:5.87 10:22:03 INFO - PROCESS | 11251 | Values: 129.0 123.0 123.0 130.0 122.0 135.0 125.0 126.0 138.0 133.0 10:22:03 INFO - PROCESS | 11251 | 10:22:03 INFO - PROCESS | 11251 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:160.50 stddev:2.95 (1.8%) stddev-sans-first:2.96 10:22:03 INFO - PROCESS | 11251 | Values: 163.0 157.0 163.0 158.0 166.0 160.0 159.0 157.0 161.0 159.0 10:22:03 INFO - PROCESS | 11251 | 10:22:03 INFO - PROCESS | 11251 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:2.81 (4.3%) stddev-sans-first:2.87 10:22:03 INFO - PROCESS | 11251 | Values: 67.0 62.0 63.0 63.0 63.0 67.0 64.0 71.0 63.0 66.0 10:22:03 INFO - PROCESS | 11251 | -------- Summary: end -------- 10:22:03 INFO - PROCESS | 11251 | 10:22:04 INFO - TEST-INFO | 11251: exit 0 10:22:04 INFO - TEST-OK | kraken | took 62353ms 10:22:04 INFO - SUITE-END | took 1174s 10:22:04 INFO - Completed test suite (00:19:34) 10:22:04 INFO - javascript benchmark 10:22:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7277.025583926988, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3057.2662560985364, 3116.3923035008183, 3131.577237072996, 3141.6072990876155, 3149.1969547765316, 5456.372517160527, 5472.699001554913, 5491.478309560585, 5493.478119578644, 5502.174673798932, 5287.365516138068, 5287.973560132204, 5369.40936496986, 5423.2136340230645, 5440.9934162179925, 4900.362952816146, 4906.607471402297, 5053.898922021557, 5086.3387759591205, 5134.075866344076, 854.350115446037, 4888.902221955559, 4892.633052521075, 4985.1774457214515, 5041.420236672793, 4936.382952131002, 4945.9258111128365, 4946.950530494685, 4977.875553111183, 4981.800727970877, 4988.052270068675, 4994.126027945095, 4995.300657907896, 5007.4992500749995, 5023.296738456583, 4897.7795999180125, 4945.060438516671, 4960.528749768766, 4980.377452818398, 4980.402351717781, 5345.278387417727, 5381.623286369956, 5398.8920221595745, 5409.540189083933, 5411.0, 5717.828465146053, 5769.365369809318, 5833.649981001154, 5843.328017277982, 5844.912326315109, 5798.797042103548, 5814.592978491507, 5828.03837366834, 5849.473547380713, 5849.941500585025, 5433.130699088167, 5436.891262174774, 5444.455554444564, 5445.455454454523, 5447.754851031713, 5783.65298082108, 5846.444587764241, 5902.734376953047, 5926.348101708809, 5952.821415357546, 5700.144978253213, 5726.942730572724, 5789.536837053026, 5799.652020878761, 5803.187553742479, 5870.706464676835, 5884.293884733774, 5901.321348044944, 5906.143609176731, 5910.261217347832, 5655.434456554394, 5773.88452230953, 5783.132530120515, 5827.0, 5838.416158384212, 5714.314282286069, 5716.42835716425, 5752.884942301131, 5775.422457754275, 5829.213056237439, 4410.580994805488, 4429.446319210098, 4443.044745379759, 4447.243968525294, 4448.532904045093, 3871.4773505576386, 3904.2581909437117, 3927.3127202739406, 3949.150932549516, 3961.0493481564217, 5491.917621235684, 5493.066178749622, 5515.420880807537, 5537.8061767837935, 5565.9721701392045, 5762.827115186551, 5791.739371728198, 5833.358330583633, 5839.591228613956, 5842.036064049469, 5434.83695489136, 5494.450554944554, 5495.0, 5515.4760297771645, 5561.638493497991, 4966.850994470172, 4972.801087956441, 4978.303037574742, 4981.750912454363, 5014.774335154927, 5960.284765828042, 5981.611195272293, 5985.970070149709, 5995.46040856325, 6033.577649564576, 5622.100463925834, 5799.913001305068, 5811.88376232473, 5846.41535846412, 5892.234009578728, 6075.179850720273, 6105.877882442415, 6109.6639684817765, 6111.633302001894, 6124.418180272867, 5772.94227057724, 5780.5953583248765, 5785.218995435563, 5788.21859049023, 5791.0, 5641.576881733969, 5788.9131663024245, 5849.61977471463, 5865.266841644794, 5866.50134738552, 5620.578456615688, 5677.971610141923, 5704.543636509153, 5722.914156287742, 5726.685032323262, 5523.143912693539, 5692.573057020657, 5743.253377060955, 5759.790444006806, 5766.192733017465, 5530.336359636869, 5549.500544950813, 5551.084071128219, 5580.693061881636, 5646.407127251579, 5687.715614219355, 5726.455986681259, 5729.28383952006, 5734.197212390185, 5748.712564371681, 5404.351477822686, 5618.634788738719, 5623.971880140737, 5624.409437009055, 5630.155476678531], "value": 5331.249202169952, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.1889321076732, 630.2625927664632, 633.4900405173835, 649.2339039932883, 652.9999999999999, 40798.38802417966, 44412.77793611032, 44428.11143777122, 44465.77767111164, 44838.55161448385, 45143.0, 45717.085658286815, 45725.31412028814, 45745.77127114368, 45755.31367029497, 8763.211310982026, 8859.911400885972, 8954.955225223865, 8959.0, 8959.059298773633, 8642.697505587306, 8766.254868336198, 8771.12288771124, 8811.295096392305, 8811.854458920363, 8852.645894164258, 8860.468371897674, 8914.732558023237, 8916.598753056096, 8919.643214271422, 8803.60383782728, 8841.73474795754, 8854.380193386465, 8861.867071993958, 8878.689245876429, 8730.825383492358, 8743.825123497494, 8805.427647202976, 8832.293416526663, 8858.689945851864, 41403.0, 41799.0, 41805.0, 41818.0, 41819.16361672749, 3752.5309336332957, 3828.157805282833, 3830.0999265172663, 3856.633619806114, 4157.812898419578, 32695.18262043468, 32975.50536741951, 33117.503237451456, 33120.0, 33207.17360545169, 4260.25445547028, 4298.806553705091, 4318.330658747899, 4338.414314067623, 4350.891227719332, 362250.0, 364572.0, 365879.0, 367937.0, 369822.15088924655, 56727.0, 57456.42543574594, 57803.0, 57884.13173802396, 57950.0, 35525.46711799325, 36372.27255454876, 36486.27027459436, 37630.0, 38112.23775524474, 15955.521334359988, 15986.840131598768, 16014.0, 16042.839571604134, 16071.598210044842, 12678.80981785274, 12699.428525716181, 12742.936285318514, 12783.936080319725, 13052.673683157807, 19843.107060182327, 19856.50358741014, 19951.301704440273, 19987.800121998884, 20072.89963550173, 7267.600281984436, 7300.233475485104, 7403.925960740324, 7414.406847452191, 7603.125640551297, 1018.6689325969089, 1109.928918593561, 1113.9053180479589, 1118.1948996722347, 1201.195199216527, 31906.680933190833, 32616.836915815744, 34424.82787586096, 35274.70714403556, 35989.1002724934, 1111.7832022755485, 1167.5855071449682, 1169.859616845967, 1231.8891299783063, 1273.0642977411594, 16113.758293625606, 16359.836401635832, 16556.75164872528, 16741.330346786235, 16904.492865214062, 264388.0, 265745.0, 266536.0, 266994.0, 268035.0, 55828.0, 56522.15216771752, 56589.43410565924, 56774.0, 56835.43164568384, 1407.289318893952, 1425.6008317670862, 1440.4166312643397, 1451.6588601678598, 1457.1985408025544, 30052.84973575118, 31880.521792172673, 33504.329913402085, 34888.302233955685, 35254.647453526166, 57891.42108579029, 58293.4170658288, 58622.41377586169, 58777.70611146917, 58922.11616825837, 510786.0, 521320.0, 521398.0, 522745.0, 524023.0, 44643.55356446394, 44943.786643288695, 44970.0, 45157.09685806331, 45172.548274516834, 48870.0, 48965.755171223915, 49595.0, 50330.748346258035, 50410.74794626003, 40998.59001410067, 41150.58849411467, 41471.170576588906, 41950.79024604857, 43098.353524696526, 40439.3934090983, 41254.587454125074, 41852.790736046125, 42146.0, 42813.5718642822, 37030.629693702715, 41086.178276433704, 41915.371269430376, 43668.56331436645, 45420.0, 34321.0, 35882.64117358793, 36218.63781362153, 38702.419463707505, 38885.61114388933, 28604.0, 28717.712822871505, 28734.0, 29002.56496152517, 29184.27039323949], "value": 20230.347143498664, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.9094008378073, 397.3523157253676, 397.7017237072197, 399.18366939608495, 419.29767639204346, 14123.929380353109, 18317.0, 19692.21231150756, 19868.801311986896, 20007.299744508928, 18469.0, 19076.33232836851, 19172.233110675556, 19173.616527669474, 19452.90273548634, 5509.3664228613625, 5643.040683083876, 5786.942130578704, 5828.154917536955, 5836.328822185439, 5374.3013408256875, 5612.158176273571, 5823.708814559255, 5837.9124313135335, 5883.735231914574, 5702.942970570303, 5730.885382292352, 5733.827985160431, 5741.19623252745, 5747.2241247431475, 5684.7157642118145, 5725.971370143144, 5745.396733343002, 5758.654480731169, 5771.624844385144, 5474.42518535552, 5559.360673522516, 5562.805301814417, 5613.382527921925, 5623.100303951348, 12772.744545109046, 15998.52004439857, 21470.71175729461, 21491.462713432134, 21846.563068738695, 2317.2584772872688, 2364.574376612209, 2416.0818888822137, 2797.146870204587, 3015.517517197238, 9284.767880802967, 9871.420572708332, 10080.24398170133, 10130.493475326279, 10286.742831429274, 1947.2503086311872, 1981.5937732764748, 1983.7817840037585, 1997.2510308634262, 2009.65835807913, 76962.23037769606, 80128.0, 81135.18864811336, 81205.0, 81782.59108704478, 10328.277020608635, 10641.840372394421, 10820.78358432827, 11005.0, 11852.229605075643, 15135.848641513443, 15150.924245378703, 15189.468368607046, 15267.770983435257, 15273.0, 7979.281864632211, 8228.917710822934, 8265.214804593554, 8349.54077525742, 8359.080501144868, 7901.249381308767, 7934.920650793533, 8016.79958001043, 8079.272865442138, 8082.636281367352, 4700.2244629635725, 4735.171345014609, 4759.952400476021, 4798.328234047236, 4844.8304309349705, 1966.2823069579501, 1970.148060822822, 1992.8405727541763, 2015.6674148765583, 2050.0774651406628, 926.5321012888448, 1022.6471867205802, 1114.899659030691, 1163.9941800291115, 1169.8654654714646, 18504.484148012103, 18703.0, 18715.0, 18850.528736781416, 19235.0, 976.545906153642, 987.7185002274317, 1005.9195264378832, 1053.4206186597341, 1086.3156211586809, 10330.896691033144, 10647.84028239577, 10672.62645807393, 10694.037536621587, 10703.625373111903, 459570.0, 462777.0, 468509.0, 469267.0, 470418.0, 86106.56946715227, 86702.56648716716, 87571.56214218888, 87925.0, 88750.55624721835, 1048.124815778818, 1091.7871015151968, 1099.99350594207, 1104.1718710966775, 1109.3122264196088, 16370.0, 16525.51270385671, 16636.916815415847, 16667.166641667627, 17361.0, 40374.1925161501, 40620.39069413902, 41676.58323416727, 42516.787416062725, 42807.78596107124, 56022.1596676042, 58071.0, 58621.413785861594, 59742.0, 60624.696876515336, 8436.282915952213, 8558.315334773328, 8691.608877600649, 8712.39013269065, 8830.558472076242, 9681.37071090377, 12719.109662323548, 12862.742745144858, 13124.343782811013, 13566.659220095577, 11632.243904146204, 11672.0, 11988.700282492659, 12025.037996960047, 12086.456109474919, 5855.531557475307, 10433.530491127765, 10998.570185875786, 11157.721056973316, 11239.494222759831, 10688.786224275627, 10730.356178629307, 10901.509432075418, 11606.187566870576, 11626.651200463999, 8203.917960820316, 8264.48745861795, 8328.750137495885, 8330.583470826556, 8382.0, 8702.608382622924, 10831.783364332512, 11145.554177832795, 11841.348725820162, 12099.818502722643], "value": 9105.624808817214, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1513.8032055832741, 1521.2013692811277, 1670.7076261654215, 1745.485081900839, 1781.5011796696922, 7422.517536360133, 8117.675292988288, 8281.544515051677, 8797.208251257385, 8838.469691818495, 8286.047104582974, 8493.108223636522, 8575.528345940971, 8602.18279263469, 8611.095834937336, 2325.337278875525, 2356.5522550715395, 2361.9291421257303, 2366.9763302367014, 2367.3253122859987, 2336.2757545161053, 2343.16817529777, 2374.560706269337, 2376.6197408414655, 2379.179183181808, 2345.6012477878803, 2353.4234112642425, 2363.1728894886824, 2370.3126093432884, 2371.1819422299277, 2277.191596983072, 2294.208498068164, 2318.3508617586936, 2319.8376113672048, 2320.060375547906, 2346.378209774411, 2358.2807243790635, 2363.409147713072, 2370.6799582056547, 2390.40239940015, 8511.063782983867, 8522.14778522149, 8562.058173600899, 8579.399442039059, 8582.313414926854, 5198.934218485201, 5356.4107948125675, 5387.0303345397815, 5387.757550910218, 5392.514673679349, 3431.279431319426, 3478.843452044664, 3504.2641045380246, 3537.044997850566, 3540.822958852073, 1159.3797318434597, 1161.1465572803982, 1161.7618388230392, 1206.849143857018, 1222.6637674639455, 11894.464749086226, 11910.821337679941, 11936.940315298369, 11938.925496705251, 11941.64175074749, 4614.838480653161, 4652.348671186037, 4710.599599034121, 4755.762211889391, 4767.73777442244, 10071.0, 10086.546105425274, 10087.546060427298, 10095.697129086138, 10109.797804044025, 5248.763805628756, 5264.0261551613075, 5285.048691235615, 5285.894282114413, 5310.123829568155, 4075.9796201018803, 4681.368015317888, 4774.522547745198, 4795.688280261772, 4842.394700662418, 3795.3168429682923, 3816.6832442807186, 3896.4544963705102, 3901.141748815256, 3970.265500882288, 1242.45332053896, 1244.7510497900457, 1261.3188878005774, 1263.1726219326356, 1272.5037235478171, 932.7854593443546, 992.3004281981185, 1017.872765904262, 1043.8538604595362, 1045.5242864496788, 6081.118237855486, 6093.238345206849, 6101.420365065312, 6171.197744293303, 6220.284667263232, 457.1611093643136, 458.589562341709, 467.8526264226826, 469.19298806053536, 473.87679203406674, 4184.707070505096, 4185.142045880587, 4199.076203235283, 4231.809568569422, 4280.636145927569, 10199.643012494527, 10595.682129536126, 10621.522031508446, 10621.575136994588, 10632.149428045737, 10505.9474702626, 10519.94740026295, 10525.631602894015, 10539.314944528582, 10626.734331641615, 7673.577953212515, 7936.6031698414845, 7951.681932722627, 7991.0, 8127.187281271944, 6167.969160154171, 6307.621542707452, 6335.334789847, 6386.010168423902, 6403.391677790602, 9665.661701840401, 9935.403875767477, 10005.299629025898, 10101.343412678152, 10114.8482772757, 9948.950255248677, 10063.849042264226, 10123.532087847369, 10138.08757211825, 10175.389476631426, 6887.070245516791, 7199.280071992759, 7355.448341374526, 7647.426443016907, 7747.92252077472, 8159.918400815915, 8230.341572674051, 8244.505329680238, 8274.751757447286, 8283.875741863998, 7234.457415693949, 7448.143463501767, 7452.143003554661, 7471.775846724607, 7577.469577129548, 7130.0, 7284.162321333115, 7313.488055836253, 7345.22875098107, 7400.48196626231, 6862.279460656559, 6890.793276201722, 6955.0, 6961.095057642474, 6986.54587451814, 4919.754012299442, 4975.278584605285, 5037.319961805109, 5166.870828229325, 5183.015227106837, 5017.12200364942, 5146.588272938081, 5225.738713064407, 5299.364076310713, 5328.6802791832615], "value": 4535.144610919156, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.0874100073789, 334.5767603980964, 334.80581262867537, 335.4180496837987, 337.789026340569, 5547.33431988162, 5551.250581171541, 5658.745356458959, 5751.769929202832, 5759.884802303952, 5623.859403514914, 5637.267155269809, 5642.630095359948, 5654.491095801377, 5658.207850900877, 4380.08018316154, 4387.890302742425, 4390.40729501518, 4400.8679739607705, 4407.360932664769, 4164.292070348033, 4411.514733379326, 4420.756858372788, 4431.135928493945, 4442.577955094261, 4341.2836881914445, 4353.28170851809, 4360.585744354281, 4365.624828179113, 4377.7592232427205, 4402.86791396257, 4412.602865742067, 4413.82344706213, 4424.181526417623, 4426.9778651106535, 3859.807009649506, 3898.4542164097047, 3900.473436086149, 3956.8417263309434, 3985.940210896839, 5395.29861118056, 5450.3732070811575, 5459.808906688247, 5464.180372944051, 5470.972645136789, 5024.723640199788, 5031.874203144914, 5034.723090230036, 5058.949410505885, 5070.0, 5573.972130139364, 5880.911786323209, 5883.17635531026, 5902.704864756745, 5953.434423729739, 4210.789460526992, 4236.788160591958, 4258.318669012974, 4261.531231564525, 4274.29474136767, 6117.296510901214, 6131.049687298476, 6133.846653833645, 6200.286966998808, 6226.719797609073, 4221.197972385237, 4291.262038874261, 4298.290782020931, 4319.568043195655, 4347.782610869507, 4335.804888780012, 4342.739435633872, 4346.7179730641665, 4347.869563913087, 4355.825766969286, 4955.108080545464, 4966.751662416865, 5017.397912250553, 5020.497950205024, 5022.246663000579, 5624.803131890364, 5633.211350410946, 5771.913421298684, 5893.174955506232, 5933.724249286424, 1490.9712298513991, 1501.797257370263, 1514.674345015827, 1517.9829514225496, 1535.7696345548034, 960.7213907966611, 965.2663975378763, 967.511406739592, 983.9212862970945, 989.1443901025561, 5107.7446127693465, 5112.0, 5129.538341549279, 5148.871278218075, 5155.32980712505, 5358.946410535923, 5359.973200134053, 5377.5852333768335, 5379.704116273564, 5441.211024401518, 4990.830822427784, 5168.405633352138, 5199.542304367553, 5221.895562088813, 5246.055709972242, 2934.4424559333656, 2945.911622651324, 2945.9705402946124, 2949.675535691072, 2954.640865201988, 5547.944520554824, 5548.86127846799, 5554.805581804618, 5559.749056462345, 5623.325200975909, 5052.9747351263, 5459.208414779835, 5463.951018368112, 5465.344158700902, 5466.938514431931, 5518.475744804237, 5527.944720552743, 5531.865967476658, 5564.998300305902, 5572.860678482989, 5189.818356357509, 5320.733963301896, 5398.35219773614, 5415.620906536505, 5419.832067173163, 5296.378292744962, 5343.492368225013, 5356.3572371315695, 5358.794271288929, 5435.864103397446, 5525.171224316224, 5534.889302214014, 5583.302087239095, 5621.775128994795, 5707.914381284367, 3852.94220586697, 3961.9405708913814, 4001.519817621904, 4008.899777505469, 4025.6376926076796, 5381.040427764792, 5383.515483606494, 5420.891582168256, 5971.313298970674, 6101.725422355916, 5843.2695913010875, 5972.70136493165, 5983.970080149571, 5989.730462129128, 5991.3409524953095, 5932.377100404396, 5951.226340575698, 5969.552283578662, 5978.8206353809455, 5990.580659353804, 5670.262865827416, 5861.238039054895, 5874.5020019894655, 5874.823755287348, 5880.353161152184, 6033.336333003278, 6052.939470605237, 6053.969730151321, 6061.15143879866, 6091.512678985582, 5613.943860561342, 5863.501602363847, 5873.647581145145, 5879.382664820132, 5914.674692891932], "value": 4346.966634260215, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.8039519527326, 756.1833220122269, 826.5330088499998, 862.0431321233434, 874.8250349930014, 13866.37601307941, 15828.683426331467, 16002.279897404616, 16648.417305394312, 16684.0, 15350.846491535109, 15409.229538523085, 15428.460003899865, 15516.069035857856, 15521.456749013787, 683.835879388948, 814.5275740070745, 836.2557323981662, 841.7054031089131, 843.0515669871395, 815.2092470303826, 819.6803246733779, 820.3929092471558, 824.8432797768435, 826.2274773087182, 874.3442418186361, 876.430320291809, 879.7536689726886, 880.995595022024, 883.9602217900177, 863.5034854958393, 868.8349213649386, 871.5163084488106, 874.5583480342418, 877.793718476164, 639.0446282807186, 639.5682914033056, 641.3137942401632, 642.5566359212129, 644.0757512968858, 15252.694946101015, 15254.542363729106, 15263.465778697693, 15289.159096249701, 15305.311260993281, 15803.841961580467, 16026.679466410724, 16147.677046459123, 16273.349066037345, 16340.75488867668, 11537.653870383901, 11757.470913808898, 11821.0, 11903.22629029119, 11959.0, 3953.5651078381356, 3960.5049368828895, 3989.740666856645, 4073.490813648294, 4139.937900931488, 72351.63824180898, 73831.63084184598, 74143.0, 74221.25778742197, 75662.62168689231, 11361.772764544663, 11619.186656934102, 11956.58151964677, 12270.32513211782, 12337.753244935231, 20391.694124588143, 21159.365219043146, 22315.776842231695, 22348.664770028463, 22429.32712018642, 9235.399699019677, 9354.485503297385, 9386.249100071978, 9416.435013899189, 9548.140667339972, 4844.006978569385, 4894.339264199359, 4956.826511072095, 4974.950250497521, 5136.8715782105, 3554.3779838528153, 3685.594584595692, 3708.5364329458816, 3710.9257814843554, 3713.7400381973002, 658.4798009572385, 660.3462572053633, 661.9635920024444, 667.3926726678797, 672.1295921781305, 774.194837369141, 782.5852298281919, 792.9127795942442, 797.4736673795268, 810.9716159934374, 10027.247956403298, 10102.545385457672, 10198.592056317813, 10481.0, 10734.248602597743, 645.3997782062727, 719.6509692798988, 755.8752805786984, 762.0588573112202, 773.4083426178978, 4920.655554111249, 5006.048850718352, 5046.116929537389, 5056.216286475602, 5060.367454068241, 66787.0, 71636.0, 72150.63924680343, 72366.63816680988, 72414.63792681108, 67034.66482667653, 74756.62621686856, 106958.46520767346, 107685.46157269164, 107758.46120769346, 89505.55247223722, 90302.32430243371, 90725.6615974139, 92482.0, 93513.53243233741, 9540.0, 9593.568289426852, 9608.0, 9633.181179599533, 9721.854172187564, 53400.0, 54466.45533544614, 54947.450525494234, 55455.44544554664, 56390.154147687, 75397.62301188459, 78333.60833195798, 80575.0, 80853.59573202331, 81782.0, 12714.173578717353, 12939.288339141438, 13124.475020999053, 13254.072214944861, 13333.599992000256, 14122.916542798623, 14150.929245354118, 14402.927985360006, 14537.273136343352, 14576.927115364779, 13179.275139867399, 13235.404406801525, 13308.86691133115, 13456.614225791174, 14005.929970350084, 13325.400356984153, 13373.39819708096, 13389.263590502227, 13436.261005644783, 14176.858231417555, 13110.737785244433, 13128.277944713132, 13200.471981120647, 13240.735185296433, 13541.661458463617, 10538.789224215627, 10768.623098191525, 10862.402567858844, 11118.499667515143, 11141.331520108819, 11297.491612877277, 11404.771904562029, 11623.88376116228, 11692.415379231175, 11707.473163707484], "value": 7669.3589708783775, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 111.0, 112.0, 111.0, 110.0, 109.0, 111.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 153.0, 192.0, 126.0, 156.0, 159.0, 127.0, 180.0, 127.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 164.0, 163.0, 166.0, 167.0, 163.0, 163.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 154.0, 76.0, 76.0, 74.0, 76.0, 176.0, 75.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 155.0, 86.0, 84.0, 84.0, 143.0, 84.0, 84.0, 146.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 147.0, 150.0, 147.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 97.0, 96.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 53.0, 55.0, 53.0, 54.0, 55.0, 53.0, 54.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 61.0, 61.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 86.0, 81.0, 81.0, 87.0, 84.0, 80.0, 81.0, 107.0, 81.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 123.0, 123.0, 130.0, 122.0, 135.0, 125.0, 126.0, 138.0, 133.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 157.0, 163.0, 158.0, 166.0, 160.0, 159.0, 157.0, 161.0, 159.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 62.0, 63.0, 63.0, 63.0, 67.0, 64.0, 71.0, 63.0, 66.0], "value": 64.9, "unit": "score"}]}]} 10:22:04 INFO - Return code: 0 10:22:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:22:04 ERROR - # TBPL SUCCESS # 10:22:04 INFO - Running post-action listener: _resource_record_post_action 10:22:04 INFO - ##### 10:22:04 INFO - ##### Finished run-tests step (success) 10:22:04 INFO - ##### 10:22:04 INFO - Running post-run listener: _resource_record_post_run 10:22:04 INFO - Total resource usage - Wall time: 1192s; CPU: 14.0%; Read bytes: 8192; Write bytes: 540286976; Read time: 36; Write time: 1291696 10:22:04 INFO - TinderboxPrint: CPU usage
13.6% 10:22:04 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 36 10:22:04 INFO - TinderboxPrint: I/O write bytes / time
540,286,976 / 1,291,696 10:22:04 INFO - TinderboxPrint: CPU idle
8,218.8 (86.4%) 10:22:04 INFO - TinderboxPrint: CPU user
1,224.7 (12.9%) 10:22:04 INFO - TinderboxPrint: Swap in / out
0 / 0 10:22:04 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 247992320; Read time: 0; Write time: 694052 10:22:04 INFO - run-tests - Wall time: 1176s; CPU: 14.0%; Read bytes: 8192; Write bytes: 292294656; Read time: 36; Write time: 597644 10:22:05 INFO - Running post-run listener: _upload_blobber_files 10:22:05 INFO - Blob upload gear active. 10:22:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:22:05 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 10:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:22:05 INFO - (blobuploader) - INFO - Open directory for files ... 10:22:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:22:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:22:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:06 INFO - (blobuploader) - INFO - Done attempting. 10:22:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:22:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:22:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:09 INFO - (blobuploader) - INFO - Done attempting. 10:22:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:22:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:22:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:10 INFO - (blobuploader) - INFO - Done attempting. 10:22:10 INFO - (blobuploader) - INFO - Iteration through files over. 10:22:10 INFO - Return code: 0 10:22:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:22:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:22:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/253df3b372004bce27b3e1c26d9ac102371e2d5185e39b6ca0e34b062682a3e0f4be455b613d1b25574fbc6b6426c9cc28a0c1bff5564c10651bc90c9aeaf8e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8de203a95dcf99b89420a1a5277cb37c56c56c179b49e9cc6a7830bc7f5e28e887f657b9a75702763194800927aafc815dc8e4ad5ff17cf12410624c7326174", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de7073c5290df908fadc9a095ba33cc77ab11a11c491fb68841a182a87dd042f6c3414a51b32bb715786f68427e7c022be9cc3e227a814a3ff8274a6c43c02fd"} 10:22:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:22:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:22:10 INFO - Contents: 10:22:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/253df3b372004bce27b3e1c26d9ac102371e2d5185e39b6ca0e34b062682a3e0f4be455b613d1b25574fbc6b6426c9cc28a0c1bff5564c10651bc90c9aeaf8e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8de203a95dcf99b89420a1a5277cb37c56c56c179b49e9cc6a7830bc7f5e28e887f657b9a75702763194800927aafc815dc8e4ad5ff17cf12410624c7326174", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de7073c5290df908fadc9a095ba33cc77ab11a11c491fb68841a182a87dd042f6c3414a51b32bb715786f68427e7c022be9cc3e227a814a3ff8274a6c43c02fd"} 10:22:10 INFO - Running post-run listener: copy_logs_to_upload_dir 10:22:10 INFO - Copying logs to upload dir... 10:22:10 INFO - mkdir: /builds/slave/test/build/upload/logs 10:22:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.728368 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-04 10:22:10.656205) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 10:22:10.659988) ========= 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=8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/253df3b372004bce27b3e1c26d9ac102371e2d5185e39b6ca0e34b062682a3e0f4be455b613d1b25574fbc6b6426c9cc28a0c1bff5564c10651bc90c9aeaf8e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8de203a95dcf99b89420a1a5277cb37c56c56c179b49e9cc6a7830bc7f5e28e887f657b9a75702763194800927aafc815dc8e4ad5ff17cf12410624c7326174", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de7073c5290df908fadc9a095ba33cc77ab11a11c491fb68841a182a87dd042f6c3414a51b32bb715786f68427e7c022be9cc3e227a814a3ff8274a6c43c02fd"} build_url:https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011431 build_url: 'https://queue.taskcluster.net/v1/task/CSfpc1i9RSCMeUWHOZoJ3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/253df3b372004bce27b3e1c26d9ac102371e2d5185e39b6ca0e34b062682a3e0f4be455b613d1b25574fbc6b6426c9cc28a0c1bff5564c10651bc90c9aeaf8e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8de203a95dcf99b89420a1a5277cb37c56c56c179b49e9cc6a7830bc7f5e28e887f657b9a75702763194800927aafc815dc8e4ad5ff17cf12410624c7326174", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de7073c5290df908fadc9a095ba33cc77ab11a11c491fb68841a182a87dd042f6c3414a51b32bb715786f68427e7c022be9cc3e227a814a3ff8274a6c43c02fd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 10:22:10.685648) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 10:22:10.685995) ========= 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=8783db0840cc980e80bb0bd400000236-1465058846.76867-46826410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 10:22:10.770457) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 10:22:10.770785) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 10:22:10.771106) ========= ========= Total master_lag: 0.19 =========