builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-064 starttime: 1467105870.05 results: success (0) buildid: 20160628010421 builduid: 1e3da39a26d8464da063d63b89e6302d revision: d87b76177b2f5cf0839d73becebb614ab8a9ef7f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 02:24:30.049015) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 02:24:30.049529) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 02:24:30.049850) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 02:24:30.068453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:24:30.068776) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 02:24:30-- 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% 69.7M=0s 2016-06-28 02:24:30 (69.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080474 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:24:30.164052) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:24:30.164435) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020393 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:24:30.220560) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:24:30.221002) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d87b76177b2f5cf0839d73becebb614ab8a9ef7f --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 d87b76177b2f5cf0839d73becebb614ab8a9ef7f --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=a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 02:24:30,492 truncating revision to first 12 chars 2016-06-28 02:24:30,492 Setting DEBUG logging. 2016-06-28 02:24:30,492 attempt 1/10 2016-06-28 02:24:30,492 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d87b76177b2f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 02:24:30,812 unpacking tar archive at: mozilla-central-d87b76177b2f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651264 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:24:30.886144) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 02:24:30.886527) ========= script_repo_revision: d87b76177b2f5cf0839d73becebb614ab8a9ef7f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 02:24:30.886976) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 02:24:30.887317) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 02:24:30.898931) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 48 secs) (at 2016-06-28 02:24:30.899649) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:24:31 INFO - MultiFileLogger online at 20160628 02:24:31 in /builds/slave/test 02:24:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 02:24:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:24:31 INFO - {'append_to_log': False, 02:24:31 INFO - 'base_work_dir': '/builds/slave/test', 02:24:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:24:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:24:31 INFO - 'branch': 'Firefox-Non-PGO', 02:24:31 INFO - 'buildbot_json_path': 'buildprops.json', 02:24:31 INFO - 'config_files': ('talos/linux_config.py',), 02:24:31 INFO - 'default_actions': ('clobber', 02:24:31 INFO - 'read-buildbot-config', 02:24:31 INFO - 'download-and-extract', 02:24:31 INFO - 'populate-webroot', 02:24:31 INFO - 'create-virtualenv', 02:24:31 INFO - 'install', 02:24:31 INFO - 'run-tests'), 02:24:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:24:31 INFO - 'download_minidump_stackwalk': True, 02:24:31 INFO - 'download_symbols': 'ondemand', 02:24:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:24:31 INFO - 'tooltool.py': '/tools/tooltool.py', 02:24:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:24:31 INFO - '/tools/misc-python/virtualenv.py')}, 02:24:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:24:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:24:31 INFO - 'installer_path': 'installer.exe', 02:24:31 INFO - 'log_level': 'info', 02:24:31 INFO - 'log_name': 'talos', 02:24:31 INFO - 'log_to_console': True, 02:24:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:24:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:24:31 INFO - 'opt_config_files': (), 02:24:31 INFO - 'pip_index': False, 02:24:31 INFO - 'sps_profile': False, 02:24:31 INFO - 'sps_profile_interval': 0, 02:24:31 INFO - 'suite': 'dromaeojs', 02:24:31 INFO - 'system_bits': '32', 02:24:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:24:31 INFO - 'title': 'talos-linux64-ix-064', 02:24:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:24:31 INFO - 'use_talos_json': True, 02:24:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:24:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:24:31 INFO - 'work_dir': 'build'} 02:24:31 INFO - ##### 02:24:31 INFO - ##### Running clobber step. 02:24:31 INFO - ##### 02:24:31 INFO - Running pre-action listener: _resource_record_pre_action 02:24:31 INFO - Running main action method: clobber 02:24:31 INFO - rmtree: /builds/slave/test/build 02:24:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:24:31 INFO - Running post-action listener: _resource_record_post_action 02:24:31 INFO - ##### 02:24:31 INFO - ##### Finished clobber step (success) 02:24:31 INFO - ##### 02:24:31 INFO - ##### 02:24:31 INFO - ##### Running read-buildbot-config step. 02:24:31 INFO - ##### 02:24:31 INFO - Running pre-action listener: _resource_record_pre_action 02:24:31 INFO - Running main action method: read_buildbot_config 02:24:31 INFO - Using buildbot properties: 02:24:31 INFO - { 02:24:31 INFO - "project": "", 02:24:31 INFO - "product": "firefox", 02:24:31 INFO - "script_repo_revision": "production", 02:24:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 02:24:31 INFO - "repository": "", 02:24:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 02:24:31 INFO - "buildid": "20160628010421", 02:24:31 INFO - "pgo_build": "False", 02:24:31 INFO - "basedir": "/builds/slave/test", 02:24:31 INFO - "buildnumber": 129, 02:24:31 INFO - "slavename": "talos-linux64-ix-064", 02:24:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:24:31 INFO - "platform": "ubuntu64_hw", 02:24:31 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 02:24:31 INFO - "branch": "mozilla-central", 02:24:31 INFO - "repo_path": "mozilla-central", 02:24:31 INFO - "revision": "d87b76177b2f5cf0839d73becebb614ab8a9ef7f", 02:24:31 INFO - "stage_platform": "linux64", 02:24:31 INFO - "builduid": "1e3da39a26d8464da063d63b89e6302d", 02:24:31 INFO - "slavebuilddir": "test" 02:24:31 INFO - } 02:24:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:24:31 INFO - Running post-action listener: _resource_record_post_action 02:24:31 INFO - ##### 02:24:31 INFO - ##### Finished read-buildbot-config step (success) 02:24:31 INFO - ##### 02:24:31 INFO - ##### 02:24:31 INFO - ##### Running download-and-extract step. 02:24:31 INFO - ##### 02:24:31 INFO - Running pre-action listener: _resource_record_pre_action 02:24:31 INFO - Running main action method: download_and_extract 02:24:31 INFO - mkdir: /builds/slave/test/build/tests 02:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:31 INFO - https://queue.taskcluster.net/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:24:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:24:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:24:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:24:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:24:32 INFO - Downloaded 1361 bytes. 02:24:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:24:32 INFO - Using the following test package requirements: 02:24:32 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:24:32 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:24:32 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:24:32 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:32 INFO - u'jsshell-linux-x86_64.zip'], 02:24:32 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:24:32 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:24:32 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:24:32 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:24:32 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:24:32 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:24:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:24:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:32 INFO - https://queue.taskcluster.net/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:24:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:24:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:24:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:24:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:24:33 INFO - Downloaded 22713290 bytes. 02:24:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:24:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:24:34 INFO - Return code: 0 02:24:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:24:34 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')]} 02:24:34 INFO - https://queue.taskcluster.net/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:24:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:24:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:24:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:24:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:24:35 INFO - Downloaded 22713290 bytes. 02:24:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:24:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:24:37 INFO - Return code: 0 02:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:24:37 INFO - https://queue.taskcluster.net/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:24:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:24:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:24:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:24:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:25:08 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip: The read operation timed out 02:25:08 INFO - retry: attempt #1 caught exception: The read operation timed out 02:25:08 INFO - retry: Failed, sleeping 30 seconds before retrying 02:25:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 02:25:39 INFO - Downloaded 14405240 bytes. 02:25:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:25:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:25:39 INFO - Return code: 0 02:25:39 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')]} 02:25:39 INFO - https://queue.taskcluster.net/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:25:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:25:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:25:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:25:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:25:43 INFO - Downloaded 56375188 bytes. 02:25:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:25:43 INFO - mkdir: /builds/slave/test/properties 02:25:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:25:43 INFO - Writing to file /builds/slave/test/properties/build_url 02:25:43 INFO - Contents: 02:25:43 INFO - build_url:https://queue.taskcluster.net/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:25:44 INFO - Running post-action listener: _resource_record_post_action 02:25:44 INFO - Running post-action listener: set_extra_try_arguments 02:25:44 INFO - ##### 02:25:44 INFO - ##### Finished download-and-extract step (success) 02:25:44 INFO - ##### 02:25:44 INFO - ##### 02:25:44 INFO - ##### Running populate-webroot step. 02:25:44 INFO - ##### 02:25:44 INFO - Running pre-action listener: _resource_record_pre_action 02:25:44 INFO - Running main action method: populate_webroot 02:25:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:25:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:25:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:25:44 INFO - '--tppagecycles', 02:25:44 INFO - '7'], 02:25:44 INFO - 'tests': ['tsvgm']}}, 02:25:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:25:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:25:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:25:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:25:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:25:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:25:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:44 INFO - 'talos_options': ['--disable-e10s'], 02:25:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:25:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:25:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:44 INFO - 'talos_options': ['--disable-e10s'], 02:25:44 INFO - 'tests': ['damp', 'tps']}, 02:25:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:44 INFO - 'tests': ['damp', 'tps']}, 02:25:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:25:44 INFO - 'tests': ['dromaeo_dom']}, 02:25:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:25:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:25:44 INFO - 'tests': ['basic_compositor_video']}, 02:25:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:25:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:25:44 INFO - 'tests': ['a11yr', 02:25:44 INFO - 'ts_paint', 02:25:44 INFO - 'tpaint', 02:25:44 INFO - 'sessionrestore', 02:25:44 INFO - 'sessionrestore_no_auto_restore', 02:25:44 INFO - 'tabpaint']}, 02:25:44 INFO - 'other-e10s': {'tests': ['a11yr', 02:25:44 INFO - 'ts_paint', 02:25:44 INFO - 'tpaint', 02:25:44 INFO - 'sessionrestore', 02:25:44 INFO - 'sessionrestore_no_auto_restore', 02:25:44 INFO - 'tabpaint']}, 02:25:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:25:44 INFO - 'ts_paint', 02:25:44 INFO - 'tpaint', 02:25:44 INFO - 'sessionrestore', 02:25:44 INFO - 'sessionrestore_no_auto_restore', 02:25:44 INFO - 'tabpaint']}, 02:25:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:25:44 INFO - 'ts_paint', 02:25:44 INFO - 'tpaint', 02:25:44 INFO - 'sessionrestore', 02:25:44 INFO - 'sessionrestore_no_auto_restore', 02:25:44 INFO - 'tabpaint']}, 02:25:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:25:44 INFO - 'tests': ['a11yr', 02:25:44 INFO - 'ts_paint', 02:25:44 INFO - 'tpaint', 02:25:44 INFO - 'sessionrestore', 02:25:44 INFO - 'sessionrestore_no_auto_restore', 02:25:44 INFO - 'tabpaint']}, 02:25:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:25:44 INFO - 'tests': ['a11yr', 02:25:44 INFO - 'ts_paint', 02:25:44 INFO - 'tpaint', 02:25:44 INFO - 'sessionrestore', 02:25:44 INFO - 'sessionrestore_no_auto_restore', 02:25:44 INFO - 'tabpaint']}, 02:25:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:25:44 INFO - 'tests': ['tsvgx', 02:25:44 INFO - 'tsvgr_opacity', 02:25:44 INFO - 'tart', 02:25:44 INFO - 'tscrollx', 02:25:44 INFO - 'cart']}, 02:25:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:25:44 INFO - 'tsvgr_opacity', 02:25:44 INFO - 'tart', 02:25:44 INFO - 'tscrollx', 02:25:44 INFO - 'cart']}, 02:25:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:44 INFO - 'talos_options': ['--disable-e10s'], 02:25:44 INFO - 'tests': ['tp5o']}, 02:25:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:44 INFO - 'tests': ['tp5o']}, 02:25:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:44 INFO - 'talos_options': ['--disable-e10s', 02:25:44 INFO - '--xperf_path', 02:25:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:25:44 INFO - 'tests': ['tp5n']}, 02:25:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:25:44 INFO - 'talos_options': ['--xperf_path', 02:25:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:25:44 INFO - 'tests': ['tp5n']}}, 02:25:44 INFO - 'talos.zip': {'path': '', 02:25:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:25:44 INFO - Running post-action listener: _resource_record_post_action 02:25:44 INFO - ##### 02:25:44 INFO - ##### Finished populate-webroot step (success) 02:25:44 INFO - ##### 02:25:44 INFO - ##### 02:25:44 INFO - ##### Running create-virtualenv step. 02:25:44 INFO - ##### 02:25:44 INFO - Running pre-action listener: _resource_record_pre_action 02:25:44 INFO - Running main action method: create_virtualenv 02:25:44 INFO - Creating virtualenv /builds/slave/test/build/venv 02:25:44 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 02:25:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:25:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:25:44 INFO - Using real prefix '/usr' 02:25:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:25:44 INFO - Installing distribute.............................................................................................................................................................................................done. 02:25:46 INFO - Installing pip.................done. 02:25:46 INFO - Return code: 0 02:25:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:46 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 0x7f6e46c14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe9520>, '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 0xfea420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea8b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', '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 02:25:46 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 02:25:46 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 02:25:46 INFO - Using env: {'DISPLAY': ':0', 02:25:46 INFO - 'HOME': '/home/cltbld', 02:25:46 INFO - 'LANG': 'en_US.UTF-8', 02:25:46 INFO - 'LANGUAGE': 'en_US:en', 02:25:46 INFO - 'LOGNAME': 'cltbld', 02:25:46 INFO - 'MAIL': '/var/mail/cltbld', 02:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:46 INFO - 'MOZ_NO_REMOTE': '1', 02:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:46 INFO - 'NO_EM_RESTART': '1', 02:25:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:46 INFO - 'PWD': '/builds/slave/test', 02:25:46 INFO - 'SHELL': '/bin/bash', 02:25:46 INFO - 'SHLVL': '1', 02:25:46 INFO - 'TERM': 'linux', 02:25:46 INFO - 'TMOUT': '86400', 02:25:46 INFO - 'USER': 'cltbld', 02:25:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', 02:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:46 INFO - '_': '/tools/buildbot/bin/python'} 02:25:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:46 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 02:25:46 INFO - Cleaning up... 02:25:46 INFO - Return code: 0 02:25:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:46 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 0x7f6e46c14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe9520>, '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 0xfea420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea8b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', '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 02:25:46 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 02:25:46 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 02:25:46 INFO - Using env: {'DISPLAY': ':0', 02:25:46 INFO - 'HOME': '/home/cltbld', 02:25:46 INFO - 'LANG': 'en_US.UTF-8', 02:25:46 INFO - 'LANGUAGE': 'en_US:en', 02:25:46 INFO - 'LOGNAME': 'cltbld', 02:25:46 INFO - 'MAIL': '/var/mail/cltbld', 02:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:46 INFO - 'MOZ_NO_REMOTE': '1', 02:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:46 INFO - 'NO_EM_RESTART': '1', 02:25:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:46 INFO - 'PWD': '/builds/slave/test', 02:25:46 INFO - 'SHELL': '/bin/bash', 02:25:46 INFO - 'SHLVL': '1', 02:25:46 INFO - 'TERM': 'linux', 02:25:46 INFO - 'TMOUT': '86400', 02:25:46 INFO - 'USER': 'cltbld', 02:25:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', 02:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:46 INFO - '_': '/tools/buildbot/bin/python'} 02:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:47 INFO - Downloading/unpacking psutil>=3.1.1 02:25:47 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 02:25:47 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 02:25:47 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 02:25:47 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 02:25:47 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 02:25:47 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 02:25:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:25:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:25:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:25:49 INFO - Installing collected packages: psutil 02:25:49 INFO - Running setup.py install for psutil 02:25:49 INFO - building 'psutil._psutil_linux' extension 02:25:49 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 02:25:49 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 02:25:49 INFO - building 'psutil._psutil_posix' extension 02:25:49 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 02:25:49 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 02:25:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:25:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:25:49 INFO - Successfully installed psutil 02:25:49 INFO - Cleaning up... 02:25:49 INFO - Return code: 0 02:25:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:25: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')]} 02:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25: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')]} 02:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6e46c14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe9520>, '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 0xfea420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea8b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', '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 02:25: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:25: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 mozsystemmonitor==0.3 02:25:49 INFO - Using env: {'DISPLAY': ':0', 02:25:49 INFO - 'HOME': '/home/cltbld', 02:25:49 INFO - 'LANG': 'en_US.UTF-8', 02:25:49 INFO - 'LANGUAGE': 'en_US:en', 02:25:49 INFO - 'LOGNAME': 'cltbld', 02:25:49 INFO - 'MAIL': '/var/mail/cltbld', 02:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:49 INFO - 'MOZ_NO_REMOTE': '1', 02:25:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:49 INFO - 'NO_EM_RESTART': '1', 02:25:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:49 INFO - 'PWD': '/builds/slave/test', 02:25:49 INFO - 'SHELL': '/bin/bash', 02:25:49 INFO - 'SHLVL': '1', 02:25:49 INFO - 'TERM': 'linux', 02:25:49 INFO - 'TMOUT': '86400', 02:25:49 INFO - 'USER': 'cltbld', 02:25:49 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', 02:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:49 INFO - '_': '/tools/buildbot/bin/python'} 02:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:25:49 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 02:25:49 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 02:25:49 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 02:25:49 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 02:25:49 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 02:25:49 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 02:25:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:25:52 INFO - Installing collected packages: mozsystemmonitor 02:25:52 INFO - Running setup.py install for mozsystemmonitor 02:25:53 INFO - Successfully installed mozsystemmonitor 02:25:53 INFO - Cleaning up... 02:25:53 INFO - Return code: 0 02:25:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6e46c14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe9520>, '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 0xfea420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea8b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', '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 02:25:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:25:53 INFO - Using env: {'DISPLAY': ':0', 02:25:53 INFO - 'HOME': '/home/cltbld', 02:25:53 INFO - 'LANG': 'en_US.UTF-8', 02:25:53 INFO - 'LANGUAGE': 'en_US:en', 02:25:53 INFO - 'LOGNAME': 'cltbld', 02:25:53 INFO - 'MAIL': '/var/mail/cltbld', 02:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:53 INFO - 'MOZ_NO_REMOTE': '1', 02:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:53 INFO - 'NO_EM_RESTART': '1', 02:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:53 INFO - 'PWD': '/builds/slave/test', 02:25:53 INFO - 'SHELL': '/bin/bash', 02:25:53 INFO - 'SHLVL': '1', 02:25:53 INFO - 'TERM': 'linux', 02:25:53 INFO - 'TMOUT': '86400', 02:25:53 INFO - 'USER': 'cltbld', 02:25:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', 02:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:53 INFO - '_': '/tools/buildbot/bin/python'} 02:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:53 INFO - Downloading/unpacking jsonschema==2.5.1 02:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:25:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:25: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 02:25: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 02:25: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 02:25: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 02:25: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 02:25: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 02:25:55 INFO - Downloading functools32-3.2.3-2.tar.gz 02:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:25:55 INFO - warning: no files found matching '*.txt' 02:25:55 INFO - no previously-included directories found matching 'build' 02:25:55 INFO - no previously-included directories found matching 'dist' 02:25:55 INFO - no previously-included directories found matching '.git*' 02:25:55 INFO - Installing collected packages: jsonschema, functools32 02:25:55 INFO - Running setup.py install for functools32 02:25:55 INFO - warning: no files found matching '*.txt' 02:25:55 INFO - no previously-included directories found matching 'build' 02:25:55 INFO - no previously-included directories found matching 'dist' 02:25:55 INFO - no previously-included directories found matching '.git*' 02:25:55 INFO - Successfully installed jsonschema functools32 02:25:55 INFO - Cleaning up... 02:25:55 INFO - Return code: 0 02:25:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6e46c14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe9520>, '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 0xfea420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea8b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', '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 02:25:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:25:55 INFO - Using env: {'DISPLAY': ':0', 02:25:55 INFO - 'HOME': '/home/cltbld', 02:25:55 INFO - 'LANG': 'en_US.UTF-8', 02:25:55 INFO - 'LANGUAGE': 'en_US:en', 02:25:55 INFO - 'LOGNAME': 'cltbld', 02:25:55 INFO - 'MAIL': '/var/mail/cltbld', 02:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:55 INFO - 'MOZ_NO_REMOTE': '1', 02:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:55 INFO - 'NO_EM_RESTART': '1', 02:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:55 INFO - 'PWD': '/builds/slave/test', 02:25:55 INFO - 'SHELL': '/bin/bash', 02:25:55 INFO - 'SHLVL': '1', 02:25:55 INFO - 'TERM': 'linux', 02:25:55 INFO - 'TMOUT': '86400', 02:25:55 INFO - 'USER': 'cltbld', 02:25:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', 02:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:55 INFO - '_': '/tools/buildbot/bin/python'} 02:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:55 INFO - Downloading/unpacking blobuploader==1.2.4 02:25: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 02:25: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 02:25: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 02:25: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 02:25: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 02:25: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 02:25:57 INFO - Downloading blobuploader-1.2.4.tar.gz 02:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:25:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:25: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 02:25: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 02:25: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 02:25: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 02:25: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 02:25: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 02:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:25:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:58 INFO - Downloading docopt-0.6.1.tar.gz 02:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:25:58 INFO - Installing collected packages: blobuploader, requests, docopt 02:25:58 INFO - Running setup.py install for blobuploader 02:25:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:25:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:25:58 INFO - Running setup.py install for requests 02:25:59 INFO - Running setup.py install for docopt 02:25:59 INFO - Successfully installed blobuploader requests docopt 02:25:59 INFO - Cleaning up... 02:25:59 INFO - Return code: 0 02:25:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:59 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 0x7f6e46c14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe9520>, '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 0xfea420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea8b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', '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 02:25:59 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 02:25:59 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 02:25:59 INFO - Using env: {'DISPLAY': ':0', 02:25:59 INFO - 'HOME': '/home/cltbld', 02:25:59 INFO - 'LANG': 'en_US.UTF-8', 02:25:59 INFO - 'LANGUAGE': 'en_US:en', 02:25:59 INFO - 'LOGNAME': 'cltbld', 02:25:59 INFO - 'MAIL': '/var/mail/cltbld', 02:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:59 INFO - 'MOZ_NO_REMOTE': '1', 02:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:25:59 INFO - 'NO_EM_RESTART': '1', 02:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:59 INFO - 'PWD': '/builds/slave/test', 02:25:59 INFO - 'SHELL': '/bin/bash', 02:25:59 INFO - 'SHLVL': '1', 02:25:59 INFO - 'TERM': 'linux', 02:25:59 INFO - 'TMOUT': '86400', 02:25:59 INFO - 'USER': 'cltbld', 02:25:59 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', 02:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:59 INFO - '_': '/tools/buildbot/bin/python'} 02:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:25:59 INFO - Running setup.py (path:/tmp/pip-J4wdkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:25:59 INFO - Running setup.py (path:/tmp/pip-3GLLOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:25:59 INFO - Running setup.py (path:/tmp/pip-gn3yLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:25:59 INFO - Running setup.py (path:/tmp/pip-wdoSKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:25:59 INFO - Running setup.py (path:/tmp/pip-2C1PnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:25:59 INFO - Running setup.py (path:/tmp/pip-OSQvUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:25:59 INFO - Running setup.py (path:/tmp/pip-fl9YI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:25:59 INFO - Running setup.py (path:/tmp/pip-8A0E04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:25:59 INFO - Running setup.py (path:/tmp/pip-leB9FC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:26:00 INFO - Running setup.py (path:/tmp/pip-YRcyXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:26:00 INFO - Running setup.py (path:/tmp/pip-42q83Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:26:00 INFO - Running setup.py (path:/tmp/pip-s0rokg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:26:00 INFO - Running setup.py (path:/tmp/pip-BuCAsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:26:00 INFO - Running setup.py (path:/tmp/pip-T0tIOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:00 INFO - Running setup.py (path:/tmp/pip-fLCaXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:26:00 INFO - Running setup.py (path:/tmp/pip-axXY8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:26:00 INFO - Running setup.py (path:/tmp/pip-NmJclG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:26:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:26:00 INFO - Running setup.py install for manifestparser 02:26:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:26:00 INFO - Running setup.py install for mozcrash 02:26:00 INFO - Running setup.py install for mozdebug 02:26:00 INFO - Running setup.py install for mozdevice 02:26:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:26:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:26:01 INFO - Running setup.py install for mozfile 02:26:01 INFO - Running setup.py install for mozhttpd 02:26:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:26:01 INFO - Running setup.py install for mozinfo 02:26:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:26:01 INFO - Running setup.py install for mozInstall 02:26:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:26:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:26:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:26:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:26:01 INFO - Running setup.py install for mozleak 02:26:01 INFO - Running setup.py install for mozlog 02:26:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:26:01 INFO - Running setup.py install for moznetwork 02:26:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:26:01 INFO - Running setup.py install for mozprocess 02:26:01 INFO - Running setup.py install for mozprofile 02:26:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:26:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:26:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:26:02 INFO - Running setup.py install for mozrunner 02:26:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:26:02 INFO - Running setup.py install for mozscreenshot 02:26:02 INFO - Running setup.py install for moztest 02:26:02 INFO - Running setup.py install for mozversion 02:26:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:26:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:26:02 INFO - Cleaning up... 02:26:02 INFO - Return code: 0 02:26:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:02 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 0x7f6e46c14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe9520>, '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 0xfea420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea8b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', '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 02:26:02 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 02:26:02 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 02:26:02 INFO - Using env: {'DISPLAY': ':0', 02:26:02 INFO - 'HOME': '/home/cltbld', 02:26:02 INFO - 'LANG': 'en_US.UTF-8', 02:26:02 INFO - 'LANGUAGE': 'en_US:en', 02:26:02 INFO - 'LOGNAME': 'cltbld', 02:26:02 INFO - 'MAIL': '/var/mail/cltbld', 02:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:02 INFO - 'MOZ_NO_REMOTE': '1', 02:26:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:02 INFO - 'NO_EM_RESTART': '1', 02:26:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:02 INFO - 'PWD': '/builds/slave/test', 02:26:02 INFO - 'SHELL': '/bin/bash', 02:26:02 INFO - 'SHLVL': '1', 02:26:02 INFO - 'TERM': 'linux', 02:26:02 INFO - 'TMOUT': '86400', 02:26:02 INFO - 'USER': 'cltbld', 02:26:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', 02:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:02 INFO - '_': '/tools/buildbot/bin/python'} 02:26:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:26:02 INFO - Running setup.py (path:/tmp/pip-dqfW6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:26:02 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)) 02:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:26:02 INFO - Running setup.py (path:/tmp/pip-fEz01l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:26:02 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)) 02:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:26:02 INFO - Running setup.py (path:/tmp/pip-fby7f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:26:02 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)) 02:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:26:02 INFO - Running setup.py (path:/tmp/pip-4oUDsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:26:02 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)) 02:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:26:02 INFO - Running setup.py (path:/tmp/pip-zo9ytP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:26:03 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)) 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:26:03 INFO - Running setup.py (path:/tmp/pip-9LPjcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:26:03 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)) 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:26:03 INFO - Running setup.py (path:/tmp/pip-PNDoL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:26:03 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)) 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:26:03 INFO - Running setup.py (path:/tmp/pip-qdvlRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:26:03 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)) 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:26:03 INFO - Running setup.py (path:/tmp/pip-FqJzPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:26:03 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)) 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:26:03 INFO - Running setup.py (path:/tmp/pip-iDV7lQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:26:03 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)) 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:26:03 INFO - Running setup.py (path:/tmp/pip-qj_PLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:26:03 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)) 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:26:03 INFO - Running setup.py (path:/tmp/pip-6ZCMWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:26:03 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)) 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:26:03 INFO - Running setup.py (path:/tmp/pip-x9G6_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:26:03 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)) 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:26:03 INFO - Running setup.py (path:/tmp/pip-WZtLKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:26:03 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)) 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:03 INFO - Running setup.py (path:/tmp/pip-jiiP1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:03 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)) 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:26:03 INFO - Running setup.py (path:/tmp/pip-EIO8h4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:26:03 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)) 02:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:26:03 INFO - Running setup.py (path:/tmp/pip-ube6kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:26:03 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)) 02:26:03 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)) 02:26:03 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)) 02:26:03 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)) 02:26:03 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)) 02:26:03 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)) 02:26:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:26:03 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 02:26:03 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 02:26:03 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 02:26:03 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 02:26:03 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 02:26:03 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 02:26:05 INFO - Downloading blessings-1.6.tar.gz 02:26:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:26:06 INFO - Installing collected packages: blessings 02:26:06 INFO - Running setup.py install for blessings 02:26:06 INFO - Successfully installed blessings 02:26:06 INFO - Cleaning up... 02:26:06 INFO - Return code: 0 02:26:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:26:06 INFO - Reading from file tmpfile_stdout 02:26:06 INFO - Current package versions: 02:26:06 INFO - argparse == 1.2.1 02:26:06 INFO - blessings == 1.6 02:26:06 INFO - blobuploader == 1.2.4 02:26:06 INFO - docopt == 0.6.1 02:26:06 INFO - functools32 == 3.2.3-2 02:26:06 INFO - jsonschema == 2.5.1 02:26:06 INFO - manifestparser == 1.1 02:26:06 INFO - mozInstall == 1.12 02:26:06 INFO - mozcrash == 0.17 02:26:06 INFO - mozdebug == 0.1 02:26:06 INFO - mozdevice == 0.48 02:26:06 INFO - mozfile == 1.2 02:26:06 INFO - mozhttpd == 0.7 02:26:06 INFO - mozinfo == 0.9 02:26:06 INFO - mozleak == 0.1 02:26:06 INFO - mozlog == 3.2 02:26:06 INFO - moznetwork == 0.27 02:26:06 INFO - mozprocess == 0.22 02:26:06 INFO - mozprofile == 0.28 02:26:06 INFO - mozrunner == 6.11 02:26:06 INFO - mozscreenshot == 0.1 02:26:06 INFO - mozsystemmonitor == 0.3 02:26:06 INFO - moztest == 0.7 02:26:06 INFO - mozversion == 1.4 02:26:06 INFO - psutil == 3.1.1 02:26:06 INFO - requests == 1.2.3 02:26:06 INFO - wsgiref == 0.1.2 02:26:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26:06 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')]} 02:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:06 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')]} 02:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:06 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 0x7f6e46c14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe9520>, '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 0xfea420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea8b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', '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 02:26:06 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 02:26:06 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 02:26:06 INFO - Using env: {'DISPLAY': ':0', 02:26:06 INFO - 'HOME': '/home/cltbld', 02:26:06 INFO - 'LANG': 'en_US.UTF-8', 02:26:06 INFO - 'LANGUAGE': 'en_US:en', 02:26:06 INFO - 'LOGNAME': 'cltbld', 02:26:06 INFO - 'MAIL': '/var/mail/cltbld', 02:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:06 INFO - 'MOZ_NO_REMOTE': '1', 02:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:06 INFO - 'NO_EM_RESTART': '1', 02:26:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:06 INFO - 'PWD': '/builds/slave/test', 02:26:06 INFO - 'SHELL': '/bin/bash', 02:26:06 INFO - 'SHLVL': '1', 02:26:06 INFO - 'TERM': 'linux', 02:26:06 INFO - 'TMOUT': '86400', 02:26:06 INFO - 'USER': 'cltbld', 02:26:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', 02:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:06 INFO - '_': '/tools/buildbot/bin/python'} 02:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:06 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)) 02:26:06 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)) 02:26:06 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)) 02:26:06 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)) 02:26:06 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)) 02:26:06 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)) 02:26:06 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)) 02:26:06 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)) 02:26:06 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)) 02:26:06 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)) 02:26:06 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)) 02:26:06 INFO - Cleaning up... 02:26:06 INFO - Return code: 0 02:26:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:26:06 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')]} 02:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:06 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')]} 02:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:06 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 0x7f6e46c14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe9520>, '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 0xfea420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea8b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', '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 02:26:06 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 02:26:06 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 02:26:06 INFO - Using env: {'DISPLAY': ':0', 02:26:06 INFO - 'HOME': '/home/cltbld', 02:26:06 INFO - 'LANG': 'en_US.UTF-8', 02:26:06 INFO - 'LANGUAGE': 'en_US:en', 02:26:06 INFO - 'LOGNAME': 'cltbld', 02:26:06 INFO - 'MAIL': '/var/mail/cltbld', 02:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:06 INFO - 'MOZ_NO_REMOTE': '1', 02:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:06 INFO - 'NO_EM_RESTART': '1', 02:26:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:06 INFO - 'PWD': '/builds/slave/test', 02:26:06 INFO - 'SHELL': '/bin/bash', 02:26:06 INFO - 'SHLVL': '1', 02:26:06 INFO - 'TERM': 'linux', 02:26:06 INFO - 'TMOUT': '86400', 02:26:06 INFO - 'USER': 'cltbld', 02:26:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', 02:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:06 INFO - '_': '/tools/buildbot/bin/python'} 02:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:26:06 INFO - Cleaning up... 02:26:06 INFO - Return code: 0 02:26:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:26:06 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')]} 02:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:06 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')]} 02:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:06 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 0x7f6e46c14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5a7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe9520>, '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 0xfea420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea8b0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', '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 02:26:06 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 02:26:06 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 02:26:06 INFO - Using env: {'DISPLAY': ':0', 02:26:06 INFO - 'HOME': '/home/cltbld', 02:26:06 INFO - 'LANG': 'en_US.UTF-8', 02:26:06 INFO - 'LANGUAGE': 'en_US:en', 02:26:06 INFO - 'LOGNAME': 'cltbld', 02:26:06 INFO - 'MAIL': '/var/mail/cltbld', 02:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:06 INFO - 'MOZ_NO_REMOTE': '1', 02:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:06 INFO - 'NO_EM_RESTART': '1', 02:26:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:06 INFO - 'PWD': '/builds/slave/test', 02:26:06 INFO - 'SHELL': '/bin/bash', 02:26:06 INFO - 'SHLVL': '1', 02:26:06 INFO - 'TERM': 'linux', 02:26:06 INFO - 'TMOUT': '86400', 02:26:06 INFO - 'USER': 'cltbld', 02:26:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', 02:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:06 INFO - '_': '/tools/buildbot/bin/python'} 02:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:07 INFO - Downloading/unpacking flake8 02:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:26:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:26:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:26:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:26:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:26:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:26:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:26:09 INFO - no previously-included directories found matching 'docs/_build' 02:26:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:26:09 INFO - Running setup.py install for pep8 02:26:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:26:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:26:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:26:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:26:09 INFO - no previously-included directories found matching 'docs/_build' 02:26:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:26:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:26:09 INFO - Cleaning up... 02:26:09 INFO - Return code: 0 02:26:09 INFO - Running post-action listener: _resource_record_post_action 02:26:09 INFO - Running post-action listener: _start_resource_monitoring 02:26:10 INFO - Starting resource monitoring. 02:26:10 INFO - ##### 02:26:10 INFO - ##### Finished create-virtualenv step (success) 02:26:10 INFO - ##### 02:26:10 INFO - ##### 02:26:10 INFO - ##### Running install step. 02:26:10 INFO - ##### 02:26:10 INFO - Running pre-action listener: _resource_record_pre_action 02:26:10 INFO - Running main action method: install 02:26:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:26:10 INFO - Reading from file tmpfile_stdout 02:26:10 INFO - Detecting whether we're running mozinstall >=1.0... 02:26:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:26:10 INFO - Reading from file tmpfile_stdout 02:26:10 INFO - Output received: 02:26:10 INFO - Usage: mozinstall [options] installer 02:26:10 INFO - Options: 02:26:10 INFO - -h, --help show this help message and exit 02:26:10 INFO - -d DEST, --destination=DEST 02:26:10 INFO - Directory to install application into. [default: 02:26:10 INFO - "/builds/slave/test"] 02:26:10 INFO - --app=APP Application being installed. [default: firefox] 02:26:10 INFO - mkdir: /builds/slave/test/build/application 02:26:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:26:26 INFO - Reading from file tmpfile_stdout 02:26:26 INFO - Output received: 02:26:26 INFO - /builds/slave/test/build/application/firefox/firefox 02:26:26 INFO - Running post-action listener: _resource_record_post_action 02:26:26 INFO - ##### 02:26:26 INFO - ##### Finished install step (success) 02:26:26 INFO - ##### 02:26:26 INFO - ##### 02:26:26 INFO - ##### Running run-tests step. 02:26:26 INFO - ##### 02:26:26 INFO - Running pre-action listener: _resource_record_pre_action 02:26:26 INFO - Running main action method: run_tests 02:26:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:26:26 INFO - Python 2.7.3 02:26:26 INFO - Return code: 0 02:26:26 INFO - grabbing minidump binary from tooltool 02:26:26 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')]} 02:26:26 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 0xfe9520>, '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 0xfea420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfea8b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:26:26 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 02:26:26 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 02:26:26 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 02:26:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:26:26 INFO - Return code: 0 02:26:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:26:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:26:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:26:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:26:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:26:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:26:27 INFO - Return code: 0 02:26:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:26:27 INFO - Using env: {'DISPLAY': ':0', 02:26:27 INFO - 'HOME': '/home/cltbld', 02:26:27 INFO - 'LANG': 'en_US.UTF-8', 02:26:27 INFO - 'LANGUAGE': 'en_US:en', 02:26:27 INFO - 'LOGNAME': 'cltbld', 02:26:27 INFO - 'MAIL': '/var/mail/cltbld', 02:26:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:26:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:27 INFO - 'MOZ_NO_REMOTE': '1', 02:26:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:26:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:27 INFO - 'NO_EM_RESTART': '1', 02:26:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:27 INFO - 'PWD': '/builds/slave/test', 02:26:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:26:27 INFO - 'SHELL': '/bin/bash', 02:26:27 INFO - 'SHLVL': '1', 02:26:27 INFO - 'TERM': 'linux', 02:26:27 INFO - 'TMOUT': '86400', 02:26:27 INFO - 'USER': 'cltbld', 02:26:27 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074', 02:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:27 INFO - '_': '/tools/buildbot/bin/python'} 02:26:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:26:27 INFO - mozversion application_buildid: 20160628010421 02:26:27 INFO - mozversion application_changeset: d87b76177b2f5cf0839d73becebb614ab8a9ef7f 02:26:27 INFO - mozversion application_display_name: Nightly 02:26:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:26:27 INFO - mozversion application_name: Firefox 02:26:27 INFO - mozversion application_remotingname: firefox 02:26:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:26:27 INFO - mozversion application_vendor: Mozilla 02:26:27 INFO - mozversion application_version: 50.0a1 02:26:27 INFO - mozversion platform_buildid: 20160628010421 02:26:27 INFO - mozversion platform_changeset: d87b76177b2f5cf0839d73becebb614ab8a9ef7f 02:26:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:26:27 INFO - mozversion platform_version: 50.0a1 02:26:27 INFO - using testdate: 1467105987 02:26:27 INFO - actual date: 1467105987 02:26:27 INFO - starting webserver on 'localhost:57581' 02:26:27 INFO - SUITE-START | Running 2 tests 02:26:27 INFO - TEST-START | dromaeo_css 02:26:27 INFO - operating with platform_type : linux_ 02:26:27 INFO - Initialising browser for dromaeo_css test... 02:26:27 INFO - TEST-INFO | started process 20342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxIXfD5/profile http://localhost:57581/getInfo.html) 02:26:32 INFO - PROCESS | 20342 | __metrics Screen width/height:1600/1200 02:26:32 INFO - PROCESS | 20342 | colorDepth:24 02:26:32 INFO - PROCESS | 20342 | Browser inner width/height: 1024/697 02:26:32 INFO - PROCESS | 20342 | __metrics 02:26:33 INFO - PROCESS | 20342 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:26:34 INFO - TEST-INFO | 20342: exit 0 02:26:34 INFO - Browser initialized. 02:26:34 INFO - Running cycle 1/1 for dromaeo_css test... 02:26:34 INFO - TEST-INFO | started process 20424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxIXfD5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:26:46 INFO - PROCESS | 20424 | RSS: Main: 176017408 02:26:46 INFO - PROCESS | 20424 | 02:27:37 INFO - PROCESS | 20424 | 1467106057881 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] 02:29:50 INFO - PROCESS | 20424 | Cycle 1(1): loaded http://localhost:57581/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57581/tests/dromaeo/cssquery-ext.html) 02:29:52 INFO - PROCESS | 20424 | RSS: Main: 292147200 02:29:52 INFO - PROCESS | 20424 | 02:32:55 INFO - PROCESS | 20424 | Cycle 1(1): loaded http://localhost:57581/tests/dromaeo/cssquery-ext.html (next: http://localhost:57581/tests/dromaeo/cssquery-jquery.html) 02:32:55 INFO - PROCESS | 20424 | RSS: Main: 256954368 02:32:55 INFO - PROCESS | 20424 | 02:35:58 INFO - PROCESS | 20424 | Cycle 1(1): loaded http://localhost:57581/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57581/tests/dromaeo/cssquery-mootools.html) 02:35:58 INFO - PROCESS | 20424 | RSS: Main: 257753088 02:35:58 INFO - PROCESS | 20424 | 02:39:00 INFO - PROCESS | 20424 | Cycle 1(1): loaded http://localhost:57581/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57581/tests/dromaeo/cssquery-prototype.html) 02:39:01 INFO - PROCESS | 20424 | RSS: Main: 252792832 02:39:01 INFO - PROCESS | 20424 | 02:42:04 INFO - PROCESS | 20424 | Cycle 1(1): loaded http://localhost:57581/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57581/tests/dromaeo/cssquery-yui.html) 02:42:05 INFO - PROCESS | 20424 | RSS: Main: 226795520 02:42:05 INFO - PROCESS | 20424 | 02:45:07 INFO - PROCESS | 20424 | Cycle 1(1): loaded http://localhost:57581/tests/dromaeo/cssquery-yui.html (next: http://localhost:57581/tests/dromaeo/cssquery-dojo.html) 02:45:08 INFO - PROCESS | 20424 | RSS: Main: 288321536 02:45:08 INFO - PROCESS | 20424 | 02:45:08 INFO - PROCESS | 20424 | __start_tp_report 02:45:08 INFO - PROCESS | 20424 | _x_x_mozilla_page_load 02:45:08 INFO - PROCESS | 20424 | _x_x_mozilla_page_load_details 02:45:08 INFO - PROCESS | 20424 | |i|pagename|runs| 02:45:08 INFO - PROCESS | 20424 | |0;dojo.html;2644.44466662001;2661.6672915885515;2695.9056433024843;2696.1776658119265;2711.1188863619327;4817.421909370872;4837.540433658801;4878.268259761037;4883.536064073916;4942.135126352888;4872.585830204428;4880.4143502779625;4883.243097319921;4888.657793954425;4953.108440480712;4446.866594002177;4517.2772356422975;4531.705439146462;4578.954210457903;4689.671722979393;4597.241455159911;4610.5389461053965;4634.0500197459605;4641.187792136363;4684.250519916814;4413.293872980308;4444.422225110715;4450;4481.282994720829;4524.773761311922;4466.508684044752;4470.9105817883465;4483.417155769762;4515.706479078849;4536.047430039695;4506.954930450719;4515.164694531522;4529.433820772403;4532.954670453286;4582.816687332503;4784.880377990578;4843.927341089887;4918.827841025547;4922.138625740481;4983;5215.58275337972;5277.498637629419;5282.947170528284;5285.6300058995885;5286.629935904488;5351.518363347317;5369.436209198017;5381.2197231401615;5381.730913454351;5385.730713464351;4800.471948085743;4846.733429661332;4877.780499877514;4880.9749952509665;4894.681845680019;5352.705601191972;5383.542398896059;5435.918461223085;5441.292631957899;5444.5916556258435;5028.17035189197;5156.871078222999;5194.636375453682;5202.791888324425;5212.218167274939;5220.817271395483;5269.578433725293;5275.683458992473;5322.308099946982;5341.572674186134;5208.687478751287;5216.843494695166;5219.16493361068;5219.765110570033;5221.947780522222;5192.428832828386;5201.08980928336;5202.297689811902;5208;5209.244659524424;4463.709858859163;4498.617617502484;4505.031418245093;4517.774111294488;4519.367288579601;3944;3944.8619298324993;3951.644352008333;3983.5618082010956;4010.6991975601945;4575.771211439414;4577.954220457753;4578.816847326137;4615.3077038443835;4626;5091.9236211456855;5252.789888404421;5300.708461034603;5309.044372013074;5335.813246536352;4543.7728113594185;4552.567506086916;4558.361829343895;4562.977185114053;4598.494165641777;4791.592714619296;4813.879653008633;4819.277108433763;4822.517748225149;4867.415910090741;4861.440934292602;4956.330895329084;4992.425871024733;5009.899802004013;5013.498650134958;5335.093034184276;5359.303290572357;5367.4364191759305;5367.704776237344;5423.620346575702;4825.203841366135;5000.049990501793;5009.699418034929;5011.774470148779;5017.12200364942;5175.741212939262;5231.346081739783;5235.424103348705;5259.421463639073;5263.578913686973;5330.093884039645;5334.306540149756;5335.413104558573;5341.973290133525;5384.111621582395;4971.950280497149;5042.016806722654;5150.201718733602;5160.251763494347;5163.8192663258105;5073.036123136592;5108.233764935289;5123.154679477844;5133.563647090039;5183.663061900965;5051.3433253676785;5108.719020453762;5110.923336149886;5115.181570948779;5117.411497677815;5084.491550844886;5100.183970564692;5128.9487105129965;5198.194279886624;5210.166373380241;5053.494650534917;5063.898722025465;5065.7720402581235;5078.619103567321;5114.309568208244 02:45:08 INFO - PROCESS | 20424 | |1;ext.html;534.6429720471623;576.2278546747358;581.2211636407214;590.5423296944864;598.3119412675422;27056.594151087724;40257.3961390579;41038;41056.58943410565;44465.33302000465;40513;41093.38359924604;41095.58904410955;41101.38347924784;41119.38320925181;7607.581583012932;7805.297523222909;7820.1788812174755;7890.132085470579;8051.51690898548;7802.921970780305;10177.08406243438;10398.22013348998;10402.739931501697;10804.945975270113;10481.685549433529;10531.420771857545;10536.473176341153;10541.525631346607;10556.894431055707;7611.581363025031;10015.649452269208;10181.28730988831;10233.692989210336;10241.795164096751;9914.760654918135;10281.794364112751;10293.897061029369;10302.175825933908;10311.175105991502;37361.62638373609;37657.435138472945;37752.81123594392;37805.05487362838;37925.43111853324;3037.7569794416395;3090.8454577271045;3133.0287610840483;3482.0250329907667;3696.722745794076;26428.73571264282;26539.867300663565;26708.33229169267;27049;30550.69449305523;3142.842857857098;3232.5797646306064;3480.3387356402204;3612.963870361289;3682.834272457746;250833;252791;252905;253560;253933;31905.361892762478;32486;32526.51210231801;55476.16785748217;55968.72015639896;34433.82783086068;34475;34569.135771605404;34693.30613387768;34701.82649086738;11826.11304152192;11942.223755456042;11943.16397852142;11946.761064778655;11950.521979120738;9369.390989585656;9521.19069879068;9532.332736708364;9598.712038638852;9617.471039092778;7983.2016798320865;8015.078265999368;8022.919770802334;8070.47541909774;8086.7169649062;3119.1790057179774;3133.3889891470944;3134.2164458885277;3157.842107894596;3195.7603179761145;830.5358697003605;906.0531744327194;918.169057003413;929.5120061967522;1049.9107575856137;28120.43759124806;28318.575221371695;28505.714942850307;28973.42053158925;29060.854695726386;952.2144231009445;954.19370631816;984.2372161574693;987.8962708915604;1024.073213741565;14411.495597654031;15019;15082.849171508364;15384.61538461525;15488.22558872052;375918;377040;378137;378236;381484;33322.83338583291;33421.665783342345;33482.162945926546;33624;33633;1070.834020726773;1095.7479779650726;1159.7390587117832;1196.3121205306984;1199.9040076793835;26262.73737262603;28759.137225883256;29411;29650;29889.551656724732;41605.79197103995;41836.58163418327;42086;42097.15805683808;42142.789286053376;280490;280890;281209;281271;282092;22422.77577224207;24900.501989959736;25092.12177573776;25707.228783136536;25961.274066222773;41498.37752433776;42067;42238.57761422346;42664;43845.78077109722;36255.63744362522;36349.27301454009;36637.26725465529;36872.44691329686;36884.446733298486;35622;36394.63605363912;36482.27035459329;36598.63401366059;36605.450918236784;34681.30637387289;35512.46731299084;36473.27053458863;36560.634393655724;36593.26813463769;31186.376272474878;32569.511457328634;32714.509282360308;33034.66965330316;33119.50320745239;24231.273061808173;25166.49667006613;25220;25445.61831572565;25669.101581445306 02:45:08 INFO - PROCESS | 20424 | |2;jquery.html;378.9033796381924;378.9431585262211;379.2415169660679;391.83934586819373;397.2829043576344;15724.60688482787;17520.386786462477;17681.381151659694;17858.732119018194;17992.73010904836;16761;16807.495775126736;17416.56458588536;17513.299468021294;17518.737218941693;4897.632677549181;5118.30902828119;5146.099432599281;5150.587952963754;5163.967206558685;3653.1962968146963;3867.4198870169557;5652.463016013472;5973.850653733648;5977.7608895644125;5796.449337312949;6014.699265036753;6035.939640603582;6061.9393806062035;6072.6356418614805;5939.049752039675;5948.910766338508;5952.0476723724;5966.761329546856;5974.97012514939;3361.5966084069823;3542.769719968194;3545.680888720002;3554.3957527220177;4949.381327334083;20547.280845170495;21110.683339749918;21270.93645317728;21503.2473863414;21516;1947.57153426246;1956.6575849226329;2047.3550831488033;2165.101482884601;2353.976460235393;12967.157134786208;13313.467461301632;13474;13529;13794.517191898336;1735.2798588585722;1785.8571314294825;1856.4616261284211;1875.2311552263507;1892.2431027588937;65945;68101.65949170223;68516.31483685199;68518;69298.65350673265;9494.382865113745;9618.230541556799;9893.901060989298;9944.154746846454;10008.949955250177;13544;13545.66135846592;13548.322583870768;13589.388477518338;13609.931950340382;6942.687579058854;7034.507584469038;7047.92952070483;7095.432365410755;7150.856982860418;6591.274959754423;6594.2195607185795;6618.106555615027;6754.560953538103;6756.662166891636;6212.409821066992;6238.500919926395;6290.8427289317215;6326.114343991845;6326.49388048955;1631.9673606527804;1653.6196674764872;1786.490850107739;1797.703378942486;1810.7646006019133;792.5561685456048;905.6753999651585;953.1183655119125;988.7033889833021;990.5839547389969;16706.749398759028;17569.20938557768;17570.209340579448;17702.29190832378;18027.549311267325;844.1853611265159;844.5144042175774;868.5787393114334;888.5024386343539;916.2395211974045;9844.950775246221;9962.203023758228;10160.187185025181;10240.539175737109;10446.268761186797;382434;387101;399443;400104;404291;65879.67060164668;67943;68270.65864670744;71697.64151179315;82229;902.5577467041103;921.7972046149837;950.1638558068993;954.9713508594614;954.9952250238705;16072.919635402215;16161.353545858034;16208.756868646744;16337.754933676242;16558.917205413894;37221.25557488781;37427.251454971294;37704.43443348297;38164.236715266095;38791;49133;49156;53270.73364633307;55120.173197401265;55650.16524752051;7819.765407037798;7968.163342848918;8022.679092836222;8117.959410202911;8158;9022;11188.384638844942;12107.33409662477;12164.574239901915;12205.511779528719;9254.583543740682;10095.596176153165;10161.390316581028;10190.949045255024;10229.488525573543;10409.479526023517;10610.575576976835;10747.193960453154;10747.408892510986;10817.350958942488;9371.671991480265;10125.088742013255;10268.486575671335;10314.793704126025;10320.793584128125;7858.960705196438;7967.641456134372;8214.096449390681;8229.629666665134;8315.168483151636;9179.862302065341;9951.800963980535;9971.800563988825;10253;10333.844992325272 02:45:08 INFO - PROCESS | 20424 | |3;mootools.html;1190.4345435917935;1389.867962543558;1438.050886414966;1521.6195951012246;1725.9137043147832;7747.3027427531515;8067.87898181527;8075.555844428554;8349.373796965221;8365.07984121746;8086.676532938675;8303;8306.04480484743;8307.00315962084;8317.085120636724;1903.7144428335791;2225.2879078694823;2259.243153543565;2294.9426264343356;2298.080767692928;2354.458474550854;2365.5387199496104;2367.7277113131954;2369.6327069304198;2369.834111612179;2277.9202727904526;2287.5310561334886;2320.025589252518;2320.269115228706;2320.3966968588206;1890.6029733755927;2182.127149140357;2248.3704562722464;2262.3778460923213;2266.92065777697;2243.721078984979;2286.017012684545;2286.3483907086566;2287.9199228027105;2288.1533832481923;8132.064812546574;8174.3460523158;8182.427230093896;8189;8189.631466584018;4802.567768900815;4948.183549714293;4956.033573453178;4958.20668693011;4959.330490383824;2916.5479350700675;2958.9408211835857;3120.9063728087967;3143.811371317728;3151.448496513124;982.5529384130203;1013.4375421640987;1023.7389465686276;1026.6663334416344;1026.9332493387906;11027.72430689231;11305.49125289364;11326.71683207918;11348.659540213806;11357;4318.287482565404;4537.069900670354;4600.953990460052;4601.953980460219;4608.124456353282;9767.218622510181;9773.41359518431;9808.852867206997;9814.852777208347;9825.656102036395;4874.098291816025;4875.512448755097;4875.634327425457;4879.219324908068;4879.536444037811;3805.980970095132;4342.131573685276;4473.530279320689;4492.573205545468;4525.298578720303;3782.3759079752085;3841.154945911951;3901.453796468497;3930.292547341506;3977.54258260298;1218.4334284557724;1253.1040306181123;1255.2280347586352;1278.5844600504872;1286.0097724752075;797.4856217739641;799.3525244551931;809.8501777171242;834.9457285276437;842.0442797424967;5239.240310155006;5667.518260947783;5675.772969081273;5683.77264909399;5881.029630111069;832.2800777327568;842.2714352085402;864.7449002544264;874.152072489684;920.1764420843441;3597.8920632380546;3785.356489396809;3882.495275614152;3897.7271590988926;3914.745541539791;9772.657956971472;10247.231457640706;10273.486325683685;10300.330478518872;10301.38191708485;9619.951900240454;10059.647912323033;10102.444365559817;10328.845067323997;10360.533775980099;7467.925320746832;7579.962100189464;7753.728619498291;7757.146713861471;7834.608269586612;5678.517326027169;5729.197912292366;5732.484076433141;5736.856578585569;5964.224650795369;8953.149450802164;9143.77140571491;9174.495402752913;9180.908190918273;9711;9280.95359523198;9387.389819661701;9391.906080939103;9515.619375224913;9898.653547125816;6913.308669133046;7075.646217689198;7079.610621415872;7832.255935686101;8056.838863222585;6750.696218670073;7777.494462859896;7789.298963093349;8073.717419890276;8077.071136819106;6991.7902462926195;7140.642967851482;7213.931582787045;7248.492605517774;7373.77878663641;6972.163340399185;7091.82270443243;7176.892346614909;7196.712131514891;7277.199508054004;6406.967965160145;6433.839154021187;6495.512836537373;6524.575902566318;6571.408573228241;4725.338452616706;4739.976300118616;4772.713637181641;4850.1997170467885;4877.414710234794;4817.9518204817505;4818.855434336975;4847.418309802846;4877.463479017234;5007.974960125176 02:45:08 INFO - PROCESS | 20424 | |4;prototype.html;307.68308642098634;308.4848303333433;315.62913576547555;316.9017604542592;320.2506135642596;4936.062148191841;4940.555350018498;4942.308076869237;4959.528844759742;4972.254161875716;4879.756012199394;4886.8778280543;4906.803727850891;4914.459409464956;4953.157963146265;3931.5478719947287;3933.3903244997;3954.090559171392;3954.110325176841;3957.683385329167;3794.444277846084;3920;3927.607239276064;3941.586133455989;3955.624215699504;3848.4419759134908;3887.494625698655;3887.4946256986696;3887.708421868357;3904.9219015619815;3649.5802982656805;3766.397376419787;3809.1619843634357;3866.381378979378;3874.3607304794814;3318.452455344865;3353.748468864845;3422.7946323220685;3448.1207292140593;3455.94816077759;4774.618030557547;4776.617870570346;4777.113040349042;4797.424309082898;4802.087603355386;4143.91712165755;4208.494980602317;4425.8229670813125;4426.712263702849;4433.179861725591;5026.070177017264;5062.2406639004075;5072.920102757852;5091.472558232515;5094.363204599425;3695.821593429648;3696.4085746280466;3701.889433170038;3718.4980027696183;3728.1611637381643;5139.948600513984;5301.231321458367;5392.272043274147;5402.540784033362;5416.322959630046;3789.7915614640906;3799.2021675448464;3803.7717736935874;3816.6183381661613;3818.1790914953417;3883.4174873768598;3885.786281754474;3894.883153505399;3899.161680238762;3919.7648141111627;4363.498197707241;4372.344148377769;4374.606285434263;4393.428854248928;4397.450318710161;4837.830675926396;5066.898662026812;5092.344987878954;5125.615578831528;5146.433892271847;1307.3528603341406;1311.7442098790834;1318.4133060787858;1319.221659221064;1325.7613629546581;816.5835423933718;834.588040562774;849.723839752083;850.5152063323847;854.2439940652444;4129.566395528486;4148.522919864194;4150.8547200847825;4165.479315085614;4185.832566697298;4635.466921304026;4761.976190119097;4775.21209000518;4777.402824646919;4837.298591704253;4094.3653733671326;4154.379791881169;4154.896127596834;4192.434021407132;4204.3693445983345;2416.154345978893;2523;2527.9620805687928;2549.6048112542217;2559.628853816186;4384.802683879233;4393.472783266028;4417.911641767147;4480.215962206601;4483.1843103543115;4788.329633851264;4800.5199480051715;4804.40562096464;4804.735739534359;4825.30033145192;4455.108978204372;4599.33309670096;4986.47641997585;4988.401391833003;5007.624428167902;5300.231466437268;5334;5345.919811202913;5354.437784032776;5376.193570964387;5181.870453238699;5189.351331083614;5201.817936372209;5246.632735708617;5246.842594722164;4745.430548334222;5002.699838009731;5007.824726134568;5008.6243531734535;5010.3737032870895;3769.8869033929027;3814.4659747634796;3827.08150043993;3854.6145385461227;3855.9807200964938;5392.492490991551;5392.919106213489;5401.540869026177;5408.269883565668;5424.783008679608;4901.264810278487;5107.157319042465;5144.9742751286;5164.638475306842;5182.792688292426;5064.240363945438;5072.898542029065;5074.695518268915;5074.771635276347;5155.948440515547;4864.197407427735;5111.258867464271;5131.640785145153;5132.6150538709;5187.351581052369;4909.26361045846;5035.194368900959;5198.324217851655;5208.453112423141;5231.378272735465;5078.695278283167;5080.110980578458;5085.931954289641;5107.565856902205;5119.360079990001 02:45:08 INFO - PROCESS | 20424 | |5;yui.html;638.4732595608621;651.5894986158719;713.5647255174342;722.6964674836568;756.3646536908997;12578.874211257884;13717.72564548711;13736.244506552135;13743.587692369232;13757.931210343946;13000.54498092567;13143.211407315544;13145.145565538258;13183.143095698773;13183.274919879403;772.8029352515101;804.1837534902079;804.6982381606897;805.3516918880299;806.1857523900873;787.7439832054577;793.5952664141272;795.8249185179251;796.1004065406083;796.2236819101388;819.3445243804962;821.5974172655416;822.198356602314;822.40786633624;823.0617096509953;821.5974172655416;821.708293555788;821.8109834737984;822.3585603229491;823.27551754456;601.9909701354483;602.340437221242;602.770947040122;603.8037637767699;603.9033754599243;11133.165012624086;14105.717885642229;14116.647083822883;14130.293485325796;14134.222617756019;11224.494897729623;12934.741305173939;13169.736605267937;13288.13627114244;13603.523876664269;11655.475503602358;11995.880041199563;12181.33002684852;12296.631101066982;12575.748485030248;4347.195768782785;4348.282533381988;4391.6486681065435;4410.713303635253;4515.503294637587;44892.77553612243;52157;53809.461905380835;55216.44783552193;64286.3571364285;11119.833202501968;11306.773864522827;11329.943350283196;11506.482208300647;11736.354500502553;20630.484237894172;20666.173353065707;20688.58622827535;20697.172113115306;20766.480837979172;7199.568025918462;7584.81037974044;7597.278258565428;7620.123685776096;7652.502587331805;3730.981345093257;3848.191879705237;3860.1507668312925;3869.090763670535;3901.785401802928;3036.2561172512433;3147.3705258948303;3147.8426078695975;3153.7477001839798;3155.353152603711;534.9010433069894;538.5906710899744;541.204429488651;545.4164044472376;552.7927027364739;461.26198083067493;461.9930701039487;483.4899181363695;524.1220954900526;540.7566595032251;7717.2668596483245;7945.510786405663;7948.205179482005;8051.5571643559;8224;559.2087196616823;573.7532860869783;577.096843440015;577.341830313443;598.8053882488209;3785.621437856192;3954.4463775071513;4045.5347635021762;4212.620864122244;4229.365595160689;59967.70016149891;75166;97008;99344.50327748315;99977.50011249896;86695.56652216699;90092;90295.54852225828;90682;90869;49544;75092.24907750962;77836.22163778402;78372.60813695895;79057.60471197608;8420.621072051896;9142.908570914205;9208.585613647536;9217.631294748135;9259.35184537076;45183.32225016693;46203.53796461992;47698;47752;47955;41350.79324603358;65093;67355.66322168357;67426.3029478835;68320.31679683339;10776.461176941279;10956.616518421817;10987.945060274647;12388.194767340094;12750;12883.162594431333;13112.344382780631;13242.80135797983;13382.197068175941;13519.188848669111;10924.399158046384;12145.514179432723;12725.236485810881;12956;13063.542776002794;11295.322280662858;11365.374904380338;11502.654920352403;11870.169088163746;12159;11934.761304774029;11935.224210426295;12062.75874482488;12224.511019559119;13010.089293749725;9935.751606209902;10088.69733907984;10218.642347517802;10309.793804124025;10557.155427565624;10337.276390652883;10552.20858435605;10661.786764264827;10678.199135064746;10867.184961127788 02:45:08 INFO - PROCESS | 20424 | __end_tp_report 02:45:08 INFO - PROCESS | 20424 | __start_cc_report 02:45:08 INFO - PROCESS | 20424 | _x_x_mozilla_cycle_collect,1109 02:45:08 INFO - PROCESS | 20424 | __end_cc_report 02:45:08 INFO - PROCESS | 20424 | __startTimestamp1467107108173__endTimestamp 02:45:08 INFO - PROCESS | 20424 | 02:45:08 INFO - PROCESS | 20424 | ------- Summary: start ------- 02:45:08 INFO - PROCESS | 20424 | Number of tests: 6 02:45:08 INFO - PROCESS | 20424 | 02:45:08 INFO - PROCESS | 20424 | [#0] dojo.html Cycles:165 Average:4876.81 Median:5009.90 stddev:518.23 (10.3%) stddev-sans-first:489.34 02:45:08 INFO - PROCESS | 20424 | Values: 2644.4 2661.7 2695.9 2696.2 2711.1 4817.4 4837.5 4878.3 4883.5 4942.1 4872.6 4880.4 4883.2 4888.7 4953.1 4446.9 4517.3 4531.7 4579.0 4689.7 4597.2 4610.5 4634.1 4641.2 4684.3 4413.3 4444.4 4450.0 4481.3 4524.8 4466.5 4470.9 4483.4 4515.7 4536.0 4507.0 4515.2 4529.4 4533.0 4582.8 4784.9 4843.9 4918.8 4922.1 4983.0 5215.6 5277.5 5282.9 5285.6 5286.6 5351.5 5369.4 5381.2 5381.7 5385.7 4800.5 4846.7 4877.8 4881.0 4894.7 5352.7 5383.5 5435.9 5441.3 5444.6 5028.2 5156.9 5194.6 5202.8 5212.2 5220.8 5269.6 5275.7 5322.3 5341.6 5208.7 5216.8 5219.2 5219.8 5221.9 5192.4 5201.1 5202.3 5208.0 5209.2 4463.7 4498.6 4505.0 4517.8 4519.4 3944.0 3944.9 3951.6 3983.6 4010.7 4575.8 4578.0 4578.8 4615.3 4626.0 5091.9 5252.8 5300.7 5309.0 5335.8 4543.8 4552.6 4558.4 4563.0 4598.5 4791.6 4813.9 4819.3 4822.5 4867.4 4861.4 4956.3 4992.4 5009.9 5013.5 5335.1 5359.3 5367.4 5367.7 5423.6 4825.2 5000.0 5009.7 5011.8 5017.1 5175.7 5231.3 5235.4 5259.4 5263.6 5330.1 5334.3 5335.4 5342.0 5384.1 4972.0 5042.0 5150.2 5160.3 5163.8 5073.0 5108.2 5123.2 5133.6 5183.7 5051.3 5108.7 5110.9 5115.2 5117.4 5084.5 5100.2 5128.9 5198.2 5210.2 5053.5 5063.9 5065.8 5078.6 5114.3 02:45:08 INFO - PROCESS | 20424 | 02:45:08 INFO - PROCESS | 20424 | [#1] ext.html Cycles:180 Average:44617.57 Median:33553.08 stddev:81263.43 (242.2%) stddev-sans-first:81423.99 02:45:08 INFO - PROCESS | 20424 | Values: 534.6 576.2 581.2 590.5 598.3 27056.6 40257.4 41038.0 41056.6 44465.3 40513.0 41093.4 41095.6 41101.4 41119.4 7607.6 7805.3 7820.2 7890.1 8051.5 7802.9 10177.1 10398.2 10402.7 10804.9 10481.7 10531.4 10536.5 10541.5 10556.9 7611.6 10015.6 10181.3 10233.7 10241.8 9914.8 10281.8 10293.9 10302.2 10311.2 37361.6 37657.4 37752.8 37805.1 37925.4 3037.8 3090.8 3133.0 3482.0 3696.7 26428.7 26539.9 26708.3 27049.0 30550.7 3142.8 3232.6 3480.3 3613.0 3682.8 250833.0 252791.0 252905.0 253560.0 253933.0 31905.4 32486.0 32526.5 55476.2 55968.7 34433.8 34475.0 34569.1 34693.3 34701.8 11826.1 11942.2 11943.2 11946.8 11950.5 9369.4 9521.2 9532.3 9598.7 9617.5 7983.2 8015.1 8022.9 8070.5 8086.7 3119.2 3133.4 3134.2 3157.8 3195.8 830.5 906.1 918.2 929.5 1049.9 28120.4 28318.6 28505.7 28973.4 29060.9 952.2 954.2 984.2 987.9 1024.1 14411.5 15019.0 15082.8 15384.6 15488.2 375918.0 377040.0 378137.0 378236.0 381484.0 33322.8 33421.7 33482.2 33624.0 33633.0 1070.8 1095.7 1159.7 1196.3 1199.9 26262.7 28759.1 29411.0 29650.0 29889.6 41605.8 41836.6 42086.0 42097.2 42142.8 280490.0 280890.0 281209.0 281271.0 282092.0 22422.8 24900.5 25092.1 25707.2 25961.3 41498.4 42067.0 42238.6 42664.0 43845.8 36255.6 36349.3 36637.3 36872.4 36884.4 35622.0 36394.6 36482.3 36598.6 36605.5 34681.3 35512.5 36473.3 36560.6 36593.3 31186.4 32569.5 32714.5 33034.7 33119.5 24231.3 25166.5 25220.0 25445.6 25669.1 02:45:08 INFO - PROCESS | 20424 | 02:45:08 INFO - PROCESS | 20424 | [#2] jquery.html Cycles:180 Average:24541.74 Median:199920.14 stddev:64994.90 (32.5%) stddev-sans-first:65151.90 02:45:08 INFO - PROCESS | 20424 | Values: 378.9 378.9 379.2 391.8 397.3 15724.6 17520.4 17681.4 17858.7 17992.7 16761.0 16807.5 17416.6 17513.3 17518.7 4897.6 5118.3 5146.1 5150.6 5164.0 3653.2 3867.4 5652.5 5973.9 5977.8 5796.4 6014.7 6035.9 6061.9 6072.6 5939.0 5948.9 5952.0 5966.8 5975.0 3361.6 3542.8 3545.7 3554.4 4949.4 20547.3 21110.7 21270.9 21503.2 21516.0 1947.6 1956.7 2047.4 2165.1 2354.0 12967.2 13313.5 13474.0 13529.0 13794.5 1735.3 1785.9 1856.5 1875.2 1892.2 65945.0 68101.7 68516.3 68518.0 69298.7 9494.4 9618.2 9893.9 9944.2 10008.9 13544.0 13545.7 13548.3 13589.4 13609.9 6942.7 7034.5 7047.9 7095.4 7150.9 6591.3 6594.2 6618.1 6754.6 6756.7 6212.4 6238.5 6290.8 6326.1 6326.5 1632.0 1653.6 1786.5 1797.7 1810.8 792.6 905.7 953.1 988.7 990.6 16706.7 17569.2 17570.2 17702.3 18027.5 844.2 844.5 868.6 888.5 916.2 9845.0 9962.2 10160.2 10240.5 10446.3 382434.0 387101.0 399443.0 400104.0 404291.0 65879.7 67943.0 68270.7 71697.6 82229.0 902.6 921.8 950.2 955.0 955.0 16072.9 16161.4 16208.8 16337.8 16558.9 37221.3 37427.3 37704.4 38164.2 38791.0 49133.0 49156.0 53270.7 55120.2 55650.2 7819.8 7968.2 8022.7 8118.0 8158.0 9022.0 11188.4 12107.3 12164.6 12205.5 9254.6 10095.6 10161.4 10190.9 10229.5 10409.5 10610.6 10747.2 10747.4 10817.4 9371.7 10125.1 10268.5 10314.8 10320.8 7859.0 7967.6 8214.1 8229.6 8315.2 9179.9 9951.8 9971.8 10253.0 10333.8 02:45:08 INFO - PROCESS | 20424 | 02:45:08 INFO - PROCESS | 20424 | [#3] mootools.html Cycles:180 Average:5428.63 Median:4879.38 stddev:3048.08 (62.5%) stddev-sans-first:3039.99 02:45:08 INFO - PROCESS | 20424 | Values: 1190.4 1389.9 1438.1 1521.6 1725.9 7747.3 8067.9 8075.6 8349.4 8365.1 8086.7 8303.0 8306.0 8307.0 8317.1 1903.7 2225.3 2259.2 2294.9 2298.1 2354.5 2365.5 2367.7 2369.6 2369.8 2277.9 2287.5 2320.0 2320.3 2320.4 1890.6 2182.1 2248.4 2262.4 2266.9 2243.7 2286.0 2286.3 2287.9 2288.2 8132.1 8174.3 8182.4 8189.0 8189.6 4802.6 4948.2 4956.0 4958.2 4959.3 2916.5 2958.9 3120.9 3143.8 3151.4 982.6 1013.4 1023.7 1026.7 1026.9 11027.7 11305.5 11326.7 11348.7 11357.0 4318.3 4537.1 4601.0 4602.0 4608.1 9767.2 9773.4 9808.9 9814.9 9825.7 4874.1 4875.5 4875.6 4879.2 4879.5 3806.0 4342.1 4473.5 4492.6 4525.3 3782.4 3841.2 3901.5 3930.3 3977.5 1218.4 1253.1 1255.2 1278.6 1286.0 797.5 799.4 809.9 834.9 842.0 5239.2 5667.5 5675.8 5683.8 5881.0 832.3 842.3 864.7 874.2 920.2 3597.9 3785.4 3882.5 3897.7 3914.7 9772.7 10247.2 10273.5 10300.3 10301.4 9620.0 10059.6 10102.4 10328.8 10360.5 7467.9 7580.0 7753.7 7757.1 7834.6 5678.5 5729.2 5732.5 5736.9 5964.2 8953.1 9143.8 9174.5 9180.9 9711.0 9281.0 9387.4 9391.9 9515.6 9898.7 6913.3 7075.6 7079.6 7832.3 8056.8 6750.7 7777.5 7789.3 8073.7 8077.1 6991.8 7140.6 7213.9 7248.5 7373.8 6972.2 7091.8 7176.9 7196.7 7277.2 6407.0 6433.8 6495.5 6524.6 6571.4 4725.3 4740.0 4772.7 4850.2 4877.4 4818.0 4818.9 4847.4 4877.5 5008.0 02:45:08 INFO - PROCESS | 20424 | 02:45:08 INFO - PROCESS | 20424 | [#4] prototype.html Cycles:180 Average:4207.61 Median:4774.92 stddev:1217.79 (25.5%) stddev-sans-first:1185.50 02:45:08 INFO - PROCESS | 20424 | Values: 307.7 308.5 315.6 316.9 320.3 4936.1 4940.6 4942.3 4959.5 4972.3 4879.8 4886.9 4906.8 4914.5 4953.2 3931.5 3933.4 3954.1 3954.1 3957.7 3794.4 3920.0 3927.6 3941.6 3955.6 3848.4 3887.5 3887.5 3887.7 3904.9 3649.6 3766.4 3809.2 3866.4 3874.4 3318.5 3353.7 3422.8 3448.1 3455.9 4774.6 4776.6 4777.1 4797.4 4802.1 4143.9 4208.5 4425.8 4426.7 4433.2 5026.1 5062.2 5072.9 5091.5 5094.4 3695.8 3696.4 3701.9 3718.5 3728.2 5139.9 5301.2 5392.3 5402.5 5416.3 3789.8 3799.2 3803.8 3816.6 3818.2 3883.4 3885.8 3894.9 3899.2 3919.8 4363.5 4372.3 4374.6 4393.4 4397.5 4837.8 5066.9 5092.3 5125.6 5146.4 1307.4 1311.7 1318.4 1319.2 1325.8 816.6 834.6 849.7 850.5 854.2 4129.6 4148.5 4150.9 4165.5 4185.8 4635.5 4762.0 4775.2 4777.4 4837.3 4094.4 4154.4 4154.9 4192.4 4204.4 2416.2 2523.0 2528.0 2549.6 2559.6 4384.8 4393.5 4417.9 4480.2 4483.2 4788.3 4800.5 4804.4 4804.7 4825.3 4455.1 4599.3 4986.5 4988.4 5007.6 5300.2 5334.0 5345.9 5354.4 5376.2 5181.9 5189.4 5201.8 5246.6 5246.8 4745.4 5002.7 5007.8 5008.6 5010.4 3769.9 3814.5 3827.1 3854.6 3856.0 5392.5 5392.9 5401.5 5408.3 5424.8 4901.3 5107.2 5145.0 5164.6 5182.8 5064.2 5072.9 5074.7 5074.8 5155.9 4864.2 5111.3 5131.6 5132.6 5187.4 4909.3 5035.2 5198.3 5208.5 5231.4 5078.7 5080.1 5085.9 5107.6 5119.4 02:45:08 INFO - PROCESS | 20424 | 02:45:08 INFO - PROCESS | 20424 | [#5] yui.html Cycles:180 Average:17671.65 Median:24849.41 stddev:24549.56 (98.8%) stddev-sans-first:24585.11 02:45:08 INFO - PROCESS | 20424 | Values: 638.5 651.6 713.6 722.7 756.4 12578.9 13717.7 13736.2 13743.6 13757.9 13000.5 13143.2 13145.1 13183.1 13183.3 772.8 804.2 804.7 805.4 806.2 787.7 793.6 795.8 796.1 796.2 819.3 821.6 822.2 822.4 823.1 821.6 821.7 821.8 822.4 823.3 602.0 602.3 602.8 603.8 603.9 11133.2 14105.7 14116.6 14130.3 14134.2 11224.5 12934.7 13169.7 13288.1 13603.5 11655.5 11995.9 12181.3 12296.6 12575.7 4347.2 4348.3 4391.6 4410.7 4515.5 44892.8 52157.0 53809.5 55216.4 64286.4 11119.8 11306.8 11329.9 11506.5 11736.4 20630.5 20666.2 20688.6 20697.2 20766.5 7199.6 7584.8 7597.3 7620.1 7652.5 3731.0 3848.2 3860.2 3869.1 3901.8 3036.3 3147.4 3147.8 3153.7 3155.4 534.9 538.6 541.2 545.4 552.8 461.3 462.0 483.5 524.1 540.8 7717.3 7945.5 7948.2 8051.6 8224.0 559.2 573.8 577.1 577.3 598.8 3785.6 3954.4 4045.5 4212.6 4229.4 59967.7 75166.0 97008.0 99344.5 99977.5 86695.6 90092.0 90295.5 90682.0 90869.0 49544.0 75092.2 77836.2 78372.6 79057.6 8420.6 9142.9 9208.6 9217.6 9259.4 45183.3 46203.5 47698.0 47752.0 47955.0 41350.8 65093.0 67355.7 67426.3 68320.3 10776.5 10956.6 10987.9 12388.2 12750.0 12883.2 13112.3 13242.8 13382.2 13519.2 10924.4 12145.5 12725.2 12956.0 13063.5 11295.3 11365.4 11502.7 11870.2 12159.0 11934.8 11935.2 12062.8 12224.5 13010.1 9935.8 10088.7 10218.6 10309.8 10557.2 10337.3 10552.2 10661.8 10678.2 10867.2 02:45:08 INFO - PROCESS | 20424 | -------- Summary: end -------- 02:45:08 INFO - PROCESS | 20424 | 02:45:08 INFO - TEST-INFO | 20424: exit 0 02:45:08 INFO - TEST-OK | dromaeo_css | took 1121234ms 02:45:08 INFO - TEST-START | kraken 02:45:08 INFO - operating with platform_type : linux_ 02:45:08 INFO - Initialising browser for kraken test... 02:45:08 INFO - TEST-INFO | started process 20604 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv2oGBX/profile http://localhost:57581/getInfo.html) 02:45:13 INFO - PROCESS | 20604 | __metrics Screen width/height:1600/1200 02:45:13 INFO - PROCESS | 20604 | colorDepth:24 02:45:13 INFO - PROCESS | 20604 | Browser inner width/height: 1024/697 02:45:13 INFO - PROCESS | 20604 | __metrics 02:45:14 INFO - PROCESS | 20604 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:45:15 INFO - TEST-INFO | 20604: exit 0 02:45:15 INFO - Browser initialized. 02:45:15 INFO - Running cycle 1/1 for kraken test... 02:45:15 INFO - TEST-INFO | started process 20686 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv2oGBX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:45:27 INFO - PROCESS | 20686 | RSS: Main: 175644672 02:45:27 INFO - PROCESS | 20686 | 02:45:30 INFO - PROCESS | 20686 | Cycle 1(1): loaded http://localhost:57581/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57581/tests/kraken/driver.html?testName=audio-beat-detection) 02:45:31 INFO - PROCESS | 20686 | RSS: Main: 233144320 02:45:31 INFO - PROCESS | 20686 | 02:45:34 INFO - PROCESS | 20686 | Cycle 1(1): loaded http://localhost:57581/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57581/tests/kraken/driver.html?testName=audio-dft) 02:45:35 INFO - PROCESS | 20686 | RSS: Main: 221237248 02:45:35 INFO - PROCESS | 20686 | 02:45:38 INFO - PROCESS | 20686 | Cycle 1(1): loaded http://localhost:57581/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57581/tests/kraken/driver.html?testName=audio-fft) 02:45:38 INFO - PROCESS | 20686 | RSS: Main: 289091584 02:45:38 INFO - PROCESS | 20686 | 02:45:41 INFO - PROCESS | 20686 | Cycle 1(1): loaded http://localhost:57581/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57581/tests/kraken/driver.html?testName=audio-oscillator) 02:45:41 INFO - PROCESS | 20686 | RSS: Main: 198664192 02:45:41 INFO - PROCESS | 20686 | 02:45:43 INFO - PROCESS | 20686 | Cycle 1(1): loaded http://localhost:57581/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57581/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:45:44 INFO - PROCESS | 20686 | RSS: Main: 202702848 02:45:44 INFO - PROCESS | 20686 | 02:45:47 INFO - PROCESS | 20686 | Cycle 1(1): loaded http://localhost:57581/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57581/tests/kraken/driver.html?testName=imaging-darkroom) 02:45:48 INFO - PROCESS | 20686 | RSS: Main: 238530560 02:45:48 INFO - PROCESS | 20686 | 02:45:51 INFO - PROCESS | 20686 | Cycle 1(1): loaded http://localhost:57581/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57581/tests/kraken/driver.html?testName=imaging-desaturate) 02:45:52 INFO - PROCESS | 20686 | RSS: Main: 234967040 02:45:52 INFO - PROCESS | 20686 | 02:45:55 INFO - PROCESS | 20686 | Cycle 1(1): loaded http://localhost:57581/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57581/tests/kraken/driver.html?testName=json-parse-financial) 02:45:55 INFO - PROCESS | 20686 | RSS: Main: 236924928 02:45:55 INFO - PROCESS | 20686 | 02:45:57 INFO - PROCESS | 20686 | Cycle 1(1): loaded http://localhost:57581/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57581/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:45:58 INFO - PROCESS | 20686 | RSS: Main: 221868032 02:45:58 INFO - PROCESS | 20686 | 02:46:00 INFO - PROCESS | 20686 | Cycle 1(1): loaded http://localhost:57581/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57581/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:46:00 INFO - PROCESS | 20686 | RSS: Main: 226492416 02:46:00 INFO - PROCESS | 20686 | 02:46:02 INFO - PROCESS | 20686 | Cycle 1(1): loaded http://localhost:57581/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57581/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:46:03 INFO - PROCESS | 20686 | RSS: Main: 234049536 02:46:03 INFO - PROCESS | 20686 | 02:46:06 INFO - PROCESS | 20686 | Cycle 1(1): loaded http://localhost:57581/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:46:07 INFO - PROCESS | 20686 | RSS: Main: 240574464 02:46:07 INFO - PROCESS | 20686 | 02:46:09 INFO - PROCESS | 20686 | Cycle 1(1): loaded http://localhost:57581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:46:10 INFO - PROCESS | 20686 | RSS: Main: 242429952 02:46:10 INFO - PROCESS | 20686 | 02:46:12 INFO - PROCESS | 20686 | Cycle 1(1): loaded http://localhost:57581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57581/tests/kraken/driver.html?testName=ai-astar) 02:46:12 INFO - PROCESS | 20686 | RSS: Main: 285179904 02:46:12 INFO - PROCESS | 20686 | 02:46:12 INFO - PROCESS | 20686 | __start_tp_report 02:46:12 INFO - PROCESS | 20686 | _x_x_mozilla_page_load 02:46:12 INFO - PROCESS | 20686 | _x_x_mozilla_page_load_details 02:46:12 INFO - PROCESS | 20686 | |i|pagename|runs| 02:46:12 INFO - PROCESS | 20686 | |0;ai-astar;105;114;118;115;116;114;114;114;114;115 02:46:12 INFO - PROCESS | 20686 | |1;audio-beat-detection;163;133;132;191;139;134;164;138;192;132 02:46:12 INFO - PROCESS | 20686 | |2;audio-dft;162;162;162;160;160;160;161;161;162;160 02:46:12 INFO - PROCESS | 20686 | |3;audio-fft;76;75;77;103;77;77;77;76;117;75 02:46:12 INFO - PROCESS | 20686 | |4;audio-oscillator;86;85;124;86;87;88;116;85;87;129 02:46:12 INFO - PROCESS | 20686 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 02:46:12 INFO - PROCESS | 20686 | |6;imaging-darkroom;147;147;148;148;147;146;145;147;147;148 02:46:12 INFO - PROCESS | 20686 | |7;imaging-desaturate;95;95;95;95;94;94;94;95;95;95 02:46:12 INFO - PROCESS | 20686 | |8;json-parse-financial;62;62;63;62;63;63;63;62;61;62 02:46:12 INFO - PROCESS | 20686 | |9;json-stringify-tinderbox;65;64;65;65;65;65;65;64;65;65 02:46:12 INFO - PROCESS | 20686 | |10;stanford-crypto-aes;88;81;81;82;83;83;86;86;93;89 02:46:12 INFO - PROCESS | 20686 | |11;stanford-crypto-ccm;134;132;146;140;126;129;141;133;153;134 02:46:12 INFO - PROCESS | 20686 | |12;stanford-crypto-pbkdf2;167;168;167;170;167;164;167;172;166;165 02:46:12 INFO - PROCESS | 20686 | |13;stanford-crypto-sha256-iterative;66;67;69;66;66;65;66;66;66;66 02:46:12 INFO - PROCESS | 20686 | __end_tp_report 02:46:12 INFO - PROCESS | 20686 | __start_cc_report 02:46:12 INFO - PROCESS | 20686 | _x_x_mozilla_cycle_collect,1898 02:46:12 INFO - PROCESS | 20686 | __end_cc_report 02:46:12 INFO - PROCESS | 20686 | __startTimestamp1467107172507__endTimestamp 02:46:12 INFO - PROCESS | 20686 | 02:46:12 INFO - PROCESS | 20686 | ------- Summary: start ------- 02:46:12 INFO - PROCESS | 20686 | Number of tests: 14 02:46:12 INFO - PROCESS | 20686 | 02:46:12 INFO - PROCESS | 20686 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.50 stddev:3.38 (3.0%) stddev-sans-first:1.36 02:46:12 INFO - PROCESS | 20686 | Values: 105.0 114.0 118.0 115.0 116.0 114.0 114.0 114.0 114.0 115.0 02:46:12 INFO - PROCESS | 20686 | 02:46:12 INFO - PROCESS | 20686 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:151.00 stddev:24.12 (16.0%) stddev-sans-first:25.24 02:46:12 INFO - PROCESS | 20686 | Values: 163.0 133.0 132.0 191.0 139.0 134.0 164.0 138.0 192.0 132.0 02:46:12 INFO - PROCESS | 20686 | 02:46:12 INFO - PROCESS | 20686 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 02:46:12 INFO - PROCESS | 20686 | Values: 162.0 162.0 162.0 160.0 160.0 160.0 161.0 161.0 162.0 160.0 02:46:12 INFO - PROCESS | 20686 | 02:46:12 INFO - PROCESS | 20686 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.50 stddev:14.63 (19.1%) stddev-sans-first:15.30 02:46:12 INFO - PROCESS | 20686 | Values: 76.0 75.0 77.0 103.0 77.0 77.0 77.0 76.0 117.0 75.0 02:46:12 INFO - PROCESS | 20686 | 02:46:12 INFO - PROCESS | 20686 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:86.00 stddev:18.02 (21.0%) stddev-sans-first:18.65 02:46:12 INFO - PROCESS | 20686 | Values: 86.0 85.0 124.0 86.0 87.0 88.0 116.0 85.0 87.0 129.0 02:46:12 INFO - PROCESS | 20686 | 02:46:12 INFO - PROCESS | 20686 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 02:46:12 INFO - PROCESS | 20686 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 02:46:12 INFO - PROCESS | 20686 | 02:46:12 INFO - PROCESS | 20686 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 02:46:12 INFO - PROCESS | 20686 | Values: 147.0 147.0 148.0 148.0 147.0 146.0 145.0 147.0 147.0 148.0 02:46:12 INFO - PROCESS | 20686 | 02:46:12 INFO - PROCESS | 20686 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:46:12 INFO - PROCESS | 20686 | Values: 95.0 95.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 95.0 02:46:12 INFO - PROCESS | 20686 | 02:46:12 INFO - PROCESS | 20686 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:62.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 02:46:12 INFO - PROCESS | 20686 | Values: 62.0 62.0 63.0 62.0 63.0 63.0 63.0 62.0 61.0 62.0 02:46:12 INFO - PROCESS | 20686 | 02:46:12 INFO - PROCESS | 20686 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 02:46:12 INFO - PROCESS | 20686 | Values: 65.0 64.0 65.0 65.0 65.0 65.0 65.0 64.0 65.0 65.0 02:46:12 INFO - PROCESS | 20686 | 02:46:12 INFO - PROCESS | 20686 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:86.00 stddev:3.94 (4.6%) stddev-sans-first:4.04 02:46:12 INFO - PROCESS | 20686 | Values: 88.0 81.0 81.0 82.0 83.0 83.0 86.0 86.0 93.0 89.0 02:46:12 INFO - PROCESS | 20686 | 02:46:12 INFO - PROCESS | 20686 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:137.00 stddev:8.20 (6.0%) stddev-sans-first:8.64 02:46:12 INFO - PROCESS | 20686 | Values: 134.0 132.0 146.0 140.0 126.0 129.0 141.0 133.0 153.0 134.0 02:46:12 INFO - PROCESS | 20686 | 02:46:12 INFO - PROCESS | 20686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.30 Median:167.00 stddev:2.31 (1.4%) stddev-sans-first:2.45 02:46:12 INFO - PROCESS | 20686 | Values: 167.0 168.0 167.0 170.0 167.0 164.0 167.0 172.0 166.0 165.0 02:46:12 INFO - PROCESS | 20686 | 02:46:12 INFO - PROCESS | 20686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 02:46:12 INFO - PROCESS | 20686 | Values: 66.0 67.0 69.0 66.0 66.0 65.0 66.0 66.0 66.0 66.0 02:46:12 INFO - PROCESS | 20686 | -------- Summary: end -------- 02:46:12 INFO - PROCESS | 20686 | 02:46:13 INFO - TEST-INFO | 20686: exit 0 02:46:13 INFO - TEST-OK | kraken | took 64604ms 02:46:13 INFO - SUITE-END | took 1185s 02:46:13 INFO - Completed test suite (00:19:45) 02:46:13 INFO - javascript benchmark 02:46:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2644.44466662001, 2661.6672915885515, 2695.9056433024843, 2696.1776658119265, 2711.1188863619327, 4817.421909370872, 4837.540433658801, 4878.268259761037, 4883.536064073916, 4942.135126352888, 4872.585830204428, 4880.4143502779625, 4883.243097319921, 4888.657793954425, 4953.108440480712, 4446.866594002177, 4517.2772356422975, 4531.705439146462, 4578.954210457903, 4689.671722979393, 4597.241455159911, 4610.5389461053965, 4634.0500197459605, 4641.187792136363, 4684.250519916814, 4413.293872980308, 4444.422225110715, 4450.0, 4481.282994720829, 4524.773761311922, 4466.508684044752, 4470.9105817883465, 4483.417155769762, 4515.706479078849, 4536.047430039695, 4506.954930450719, 4515.164694531522, 4529.433820772403, 4532.954670453286, 4582.816687332503, 4784.880377990578, 4843.927341089887, 4918.827841025547, 4922.138625740481, 4983.0, 5215.58275337972, 5277.498637629419, 5282.947170528284, 5285.6300058995885, 5286.629935904488, 5351.518363347317, 5369.436209198017, 5381.2197231401615, 5381.730913454351, 5385.730713464351, 4800.471948085743, 4846.733429661332, 4877.780499877514, 4880.9749952509665, 4894.681845680019, 5352.705601191972, 5383.542398896059, 5435.918461223085, 5441.292631957899, 5444.5916556258435, 5028.17035189197, 5156.871078222999, 5194.636375453682, 5202.791888324425, 5212.218167274939, 5220.817271395483, 5269.578433725293, 5275.683458992473, 5322.308099946982, 5341.572674186134, 5208.687478751287, 5216.843494695166, 5219.16493361068, 5219.765110570033, 5221.947780522222, 5192.428832828386, 5201.08980928336, 5202.297689811902, 5208.0, 5209.244659524424, 4463.709858859163, 4498.617617502484, 4505.031418245093, 4517.774111294488, 4519.367288579601, 3944.0, 3944.8619298324993, 3951.644352008333, 3983.5618082010956, 4010.6991975601945, 4575.771211439414, 4577.954220457753, 4578.816847326137, 4615.3077038443835, 4626.0, 5091.9236211456855, 5252.789888404421, 5300.708461034603, 5309.044372013074, 5335.813246536352, 4543.7728113594185, 4552.567506086916, 4558.361829343895, 4562.977185114053, 4598.494165641777, 4791.592714619296, 4813.879653008633, 4819.277108433763, 4822.517748225149, 4867.415910090741, 4861.440934292602, 4956.330895329084, 4992.425871024733, 5009.899802004013, 5013.498650134958, 5335.093034184276, 5359.303290572357, 5367.4364191759305, 5367.704776237344, 5423.620346575702, 4825.203841366135, 5000.049990501793, 5009.699418034929, 5011.774470148779, 5017.12200364942, 5175.741212939262, 5231.346081739783, 5235.424103348705, 5259.421463639073, 5263.578913686973, 5330.093884039645, 5334.306540149756, 5335.413104558573, 5341.973290133525, 5384.111621582395, 4971.950280497149, 5042.016806722654, 5150.201718733602, 5160.251763494347, 5163.8192663258105, 5073.036123136592, 5108.233764935289, 5123.154679477844, 5133.563647090039, 5183.663061900965, 5051.3433253676785, 5108.719020453762, 5110.923336149886, 5115.181570948779, 5117.411497677815, 5084.491550844886, 5100.183970564692, 5128.9487105129965, 5198.194279886624, 5210.166373380241, 5053.494650534917, 5063.898722025465, 5065.7720402581235, 5078.619103567321, 5114.309568208244], "value": 4842.70264268902, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.6429720471623, 576.2278546747358, 581.2211636407214, 590.5423296944864, 598.3119412675422, 27056.594151087724, 40257.3961390579, 41038.0, 41056.58943410565, 44465.33302000465, 40513.0, 41093.38359924604, 41095.58904410955, 41101.38347924784, 41119.38320925181, 7607.581583012932, 7805.297523222909, 7820.1788812174755, 7890.132085470579, 8051.51690898548, 7802.921970780305, 10177.08406243438, 10398.22013348998, 10402.739931501697, 10804.945975270113, 10481.685549433529, 10531.420771857545, 10536.473176341153, 10541.525631346607, 10556.894431055707, 7611.581363025031, 10015.649452269208, 10181.28730988831, 10233.692989210336, 10241.795164096751, 9914.760654918135, 10281.794364112751, 10293.897061029369, 10302.175825933908, 10311.175105991502, 37361.62638373609, 37657.435138472945, 37752.81123594392, 37805.05487362838, 37925.43111853324, 3037.7569794416395, 3090.8454577271045, 3133.0287610840483, 3482.0250329907667, 3696.722745794076, 26428.73571264282, 26539.867300663565, 26708.33229169267, 27049.0, 30550.69449305523, 3142.842857857098, 3232.5797646306064, 3480.3387356402204, 3612.963870361289, 3682.834272457746, 250833.0, 252791.0, 252905.0, 253560.0, 253933.0, 31905.361892762478, 32486.0, 32526.51210231801, 55476.16785748217, 55968.72015639896, 34433.82783086068, 34475.0, 34569.135771605404, 34693.30613387768, 34701.82649086738, 11826.11304152192, 11942.223755456042, 11943.16397852142, 11946.761064778655, 11950.521979120738, 9369.390989585656, 9521.19069879068, 9532.332736708364, 9598.712038638852, 9617.471039092778, 7983.2016798320865, 8015.078265999368, 8022.919770802334, 8070.47541909774, 8086.7169649062, 3119.1790057179774, 3133.3889891470944, 3134.2164458885277, 3157.842107894596, 3195.7603179761145, 830.5358697003605, 906.0531744327194, 918.169057003413, 929.5120061967522, 1049.9107575856137, 28120.43759124806, 28318.575221371695, 28505.714942850307, 28973.42053158925, 29060.854695726386, 952.2144231009445, 954.19370631816, 984.2372161574693, 987.8962708915604, 1024.073213741565, 14411.495597654031, 15019.0, 15082.849171508364, 15384.61538461525, 15488.22558872052, 375918.0, 377040.0, 378137.0, 378236.0, 381484.0, 33322.83338583291, 33421.665783342345, 33482.162945926546, 33624.0, 33633.0, 1070.834020726773, 1095.7479779650726, 1159.7390587117832, 1196.3121205306984, 1199.9040076793835, 26262.73737262603, 28759.137225883256, 29411.0, 29650.0, 29889.551656724732, 41605.79197103995, 41836.58163418327, 42086.0, 42097.15805683808, 42142.789286053376, 280490.0, 280890.0, 281209.0, 281271.0, 282092.0, 22422.77577224207, 24900.501989959736, 25092.12177573776, 25707.228783136536, 25961.274066222773, 41498.37752433776, 42067.0, 42238.57761422346, 42664.0, 43845.78077109722, 36255.63744362522, 36349.27301454009, 36637.26725465529, 36872.44691329686, 36884.446733298486, 35622.0, 36394.63605363912, 36482.27035459329, 36598.63401366059, 36605.450918236784, 34681.30637387289, 35512.46731299084, 36473.27053458863, 36560.634393655724, 36593.26813463769, 31186.376272474878, 32569.511457328634, 32714.509282360308, 33034.66965330316, 33119.50320745239, 24231.273061808173, 25166.49667006613, 25220.0, 25445.61831572565, 25669.101581445306], "value": 16530.921343441318, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.9033796381924, 378.9431585262211, 379.2415169660679, 391.83934586819373, 397.2829043576344, 15724.60688482787, 17520.386786462477, 17681.381151659694, 17858.732119018194, 17992.73010904836, 16761.0, 16807.495775126736, 17416.56458588536, 17513.299468021294, 17518.737218941693, 4897.632677549181, 5118.30902828119, 5146.099432599281, 5150.587952963754, 5163.967206558685, 3653.1962968146963, 3867.4198870169557, 5652.463016013472, 5973.850653733648, 5977.7608895644125, 5796.449337312949, 6014.699265036753, 6035.939640603582, 6061.9393806062035, 6072.6356418614805, 5939.049752039675, 5948.910766338508, 5952.0476723724, 5966.761329546856, 5974.97012514939, 3361.5966084069823, 3542.769719968194, 3545.680888720002, 3554.3957527220177, 4949.381327334083, 20547.280845170495, 21110.683339749918, 21270.93645317728, 21503.2473863414, 21516.0, 1947.57153426246, 1956.6575849226329, 2047.3550831488033, 2165.101482884601, 2353.976460235393, 12967.157134786208, 13313.467461301632, 13474.0, 13529.0, 13794.517191898336, 1735.2798588585722, 1785.8571314294825, 1856.4616261284211, 1875.2311552263507, 1892.2431027588937, 65945.0, 68101.65949170223, 68516.31483685199, 68518.0, 69298.65350673265, 9494.382865113745, 9618.230541556799, 9893.901060989298, 9944.154746846454, 10008.949955250177, 13544.0, 13545.66135846592, 13548.322583870768, 13589.388477518338, 13609.931950340382, 6942.687579058854, 7034.507584469038, 7047.92952070483, 7095.432365410755, 7150.856982860418, 6591.274959754423, 6594.2195607185795, 6618.106555615027, 6754.560953538103, 6756.662166891636, 6212.409821066992, 6238.500919926395, 6290.8427289317215, 6326.114343991845, 6326.49388048955, 1631.9673606527804, 1653.6196674764872, 1786.490850107739, 1797.703378942486, 1810.7646006019133, 792.5561685456048, 905.6753999651585, 953.1183655119125, 988.7033889833021, 990.5839547389969, 16706.749398759028, 17569.20938557768, 17570.209340579448, 17702.29190832378, 18027.549311267325, 844.1853611265159, 844.5144042175774, 868.5787393114334, 888.5024386343539, 916.2395211974045, 9844.950775246221, 9962.203023758228, 10160.187185025181, 10240.539175737109, 10446.268761186797, 382434.0, 387101.0, 399443.0, 400104.0, 404291.0, 65879.67060164668, 67943.0, 68270.65864670744, 71697.64151179315, 82229.0, 902.5577467041103, 921.7972046149837, 950.1638558068993, 954.9713508594614, 954.9952250238705, 16072.919635402215, 16161.353545858034, 16208.756868646744, 16337.754933676242, 16558.917205413894, 37221.25557488781, 37427.251454971294, 37704.43443348297, 38164.236715266095, 38791.0, 49133.0, 49156.0, 53270.73364633307, 55120.173197401265, 55650.16524752051, 7819.765407037798, 7968.163342848918, 8022.679092836222, 8117.959410202911, 8158.0, 9022.0, 11188.384638844942, 12107.33409662477, 12164.574239901915, 12205.511779528719, 9254.583543740682, 10095.596176153165, 10161.390316581028, 10190.949045255024, 10229.488525573543, 10409.479526023517, 10610.575576976835, 10747.193960453154, 10747.408892510986, 10817.350958942488, 9371.671991480265, 10125.088742013255, 10268.486575671335, 10314.793704126025, 10320.793584128125, 7858.960705196438, 7967.641456134372, 8214.096449390681, 8229.629666665134, 8315.168483151636, 9179.862302065341, 9951.800963980535, 9971.800563988825, 10253.0, 10333.844992325272], "value": 8407.850367953493, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1190.4345435917935, 1389.867962543558, 1438.050886414966, 1521.6195951012246, 1725.9137043147832, 7747.3027427531515, 8067.87898181527, 8075.555844428554, 8349.373796965221, 8365.07984121746, 8086.676532938675, 8303.0, 8306.04480484743, 8307.00315962084, 8317.085120636724, 1903.7144428335791, 2225.2879078694823, 2259.243153543565, 2294.9426264343356, 2298.080767692928, 2354.458474550854, 2365.5387199496104, 2367.7277113131954, 2369.6327069304198, 2369.834111612179, 2277.9202727904526, 2287.5310561334886, 2320.025589252518, 2320.269115228706, 2320.3966968588206, 1890.6029733755927, 2182.127149140357, 2248.3704562722464, 2262.3778460923213, 2266.92065777697, 2243.721078984979, 2286.017012684545, 2286.3483907086566, 2287.9199228027105, 2288.1533832481923, 8132.064812546574, 8174.3460523158, 8182.427230093896, 8189.0, 8189.631466584018, 4802.567768900815, 4948.183549714293, 4956.033573453178, 4958.20668693011, 4959.330490383824, 2916.5479350700675, 2958.9408211835857, 3120.9063728087967, 3143.811371317728, 3151.448496513124, 982.5529384130203, 1013.4375421640987, 1023.7389465686276, 1026.6663334416344, 1026.9332493387906, 11027.72430689231, 11305.49125289364, 11326.71683207918, 11348.659540213806, 11357.0, 4318.287482565404, 4537.069900670354, 4600.953990460052, 4601.953980460219, 4608.124456353282, 9767.218622510181, 9773.41359518431, 9808.852867206997, 9814.852777208347, 9825.656102036395, 4874.098291816025, 4875.512448755097, 4875.634327425457, 4879.219324908068, 4879.536444037811, 3805.980970095132, 4342.131573685276, 4473.530279320689, 4492.573205545468, 4525.298578720303, 3782.3759079752085, 3841.154945911951, 3901.453796468497, 3930.292547341506, 3977.54258260298, 1218.4334284557724, 1253.1040306181123, 1255.2280347586352, 1278.5844600504872, 1286.0097724752075, 797.4856217739641, 799.3525244551931, 809.8501777171242, 834.9457285276437, 842.0442797424967, 5239.240310155006, 5667.518260947783, 5675.772969081273, 5683.77264909399, 5881.029630111069, 832.2800777327568, 842.2714352085402, 864.7449002544264, 874.152072489684, 920.1764420843441, 3597.8920632380546, 3785.356489396809, 3882.495275614152, 3897.7271590988926, 3914.745541539791, 9772.657956971472, 10247.231457640706, 10273.486325683685, 10300.330478518872, 10301.38191708485, 9619.951900240454, 10059.647912323033, 10102.444365559817, 10328.845067323997, 10360.533775980099, 7467.925320746832, 7579.962100189464, 7753.728619498291, 7757.146713861471, 7834.608269586612, 5678.517326027169, 5729.197912292366, 5732.484076433141, 5736.856578585569, 5964.224650795369, 8953.149450802164, 9143.77140571491, 9174.495402752913, 9180.908190918273, 9711.0, 9280.95359523198, 9387.389819661701, 9391.906080939103, 9515.619375224913, 9898.653547125816, 6913.308669133046, 7075.646217689198, 7079.610621415872, 7832.255935686101, 8056.838863222585, 6750.696218670073, 7777.494462859896, 7789.298963093349, 8073.717419890276, 8077.071136819106, 6991.7902462926195, 7140.642967851482, 7213.931582787045, 7248.492605517774, 7373.77878663641, 6972.163340399185, 7091.82270443243, 7176.892346614909, 7196.712131514891, 7277.199508054004, 6406.967965160145, 6433.839154021187, 6495.512836537373, 6524.575902566318, 6571.408573228241, 4725.338452616706, 4739.976300118616, 4772.713637181641, 4850.1997170467885, 4877.414710234794, 4817.9518204817505, 4818.855434336975, 4847.418309802846, 4877.463479017234, 5007.974960125176], "value": 4354.549209958511, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.68308642098634, 308.4848303333433, 315.62913576547555, 316.9017604542592, 320.2506135642596, 4936.062148191841, 4940.555350018498, 4942.308076869237, 4959.528844759742, 4972.254161875716, 4879.756012199394, 4886.8778280543, 4906.803727850891, 4914.459409464956, 4953.157963146265, 3931.5478719947287, 3933.3903244997, 3954.090559171392, 3954.110325176841, 3957.683385329167, 3794.444277846084, 3920.0, 3927.607239276064, 3941.586133455989, 3955.624215699504, 3848.4419759134908, 3887.494625698655, 3887.4946256986696, 3887.708421868357, 3904.9219015619815, 3649.5802982656805, 3766.397376419787, 3809.1619843634357, 3866.381378979378, 3874.3607304794814, 3318.452455344865, 3353.748468864845, 3422.7946323220685, 3448.1207292140593, 3455.94816077759, 4774.618030557547, 4776.617870570346, 4777.113040349042, 4797.424309082898, 4802.087603355386, 4143.91712165755, 4208.494980602317, 4425.8229670813125, 4426.712263702849, 4433.179861725591, 5026.070177017264, 5062.2406639004075, 5072.920102757852, 5091.472558232515, 5094.363204599425, 3695.821593429648, 3696.4085746280466, 3701.889433170038, 3718.4980027696183, 3728.1611637381643, 5139.948600513984, 5301.231321458367, 5392.272043274147, 5402.540784033362, 5416.322959630046, 3789.7915614640906, 3799.2021675448464, 3803.7717736935874, 3816.6183381661613, 3818.1790914953417, 3883.4174873768598, 3885.786281754474, 3894.883153505399, 3899.161680238762, 3919.7648141111627, 4363.498197707241, 4372.344148377769, 4374.606285434263, 4393.428854248928, 4397.450318710161, 4837.830675926396, 5066.898662026812, 5092.344987878954, 5125.615578831528, 5146.433892271847, 1307.3528603341406, 1311.7442098790834, 1318.4133060787858, 1319.221659221064, 1325.7613629546581, 816.5835423933718, 834.588040562774, 849.723839752083, 850.5152063323847, 854.2439940652444, 4129.566395528486, 4148.522919864194, 4150.8547200847825, 4165.479315085614, 4185.832566697298, 4635.466921304026, 4761.976190119097, 4775.21209000518, 4777.402824646919, 4837.298591704253, 4094.3653733671326, 4154.379791881169, 4154.896127596834, 4192.434021407132, 4204.3693445983345, 2416.154345978893, 2523.0, 2527.9620805687928, 2549.6048112542217, 2559.628853816186, 4384.802683879233, 4393.472783266028, 4417.911641767147, 4480.215962206601, 4483.1843103543115, 4788.329633851264, 4800.5199480051715, 4804.40562096464, 4804.735739534359, 4825.30033145192, 4455.108978204372, 4599.33309670096, 4986.47641997585, 4988.401391833003, 5007.624428167902, 5300.231466437268, 5334.0, 5345.919811202913, 5354.437784032776, 5376.193570964387, 5181.870453238699, 5189.351331083614, 5201.817936372209, 5246.632735708617, 5246.842594722164, 4745.430548334222, 5002.699838009731, 5007.824726134568, 5008.6243531734535, 5010.3737032870895, 3769.8869033929027, 3814.4659747634796, 3827.08150043993, 3854.6145385461227, 3855.9807200964938, 5392.492490991551, 5392.919106213489, 5401.540869026177, 5408.269883565668, 5424.783008679608, 4901.264810278487, 5107.157319042465, 5144.9742751286, 5164.638475306842, 5182.792688292426, 5064.240363945438, 5072.898542029065, 5074.695518268915, 5074.771635276347, 5155.948440515547, 4864.197407427735, 5111.258867464271, 5131.640785145153, 5132.6150538709, 5187.351581052369, 4909.26361045846, 5035.194368900959, 5198.324217851655, 5208.453112423141, 5231.378272735465, 5078.695278283167, 5080.110980578458, 5085.931954289641, 5107.565856902205, 5119.360079990001], "value": 3822.9946282103633, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.4732595608621, 651.5894986158719, 713.5647255174342, 722.6964674836568, 756.3646536908997, 12578.874211257884, 13717.72564548711, 13736.244506552135, 13743.587692369232, 13757.931210343946, 13000.54498092567, 13143.211407315544, 13145.145565538258, 13183.143095698773, 13183.274919879403, 772.8029352515101, 804.1837534902079, 804.6982381606897, 805.3516918880299, 806.1857523900873, 787.7439832054577, 793.5952664141272, 795.8249185179251, 796.1004065406083, 796.2236819101388, 819.3445243804962, 821.5974172655416, 822.198356602314, 822.40786633624, 823.0617096509953, 821.5974172655416, 821.708293555788, 821.8109834737984, 822.3585603229491, 823.27551754456, 601.9909701354483, 602.340437221242, 602.770947040122, 603.8037637767699, 603.9033754599243, 11133.165012624086, 14105.717885642229, 14116.647083822883, 14130.293485325796, 14134.222617756019, 11224.494897729623, 12934.741305173939, 13169.736605267937, 13288.13627114244, 13603.523876664269, 11655.475503602358, 11995.880041199563, 12181.33002684852, 12296.631101066982, 12575.748485030248, 4347.195768782785, 4348.282533381988, 4391.6486681065435, 4410.713303635253, 4515.503294637587, 44892.77553612243, 52157.0, 53809.461905380835, 55216.44783552193, 64286.3571364285, 11119.833202501968, 11306.773864522827, 11329.943350283196, 11506.482208300647, 11736.354500502553, 20630.484237894172, 20666.173353065707, 20688.58622827535, 20697.172113115306, 20766.480837979172, 7199.568025918462, 7584.81037974044, 7597.278258565428, 7620.123685776096, 7652.502587331805, 3730.981345093257, 3848.191879705237, 3860.1507668312925, 3869.090763670535, 3901.785401802928, 3036.2561172512433, 3147.3705258948303, 3147.8426078695975, 3153.7477001839798, 3155.353152603711, 534.9010433069894, 538.5906710899744, 541.204429488651, 545.4164044472376, 552.7927027364739, 461.26198083067493, 461.9930701039487, 483.4899181363695, 524.1220954900526, 540.7566595032251, 7717.2668596483245, 7945.510786405663, 7948.205179482005, 8051.5571643559, 8224.0, 559.2087196616823, 573.7532860869783, 577.096843440015, 577.341830313443, 598.8053882488209, 3785.621437856192, 3954.4463775071513, 4045.5347635021762, 4212.620864122244, 4229.365595160689, 59967.70016149891, 75166.0, 97008.0, 99344.50327748315, 99977.50011249896, 86695.56652216699, 90092.0, 90295.54852225828, 90682.0, 90869.0, 49544.0, 75092.24907750962, 77836.22163778402, 78372.60813695895, 79057.60471197608, 8420.621072051896, 9142.908570914205, 9208.585613647536, 9217.631294748135, 9259.35184537076, 45183.32225016693, 46203.53796461992, 47698.0, 47752.0, 47955.0, 41350.79324603358, 65093.0, 67355.66322168357, 67426.3029478835, 68320.31679683339, 10776.461176941279, 10956.616518421817, 10987.945060274647, 12388.194767340094, 12750.0, 12883.162594431333, 13112.344382780631, 13242.80135797983, 13382.197068175941, 13519.188848669111, 10924.399158046384, 12145.514179432723, 12725.236485810881, 12956.0, 13063.542776002794, 11295.322280662858, 11365.374904380338, 11502.654920352403, 11870.169088163746, 12159.0, 11934.761304774029, 11935.224210426295, 12062.75874482488, 12224.511019559119, 13010.089293749725, 9935.751606209902, 10088.69733907984, 10218.642347517802, 10309.793804124025, 10557.155427565624, 10337.276390652883, 10552.20858435605, 10661.786764264827, 10678.199135064746, 10867.184961127788], "value": 6756.384176934262, "unit": "score"}], "name": "dromaeo_css", "value": 6504.230750101362, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 118.0, 115.0, 116.0, 114.0, 114.0, 114.0, 114.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 133.0, 132.0, 191.0, 139.0, 134.0, 164.0, 138.0, 192.0, 132.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 160.0, 160.0, 160.0, 161.0, 161.0, 162.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 103.0, 77.0, 77.0, 77.0, 76.0, 117.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 124.0, 86.0, 87.0, 88.0, 116.0, 85.0, 87.0, 129.0], "value": 97.3, "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, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 147.0, 146.0, 145.0, 147.0, 147.0, 148.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 63.0, 63.0, 63.0, 62.0, 61.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 81.0, 81.0, 82.0, 83.0, 83.0, 86.0, 86.0, 93.0, 89.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 146.0, 140.0, 126.0, 129.0, 141.0, 133.0, 153.0, 134.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 167.0, 170.0, 167.0, 164.0, 167.0, 172.0, 166.0, 165.0], "value": 167.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 69.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1548.3999999999999, "alertThreshold": 2.0}]} 02:46:13 INFO - Return code: 0 02:46:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:46:13 INFO - # TBPL SUCCESS # 02:46:13 INFO - Running post-action listener: _resource_record_post_action 02:46:13 INFO - ##### 02:46:13 INFO - ##### Finished run-tests step (success) 02:46:13 INFO - ##### 02:46:13 INFO - Running post-run listener: _resource_record_post_run 02:46:13 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 382390272; Read time: 8; Write time: 393964 02:46:13 INFO - TinderboxPrint: CPU usage
13.2% 02:46:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:46:13 INFO - TinderboxPrint: I/O write bytes / time
382,390,272 / 393,964 02:46:13 INFO - TinderboxPrint: CPU idle
8,331.7 (86.8%) 02:46:13 INFO - TinderboxPrint: CPU user
1,219.3 (12.7%) 02:46:13 INFO - TinderboxPrint: Swap in / out
0 / 0 02:46:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 71831552; Read time: 0; Write time: 85376 02:46:13 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292642816; Read time: 8; Write time: 299660 02:46:14 INFO - Running post-run listener: _upload_blobber_files 02:46:14 INFO - Blob upload gear active. 02:46:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:46:14 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 02:46:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:46:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:46:14 INFO - (blobuploader) - INFO - Open directory for files ... 02:46:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:46:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:46:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:15 INFO - (blobuploader) - INFO - Done attempting. 02:46:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:46:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:46:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:18 INFO - (blobuploader) - INFO - Done attempting. 02:46:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:46:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:46:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:19 INFO - (blobuploader) - INFO - Done attempting. 02:46:19 INFO - (blobuploader) - INFO - Iteration through files over. 02:46:19 INFO - Return code: 0 02:46:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:46:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:46:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b609f8d3ee8b94d1e4dd96eb5406815b1d9d208a35037ec854d038aca81ec83f99effaa00c4479e0ab840c88fcebef360cdd9c8e58683f3d4584b9f3b0e9eb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c16d400e6c6bc1ad572c30a65ea6630848d17871995a6a700f81327faae691fd267fe258ee0ec0b60702899acfe32f03cdf657a5640add5de76150d45d9029a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d13298b9a935f0f33d2a9970d76fc9f45d7fa834b2188b600f106771dd6f2d14d6089f506c5db0c275b46305a75d0ca1aaf70f9c64ecc2dbc0e3d32e3ba5b481"} 02:46:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:46:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:46:19 INFO - Contents: 02:46:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b609f8d3ee8b94d1e4dd96eb5406815b1d9d208a35037ec854d038aca81ec83f99effaa00c4479e0ab840c88fcebef360cdd9c8e58683f3d4584b9f3b0e9eb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c16d400e6c6bc1ad572c30a65ea6630848d17871995a6a700f81327faae691fd267fe258ee0ec0b60702899acfe32f03cdf657a5640add5de76150d45d9029a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d13298b9a935f0f33d2a9970d76fc9f45d7fa834b2188b600f106771dd6f2d14d6089f506c5db0c275b46305a75d0ca1aaf70f9c64ecc2dbc0e3d32e3ba5b481"} 02:46:19 INFO - Running post-run listener: copy_logs_to_upload_dir 02:46:19 INFO - Copying logs to upload dir... 02:46:19 INFO - mkdir: /builds/slave/test/build/upload/logs 02:46:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1308.607115 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 48 secs) (at 2016-06-28 02:46:19.506479) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 02:46:19.509974) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b609f8d3ee8b94d1e4dd96eb5406815b1d9d208a35037ec854d038aca81ec83f99effaa00c4479e0ab840c88fcebef360cdd9c8e58683f3d4584b9f3b0e9eb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c16d400e6c6bc1ad572c30a65ea6630848d17871995a6a700f81327faae691fd267fe258ee0ec0b60702899acfe32f03cdf657a5640add5de76150d45d9029a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d13298b9a935f0f33d2a9970d76fc9f45d7fa834b2188b600f106771dd6f2d14d6089f506c5db0c275b46305a75d0ca1aaf70f9c64ecc2dbc0e3d32e3ba5b481"} build_url:https://queue.taskcluster.net/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/HrEtig0TTsC1AwTtUtofwg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b609f8d3ee8b94d1e4dd96eb5406815b1d9d208a35037ec854d038aca81ec83f99effaa00c4479e0ab840c88fcebef360cdd9c8e58683f3d4584b9f3b0e9eb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c16d400e6c6bc1ad572c30a65ea6630848d17871995a6a700f81327faae691fd267fe258ee0ec0b60702899acfe32f03cdf657a5640add5de76150d45d9029a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d13298b9a935f0f33d2a9970d76fc9f45d7fa834b2188b600f106771dd6f2d14d6089f506c5db0c275b46305a75d0ca1aaf70f9c64ecc2dbc0e3d32e3ba5b481"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 02:46:19.535753) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:46:19.536188) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1467105868.495269-2109478074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004352 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 02:46:19.619618) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 02:46:19.619933) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 02:46:19.620266) ========= ========= Total master_lag: 0.16 =========