builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1468458015.98 results: success (0) buildid: 20160713152443 builduid: fb5f9fc9a81843ef95c1b9ce84958adb revision: 709652b674013b136627e45fd90b4e9063906a19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:15.979415) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:15.979870) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:15.980167) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:15.994960) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:15.995267) ========= 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=4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 18:00:16-- 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% 70.2M=0s 2016-07-13 18:00:16 (70.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128270 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:16.142502) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:16.142804) ========= 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=4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019528 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:16.191758) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:16.192106) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 709652b674013b136627e45fd90b4e9063906a19 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 709652b674013b136627e45fd90b4e9063906a19 --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=4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 18:00:16,300 truncating revision to first 12 chars 2016-07-13 18:00:16,300 Setting DEBUG logging. 2016-07-13 18:00:16,300 attempt 1/10 2016-07-13 18:00:16,300 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/709652b67401?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 18:00:16,621 unpacking tar archive at: mozilla-aurora-709652b67401/testing/mozharness/ program finished with exit code 0 elapsedTime=0.678005 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:16.887285) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:16.887559) ========= script_repo_revision: 709652b674013b136627e45fd90b4e9063906a19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:16.887931) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:16.888198) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 18:00:16.898080) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-13 18:00:16.898396) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:00:17 INFO - MultiFileLogger online at 20160713 18:00:17 in /builds/slave/test 18:00:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:00:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:00:17 INFO - {'append_to_log': False, 18:00:17 INFO - 'base_work_dir': '/builds/slave/test', 18:00:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:00:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:00:17 INFO - 'branch': 'Mozilla-Aurora', 18:00:17 INFO - 'buildbot_json_path': 'buildprops.json', 18:00:17 INFO - 'config_files': ('talos/linux_config.py',), 18:00:17 INFO - 'default_actions': ('clobber', 18:00:17 INFO - 'read-buildbot-config', 18:00:17 INFO - 'download-and-extract', 18:00:17 INFO - 'populate-webroot', 18:00:17 INFO - 'create-virtualenv', 18:00:17 INFO - 'install', 18:00:17 INFO - 'run-tests'), 18:00:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:00:17 INFO - 'download_minidump_stackwalk': True, 18:00:17 INFO - 'download_symbols': 'ondemand', 18:00:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:00:17 INFO - 'tooltool.py': '/tools/tooltool.py', 18:00:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:00:17 INFO - '/tools/misc-python/virtualenv.py')}, 18:00:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:00:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:00:17 INFO - 'installer_path': 'installer.exe', 18:00:17 INFO - 'log_level': 'info', 18:00:17 INFO - 'log_name': 'talos', 18:00:17 INFO - 'log_to_console': True, 18:00:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:00:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:00:17 INFO - 'opt_config_files': (), 18:00:17 INFO - 'pip_index': False, 18:00:17 INFO - 'sps_profile': False, 18:00:17 INFO - 'sps_profile_interval': 0, 18:00:17 INFO - 'suite': 'dromaeojs', 18:00:17 INFO - 'system_bits': '32', 18:00:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:00:17 INFO - 'title': 'talos-linux64-ix-030', 18:00:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:00:17 INFO - 'use_talos_json': True, 18:00:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:00:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:00:17 INFO - 'work_dir': 'build'} 18:00:17 INFO - ##### 18:00:17 INFO - ##### Running clobber step. 18:00:17 INFO - ##### 18:00:17 INFO - Running pre-action listener: _resource_record_pre_action 18:00:17 INFO - Running main action method: clobber 18:00:17 INFO - rmtree: /builds/slave/test/build 18:00:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:00:17 INFO - Running post-action listener: _resource_record_post_action 18:00:17 INFO - ##### 18:00:17 INFO - ##### Finished clobber step (success) 18:00:17 INFO - ##### 18:00:17 INFO - ##### 18:00:17 INFO - ##### Running read-buildbot-config step. 18:00:17 INFO - ##### 18:00:17 INFO - Running pre-action listener: _resource_record_pre_action 18:00:17 INFO - Running main action method: read_buildbot_config 18:00:17 INFO - Using buildbot properties: 18:00:17 INFO - { 18:00:17 INFO - "project": "", 18:00:17 INFO - "product": "firefox", 18:00:17 INFO - "script_repo_revision": "production", 18:00:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 18:00:17 INFO - "repository": "", 18:00:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 18:00:17 INFO - "buildid": "20160713152443", 18:00:17 INFO - "pgo_build": "True", 18:00:17 INFO - "basedir": "/builds/slave/test", 18:00:17 INFO - "buildnumber": 411, 18:00:17 INFO - "slavename": "talos-linux64-ix-030", 18:00:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:00:17 INFO - "platform": "ubuntu64_hw", 18:00:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:00:17 INFO - "branch": "mozilla-aurora", 18:00:17 INFO - "repo_path": "releases/mozilla-aurora", 18:00:17 INFO - "revision": "709652b674013b136627e45fd90b4e9063906a19", 18:00:17 INFO - "stage_platform": "linux64-pgo", 18:00:17 INFO - "builduid": "fb5f9fc9a81843ef95c1b9ce84958adb", 18:00:17 INFO - "slavebuilddir": "test" 18:00:17 INFO - } 18:00:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 18:00:17 INFO - Running post-action listener: _resource_record_post_action 18:00:17 INFO - ##### 18:00:17 INFO - ##### Finished read-buildbot-config step (success) 18:00:17 INFO - ##### 18:00:17 INFO - ##### 18:00:17 INFO - ##### Running download-and-extract step. 18:00:17 INFO - ##### 18:00:17 INFO - Running pre-action listener: _resource_record_pre_action 18:00:17 INFO - Running main action method: download_and_extract 18:00:17 INFO - mkdir: /builds/slave/test/build/tests 18:00:17 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')]} 18:00:17 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:00:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:00:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:00:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:00:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:00:22 INFO - Downloaded 1361 bytes. 18:00:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:00:22 INFO - Using the following test package requirements: 18:00:22 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 18:00:22 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:00:22 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:00:22 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:00:22 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 18:00:22 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:00:22 INFO - u'jsshell-linux-x86_64.zip'], 18:00:22 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:00:22 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:00:22 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 18:00:22 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:00:22 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:00:22 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:00:22 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:00:22 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:00:22 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:00:22 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:00:22 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:00:22 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:00:22 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')]} 18:00:22 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:00:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:00:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:00:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:00:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:00:25 INFO - Downloaded 24491003 bytes. 18:00:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:00:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:00:26 INFO - Return code: 0 18:00:26 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:00: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')]} 18:00:26 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:00:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:00:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:00:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:00:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:00:28 INFO - Downloaded 24491003 bytes. 18:00:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:00:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:00:29 INFO - Return code: 0 18:00:29 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')]} 18:00:29 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:00:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 18:00:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 18:00:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 18:00:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:00:30 INFO - Downloaded 10833369 bytes. 18:00:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:00:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:00:30 INFO - Return code: 0 18:00:30 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')]} 18:00:30 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:00:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:00:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:00:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:00:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:00:34 INFO - Downloaded 63642548 bytes. 18:00:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:00:34 INFO - mkdir: /builds/slave/test/properties 18:00:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:00:34 INFO - Writing to file /builds/slave/test/properties/build_url 18:00:34 INFO - Contents: 18:00:34 INFO - build_url:https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:00:34 INFO - Running post-action listener: _resource_record_post_action 18:00:34 INFO - Running post-action listener: set_extra_try_arguments 18:00:34 INFO - ##### 18:00:34 INFO - ##### Finished download-and-extract step (success) 18:00:34 INFO - ##### 18:00:34 INFO - ##### 18:00:34 INFO - ##### Running populate-webroot step. 18:00:34 INFO - ##### 18:00:34 INFO - Running pre-action listener: _resource_record_pre_action 18:00:34 INFO - Running main action method: populate_webroot 18:00:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:00:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:00:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:00:34 INFO - '--tppagecycles', 18:00:34 INFO - '7'], 18:00:34 INFO - 'tests': ['tsvgm']}}, 18:00:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:00:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:00:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:00:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:00:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:00:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:00:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:34 INFO - 'talos_options': ['--disable-e10s'], 18:00:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:00:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:00:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:34 INFO - 'talos_options': ['--disable-e10s'], 18:00:34 INFO - 'tests': ['damp', 'tps']}, 18:00:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:34 INFO - 'tests': ['damp', 'tps']}, 18:00:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:00:34 INFO - 'tests': ['dromaeo_dom']}, 18:00:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:00:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:00:34 INFO - 'tests': ['a11yr', 18:00:34 INFO - 'ts_paint', 18:00:34 INFO - 'tpaint', 18:00:34 INFO - 'sessionrestore', 18:00:34 INFO - 'sessionrestore_no_auto_restore', 18:00:34 INFO - 'tabpaint']}, 18:00:34 INFO - 'other-e10s': {'tests': ['a11yr', 18:00:34 INFO - 'ts_paint', 18:00:34 INFO - 'tpaint', 18:00:34 INFO - 'sessionrestore', 18:00:34 INFO - 'sessionrestore_no_auto_restore', 18:00:34 INFO - 'tabpaint']}, 18:00:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:00:34 INFO - 'ts_paint', 18:00:34 INFO - 'tpaint', 18:00:34 INFO - 'sessionrestore', 18:00:34 INFO - 'sessionrestore_no_auto_restore', 18:00:34 INFO - 'tabpaint']}, 18:00:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:00:34 INFO - 'ts_paint', 18:00:34 INFO - 'tpaint', 18:00:34 INFO - 'sessionrestore', 18:00:34 INFO - 'sessionrestore_no_auto_restore', 18:00:34 INFO - 'tabpaint']}, 18:00:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:00:34 INFO - 'tests': ['a11yr', 18:00:34 INFO - 'ts_paint', 18:00:34 INFO - 'tpaint', 18:00:34 INFO - 'sessionrestore', 18:00:34 INFO - 'sessionrestore_no_auto_restore', 18:00:34 INFO - 'tabpaint']}, 18:00:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:00:34 INFO - 'tests': ['a11yr', 18:00:34 INFO - 'ts_paint', 18:00:34 INFO - 'tpaint', 18:00:34 INFO - 'sessionrestore', 18:00:34 INFO - 'sessionrestore_no_auto_restore', 18:00:34 INFO - 'tabpaint']}, 18:00:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:00:34 INFO - 'tests': ['tsvgx', 18:00:34 INFO - 'tsvgr_opacity', 18:00:34 INFO - 'tart', 18:00:34 INFO - 'tscrollx', 18:00:34 INFO - 'cart']}, 18:00:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:00:34 INFO - 'tsvgr_opacity', 18:00:34 INFO - 'tart', 18:00:34 INFO - 'tscrollx', 18:00:34 INFO - 'cart']}, 18:00:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:34 INFO - 'talos_options': ['--disable-e10s'], 18:00:34 INFO - 'tests': ['tp5o']}, 18:00:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:34 INFO - 'tests': ['tp5o']}, 18:00:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:34 INFO - 'talos_options': ['--disable-e10s', 18:00:34 INFO - '--xperf_path', 18:00:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:00:34 INFO - 'tests': ['tp5n']}, 18:00:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:34 INFO - 'talos_options': ['--xperf_path', 18:00:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:00:34 INFO - 'tests': ['tp5n']}}, 18:00:34 INFO - 'talos.zip': {'path': '', 18:00:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:00:34 INFO - Running post-action listener: _resource_record_post_action 18:00:34 INFO - ##### 18:00:34 INFO - ##### Finished populate-webroot step (success) 18:00:34 INFO - ##### 18:00:34 INFO - ##### 18:00:34 INFO - ##### Running create-virtualenv step. 18:00:34 INFO - ##### 18:00:34 INFO - Running pre-action listener: _resource_record_pre_action 18:00:34 INFO - Running main action method: create_virtualenv 18:00:34 INFO - Creating virtualenv /builds/slave/test/build/venv 18:00:34 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 18:00:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:00:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:00:34 INFO - Using real prefix '/usr' 18:00:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:00:35 INFO - Installing distribute.............................................................................................................................................................................................done. 18:00:37 INFO - Installing pip.................done. 18:00:37 INFO - Return code: 0 18:00:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:00: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')]} 18:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00: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')]} 18:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e097e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ee350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147d1c0>, '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 0x147e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147e550>, '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': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', '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 18:00:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:00:37 INFO - Using env: {'DISPLAY': ':0', 18:00:37 INFO - 'HOME': '/home/cltbld', 18:00:37 INFO - 'LANG': 'en_US.UTF-8', 18:00:37 INFO - 'LANGUAGE': 'en_US:en', 18:00:37 INFO - 'LOGNAME': 'cltbld', 18:00:37 INFO - 'MAIL': '/var/mail/cltbld', 18:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:37 INFO - 'MOZ_NO_REMOTE': '1', 18:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:37 INFO - 'NO_EM_RESTART': '1', 18:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:37 INFO - 'PWD': '/builds/slave/test', 18:00:37 INFO - 'SHELL': '/bin/bash', 18:00:37 INFO - 'SHLVL': '1', 18:00:37 INFO - 'TERM': 'linux', 18:00:37 INFO - 'TMOUT': '86400', 18:00:37 INFO - 'USER': 'cltbld', 18:00:37 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', 18:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:37 INFO - '_': '/tools/buildbot/bin/python'} 18:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:37 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 18:00:37 INFO - Cleaning up... 18:00:37 INFO - Return code: 0 18:00:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:00: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')]} 18:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00: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')]} 18:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1e097e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ee350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147d1c0>, '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 0x147e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147e550>, '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': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', '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 18:00:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:00:37 INFO - Using env: {'DISPLAY': ':0', 18:00:37 INFO - 'HOME': '/home/cltbld', 18:00:37 INFO - 'LANG': 'en_US.UTF-8', 18:00:37 INFO - 'LANGUAGE': 'en_US:en', 18:00:37 INFO - 'LOGNAME': 'cltbld', 18:00:37 INFO - 'MAIL': '/var/mail/cltbld', 18:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:37 INFO - 'MOZ_NO_REMOTE': '1', 18:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:37 INFO - 'NO_EM_RESTART': '1', 18:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:37 INFO - 'PWD': '/builds/slave/test', 18:00:37 INFO - 'SHELL': '/bin/bash', 18:00:37 INFO - 'SHLVL': '1', 18:00:37 INFO - 'TERM': 'linux', 18:00:37 INFO - 'TMOUT': '86400', 18:00:37 INFO - 'USER': 'cltbld', 18:00:37 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', 18:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:37 INFO - '_': '/tools/buildbot/bin/python'} 18:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:37 INFO - Downloading/unpacking psutil>=3.1.1 18:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:00:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:00:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:00:39 INFO - Installing collected packages: psutil 18:00:39 INFO - Running setup.py install for psutil 18:00:40 INFO - building 'psutil._psutil_linux' extension 18:00:40 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 18:00:40 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 18:00:40 INFO - building 'psutil._psutil_posix' extension 18:00:40 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 18:00:40 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 18:00:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:00:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:00:40 INFO - Successfully installed psutil 18:00:40 INFO - Cleaning up... 18:00:40 INFO - Return code: 0 18:00:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1e097e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ee350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147d1c0>, '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 0x147e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147e550>, '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': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', '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 18:00:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:00:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:00:40 INFO - Using env: {'DISPLAY': ':0', 18:00:40 INFO - 'HOME': '/home/cltbld', 18:00:40 INFO - 'LANG': 'en_US.UTF-8', 18:00:40 INFO - 'LANGUAGE': 'en_US:en', 18:00:40 INFO - 'LOGNAME': 'cltbld', 18:00:40 INFO - 'MAIL': '/var/mail/cltbld', 18:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:40 INFO - 'MOZ_NO_REMOTE': '1', 18:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:40 INFO - 'NO_EM_RESTART': '1', 18:00:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:40 INFO - 'PWD': '/builds/slave/test', 18:00:40 INFO - 'SHELL': '/bin/bash', 18:00:40 INFO - 'SHLVL': '1', 18:00:40 INFO - 'TERM': 'linux', 18:00:40 INFO - 'TMOUT': '86400', 18:00:40 INFO - 'USER': 'cltbld', 18:00:40 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', 18:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:40 INFO - '_': '/tools/buildbot/bin/python'} 18:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:00:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:00:42 INFO - Installing collected packages: mozsystemmonitor 18:00:42 INFO - Running setup.py install for mozsystemmonitor 18:00:42 INFO - Successfully installed mozsystemmonitor 18:00:42 INFO - Cleaning up... 18:00:42 INFO - Return code: 0 18:00:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:00:42 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')]} 18:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:42 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')]} 18:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:42 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 0x7f1e097e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ee350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147d1c0>, '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 0x147e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147e550>, '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': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', '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 18:00:42 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 18:00:42 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 18:00:42 INFO - Using env: {'DISPLAY': ':0', 18:00:42 INFO - 'HOME': '/home/cltbld', 18:00:42 INFO - 'LANG': 'en_US.UTF-8', 18:00:42 INFO - 'LANGUAGE': 'en_US:en', 18:00:42 INFO - 'LOGNAME': 'cltbld', 18:00:42 INFO - 'MAIL': '/var/mail/cltbld', 18:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:42 INFO - 'MOZ_NO_REMOTE': '1', 18:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:42 INFO - 'NO_EM_RESTART': '1', 18:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:42 INFO - 'PWD': '/builds/slave/test', 18:00:42 INFO - 'SHELL': '/bin/bash', 18:00:42 INFO - 'SHLVL': '1', 18:00:42 INFO - 'TERM': 'linux', 18:00:42 INFO - 'TMOUT': '86400', 18:00:42 INFO - 'USER': 'cltbld', 18:00:42 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', 18:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:42 INFO - '_': '/tools/buildbot/bin/python'} 18:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:43 INFO - Downloading/unpacking jsonschema==2.5.1 18:00:43 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 18:00:43 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 18:00:43 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 18:00:43 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 18:00:43 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 18:00:43 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 18:00:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:00:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:00:45 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 18:00:45 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 18:00:45 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 18:00:45 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 18:00:45 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 18:00:45 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 18:00:45 INFO - Downloading functools32-3.2.3-2.tar.gz 18:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:00:45 INFO - warning: no files found matching '*.txt' 18:00:45 INFO - no previously-included directories found matching 'build' 18:00:45 INFO - no previously-included directories found matching 'dist' 18:00:45 INFO - no previously-included directories found matching '.git*' 18:00:45 INFO - Installing collected packages: jsonschema, functools32 18:00:45 INFO - Running setup.py install for functools32 18:00:45 INFO - warning: no files found matching '*.txt' 18:00:45 INFO - no previously-included directories found matching 'build' 18:00:45 INFO - no previously-included directories found matching 'dist' 18:00:45 INFO - no previously-included directories found matching '.git*' 18:00:45 INFO - Successfully installed jsonschema functools32 18:00:45 INFO - Cleaning up... 18:00:45 INFO - Return code: 0 18:00:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:00:45 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')]} 18:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:45 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')]} 18:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:45 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 0x7f1e097e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ee350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147d1c0>, '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 0x147e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147e550>, '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': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', '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 18:00:45 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 18:00:45 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 18:00:45 INFO - Using env: {'DISPLAY': ':0', 18:00:45 INFO - 'HOME': '/home/cltbld', 18:00:45 INFO - 'LANG': 'en_US.UTF-8', 18:00:45 INFO - 'LANGUAGE': 'en_US:en', 18:00:45 INFO - 'LOGNAME': 'cltbld', 18:00:45 INFO - 'MAIL': '/var/mail/cltbld', 18:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:45 INFO - 'MOZ_NO_REMOTE': '1', 18:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:45 INFO - 'NO_EM_RESTART': '1', 18:00:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:45 INFO - 'PWD': '/builds/slave/test', 18:00:45 INFO - 'SHELL': '/bin/bash', 18:00:45 INFO - 'SHLVL': '1', 18:00:45 INFO - 'TERM': 'linux', 18:00:45 INFO - 'TMOUT': '86400', 18:00:45 INFO - 'USER': 'cltbld', 18:00:45 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', 18:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:45 INFO - '_': '/tools/buildbot/bin/python'} 18:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:45 INFO - Downloading/unpacking blobuploader==1.2.4 18:00:45 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 18:00:45 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 18:00:45 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 18:00:45 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 18:00:45 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 18:00:45 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 18:00:47 INFO - Downloading blobuploader-1.2.4.tar.gz 18:00:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:00:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:00: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 18:00: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 18:00: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 18:00: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 18:00: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 18:00: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 18:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:00:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:48 INFO - Downloading docopt-0.6.1.tar.gz 18:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:00:48 INFO - Installing collected packages: blobuploader, requests, docopt 18:00:48 INFO - Running setup.py install for blobuploader 18:00:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:00:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:00:48 INFO - Running setup.py install for requests 18:00:49 INFO - Running setup.py install for docopt 18:00:49 INFO - Successfully installed blobuploader requests docopt 18:00:49 INFO - Cleaning up... 18:00:49 INFO - Return code: 0 18:00:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00: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')]} 18:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00: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')]} 18:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:49 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 0x7f1e097e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ee350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147d1c0>, '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 0x147e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147e550>, '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': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', '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 18:00:49 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 18:00:49 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 18:00:49 INFO - Using env: {'DISPLAY': ':0', 18:00:49 INFO - 'HOME': '/home/cltbld', 18:00:49 INFO - 'LANG': 'en_US.UTF-8', 18:00:49 INFO - 'LANGUAGE': 'en_US:en', 18:00:49 INFO - 'LOGNAME': 'cltbld', 18:00:49 INFO - 'MAIL': '/var/mail/cltbld', 18:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:49 INFO - 'MOZ_NO_REMOTE': '1', 18:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:49 INFO - 'NO_EM_RESTART': '1', 18:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:49 INFO - 'PWD': '/builds/slave/test', 18:00:49 INFO - 'SHELL': '/bin/bash', 18:00:49 INFO - 'SHLVL': '1', 18:00:49 INFO - 'TERM': 'linux', 18:00:49 INFO - 'TMOUT': '86400', 18:00:49 INFO - 'USER': 'cltbld', 18:00:49 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', 18:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:49 INFO - '_': '/tools/buildbot/bin/python'} 18:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:00:49 INFO - Running setup.py (path:/tmp/pip-JTHy9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:00:49 INFO - Running setup.py (path:/tmp/pip-puckm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:00:49 INFO - Running setup.py (path:/tmp/pip-zi1Ahq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:00:49 INFO - Running setup.py (path:/tmp/pip-yg4NjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:00:49 INFO - Running setup.py (path:/tmp/pip-4_Obim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:00:49 INFO - Running setup.py (path:/tmp/pip-EAt9P1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:00:49 INFO - Running setup.py (path:/tmp/pip-qqtk2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:00:49 INFO - Running setup.py (path:/tmp/pip-XRyMZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:00:49 INFO - Running setup.py (path:/tmp/pip-qtI0xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:00:50 INFO - Running setup.py (path:/tmp/pip-SbFO47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:00:50 INFO - Running setup.py (path:/tmp/pip-9BDQDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:00:50 INFO - Running setup.py (path:/tmp/pip-Dgagz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:00:50 INFO - Running setup.py (path:/tmp/pip-zAgtbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:00:50 INFO - Running setup.py (path:/tmp/pip-RAZCqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:50 INFO - Running setup.py (path:/tmp/pip-8eKj9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:00:50 INFO - Running setup.py (path:/tmp/pip-LzBvln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:00:50 INFO - Running setup.py (path:/tmp/pip-GiYlUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:00:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:00:50 INFO - Running setup.py install for manifestparser 18:00:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:00:50 INFO - Running setup.py install for mozcrash 18:00:50 INFO - Running setup.py install for mozdebug 18:00:50 INFO - Running setup.py install for mozdevice 18:00:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:00:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:00:51 INFO - Running setup.py install for mozfile 18:00:51 INFO - Running setup.py install for mozhttpd 18:00:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:00:51 INFO - Running setup.py install for mozinfo 18:00:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:00:51 INFO - Running setup.py install for mozInstall 18:00:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:00:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:00:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:00:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:00:51 INFO - Running setup.py install for mozleak 18:00:51 INFO - Running setup.py install for mozlog 18:00:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:00:51 INFO - Running setup.py install for moznetwork 18:00:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:00:51 INFO - Running setup.py install for mozprocess 18:00:51 INFO - Running setup.py install for mozprofile 18:00:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:00:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:00:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:00:51 INFO - Running setup.py install for mozrunner 18:00:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:00:52 INFO - Running setup.py install for mozscreenshot 18:00:52 INFO - Running setup.py install for moztest 18:00:52 INFO - Running setup.py install for mozversion 18:00:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:00:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:00:52 INFO - Cleaning up... 18:00:52 INFO - Return code: 0 18:00:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:52 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 0x7f1e097e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ee350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147d1c0>, '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 0x147e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147e550>, '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': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', '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 18:00:52 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 18:00:52 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 18:00:52 INFO - Using env: {'DISPLAY': ':0', 18:00:52 INFO - 'HOME': '/home/cltbld', 18:00:52 INFO - 'LANG': 'en_US.UTF-8', 18:00:52 INFO - 'LANGUAGE': 'en_US:en', 18:00:52 INFO - 'LOGNAME': 'cltbld', 18:00:52 INFO - 'MAIL': '/var/mail/cltbld', 18:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:52 INFO - 'MOZ_NO_REMOTE': '1', 18:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:52 INFO - 'NO_EM_RESTART': '1', 18:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:52 INFO - 'PWD': '/builds/slave/test', 18:00:52 INFO - 'SHELL': '/bin/bash', 18:00:52 INFO - 'SHLVL': '1', 18:00:52 INFO - 'TERM': 'linux', 18:00:52 INFO - 'TMOUT': '86400', 18:00:52 INFO - 'USER': 'cltbld', 18:00:52 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', 18:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:52 INFO - '_': '/tools/buildbot/bin/python'} 18:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:00:52 INFO - Running setup.py (path:/tmp/pip-ZK95k1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:00:52 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)) 18:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:00:52 INFO - Running setup.py (path:/tmp/pip-SRtmcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:00:52 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)) 18:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:00:52 INFO - Running setup.py (path:/tmp/pip-_hWEW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:00:52 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)) 18:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:00:52 INFO - Running setup.py (path:/tmp/pip-qQIEvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:00:52 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)) 18:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:00:52 INFO - Running setup.py (path:/tmp/pip-Wh3D9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:00:52 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)) 18:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:00:52 INFO - Running setup.py (path:/tmp/pip-CdoRw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:00:53 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)) 18:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:00:53 INFO - Running setup.py (path:/tmp/pip-kFG_bF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:00:53 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)) 18:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:00:53 INFO - Running setup.py (path:/tmp/pip-ndptsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:00:53 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)) 18:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:00:53 INFO - Running setup.py (path:/tmp/pip-R1t1X1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:00:53 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)) 18:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:00:53 INFO - Running setup.py (path:/tmp/pip-bY1jrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:00:53 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)) 18:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:00:53 INFO - Running setup.py (path:/tmp/pip-wJJk7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:00:53 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)) 18:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:00:53 INFO - Running setup.py (path:/tmp/pip-EZeeBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 18:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:00:53 INFO - Running setup.py (path:/tmp/pip-Rwb_yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:00:53 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)) 18:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:00:53 INFO - Running setup.py (path:/tmp/pip-ymwr_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 18:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:53 INFO - Running setup.py (path:/tmp/pip-8ZuuWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:53 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)) 18:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:00:53 INFO - Running setup.py (path:/tmp/pip-uXgPgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:00:53 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)) 18:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:00:53 INFO - Running setup.py (path:/tmp/pip-gI_1jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:00:53 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)) 18:00:53 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)) 18:00:53 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)) 18:00:53 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)) 18:00:53 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)) 18:00:53 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)) 18:00:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:00: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 18:00: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 18:00: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 18:00: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 18:00: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 18:00: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 18:00:55 INFO - Downloading blessings-1.6.tar.gz 18:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:00:55 INFO - Installing collected packages: blessings 18:00:55 INFO - Running setup.py install for blessings 18:00:55 INFO - Successfully installed blessings 18:00:55 INFO - Cleaning up... 18:00:56 INFO - Return code: 0 18:00:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:00:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:00:56 INFO - Reading from file tmpfile_stdout 18:00:56 INFO - Current package versions: 18:00:56 INFO - argparse == 1.2.1 18:00:56 INFO - blessings == 1.6 18:00:56 INFO - blobuploader == 1.2.4 18:00:56 INFO - docopt == 0.6.1 18:00:56 INFO - functools32 == 3.2.3-2 18:00:56 INFO - jsonschema == 2.5.1 18:00:56 INFO - manifestparser == 1.1 18:00:56 INFO - mozInstall == 1.12 18:00:56 INFO - mozcrash == 0.17 18:00:56 INFO - mozdebug == 0.1 18:00:56 INFO - mozdevice == 0.48 18:00:56 INFO - mozfile == 1.2 18:00:56 INFO - mozhttpd == 0.7 18:00:56 INFO - mozinfo == 0.9 18:00:56 INFO - mozleak == 0.1 18:00:56 INFO - mozlog == 3.2 18:00:56 INFO - moznetwork == 0.27 18:00:56 INFO - mozprocess == 0.23 18:00:56 INFO - mozprofile == 0.28 18:00:56 INFO - mozrunner == 6.12 18:00:56 INFO - mozscreenshot == 0.1 18:00:56 INFO - mozsystemmonitor == 0.3 18:00:56 INFO - moztest == 0.7 18:00:56 INFO - mozversion == 1.4 18:00:56 INFO - psutil == 3.1.1 18:00:56 INFO - requests == 1.2.3 18:00:56 INFO - wsgiref == 0.1.2 18:00:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:56 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')]} 18:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:56 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')]} 18:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:56 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 0x7f1e097e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ee350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147d1c0>, '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 0x147e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147e550>, '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': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', '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 18:00:56 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 18:00:56 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 18:00:56 INFO - Using env: {'DISPLAY': ':0', 18:00:56 INFO - 'HOME': '/home/cltbld', 18:00:56 INFO - 'LANG': 'en_US.UTF-8', 18:00:56 INFO - 'LANGUAGE': 'en_US:en', 18:00:56 INFO - 'LOGNAME': 'cltbld', 18:00:56 INFO - 'MAIL': '/var/mail/cltbld', 18:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:56 INFO - 'MOZ_NO_REMOTE': '1', 18:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:56 INFO - 'NO_EM_RESTART': '1', 18:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:56 INFO - 'PWD': '/builds/slave/test', 18:00:56 INFO - 'SHELL': '/bin/bash', 18:00:56 INFO - 'SHLVL': '1', 18:00:56 INFO - 'TERM': 'linux', 18:00:56 INFO - 'TMOUT': '86400', 18:00:56 INFO - 'USER': 'cltbld', 18:00:56 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', 18:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:56 INFO - '_': '/tools/buildbot/bin/python'} 18:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:56 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)) 18:00:56 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)) 18:00:56 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)) 18:00:56 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)) 18:00:56 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)) 18:00:56 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)) 18:00:56 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)) 18:00:56 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)) 18:00:56 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)) 18:00:56 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)) 18:00:56 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)) 18:00:56 INFO - Cleaning up... 18:00:56 INFO - Return code: 0 18:00:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:00:56 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')]} 18:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:56 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')]} 18:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:56 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 0x7f1e097e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ee350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147d1c0>, '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 0x147e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147e550>, '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': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', '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 18:00:56 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 18:00:56 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 18:00:56 INFO - Using env: {'DISPLAY': ':0', 18:00:56 INFO - 'HOME': '/home/cltbld', 18:00:56 INFO - 'LANG': 'en_US.UTF-8', 18:00:56 INFO - 'LANGUAGE': 'en_US:en', 18:00:56 INFO - 'LOGNAME': 'cltbld', 18:00:56 INFO - 'MAIL': '/var/mail/cltbld', 18:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:56 INFO - 'MOZ_NO_REMOTE': '1', 18:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:56 INFO - 'NO_EM_RESTART': '1', 18:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:56 INFO - 'PWD': '/builds/slave/test', 18:00:56 INFO - 'SHELL': '/bin/bash', 18:00:56 INFO - 'SHLVL': '1', 18:00:56 INFO - 'TERM': 'linux', 18:00:56 INFO - 'TMOUT': '86400', 18:00:56 INFO - 'USER': 'cltbld', 18:00:56 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', 18:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:56 INFO - '_': '/tools/buildbot/bin/python'} 18:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:00:56 INFO - Cleaning up... 18:00:56 INFO - Return code: 0 18:00:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:00:56 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')]} 18:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:56 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')]} 18:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:56 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 0x7f1e097e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ee350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x147d1c0>, '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 0x147e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147e550>, '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': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', '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 18:00:56 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 18:00:56 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 18:00:56 INFO - Using env: {'DISPLAY': ':0', 18:00:56 INFO - 'HOME': '/home/cltbld', 18:00:56 INFO - 'LANG': 'en_US.UTF-8', 18:00:56 INFO - 'LANGUAGE': 'en_US:en', 18:00:56 INFO - 'LOGNAME': 'cltbld', 18:00:56 INFO - 'MAIL': '/var/mail/cltbld', 18:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:56 INFO - 'MOZ_NO_REMOTE': '1', 18:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:56 INFO - 'NO_EM_RESTART': '1', 18:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:56 INFO - 'PWD': '/builds/slave/test', 18:00:56 INFO - 'SHELL': '/bin/bash', 18:00:56 INFO - 'SHLVL': '1', 18:00:56 INFO - 'TERM': 'linux', 18:00:56 INFO - 'TMOUT': '86400', 18:00:56 INFO - 'USER': 'cltbld', 18:00:56 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', 18:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:56 INFO - '_': '/tools/buildbot/bin/python'} 18:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:56 INFO - Downloading/unpacking flake8 18:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:00:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:00: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 18:00: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 18:00: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 18:00: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 18:00: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 18:00: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 18:00:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:00:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:00:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:00:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:00:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:00:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:00:59 INFO - no previously-included directories found matching 'docs/_build' 18:00:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:00:59 INFO - Running setup.py install for pep8 18:00:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:00:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:00:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:00:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:00:59 INFO - no previously-included directories found matching 'docs/_build' 18:00:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:00:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:00:59 INFO - Cleaning up... 18:00:59 INFO - Return code: 0 18:00:59 INFO - Running post-action listener: _resource_record_post_action 18:00:59 INFO - Running post-action listener: _start_resource_monitoring 18:00:59 INFO - Starting resource monitoring. 18:00:59 INFO - ##### 18:00:59 INFO - ##### Finished create-virtualenv step (success) 18:00:59 INFO - ##### 18:00:59 INFO - ##### 18:00:59 INFO - ##### Running install step. 18:00:59 INFO - ##### 18:00:59 INFO - Running pre-action listener: _resource_record_pre_action 18:00:59 INFO - Running main action method: install 18:00:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:01:00 INFO - Reading from file tmpfile_stdout 18:01:00 INFO - Detecting whether we're running mozinstall >=1.0... 18:01:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:01:00 INFO - Reading from file tmpfile_stdout 18:01:00 INFO - Output received: 18:01:00 INFO - Usage: mozinstall [options] installer 18:01:00 INFO - Options: 18:01:00 INFO - -h, --help show this help message and exit 18:01:00 INFO - -d DEST, --destination=DEST 18:01:00 INFO - Directory to install application into. [default: 18:01:00 INFO - "/builds/slave/test"] 18:01:00 INFO - --app=APP Application being installed. [default: firefox] 18:01:00 INFO - mkdir: /builds/slave/test/build/application 18:01:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:01:15 INFO - Reading from file tmpfile_stdout 18:01:15 INFO - Output received: 18:01:15 INFO - /builds/slave/test/build/application/firefox/firefox 18:01:15 INFO - Running post-action listener: _resource_record_post_action 18:01:15 INFO - ##### 18:01:15 INFO - ##### Finished install step (success) 18:01:15 INFO - ##### 18:01:15 INFO - ##### 18:01:15 INFO - ##### Running run-tests step. 18:01:15 INFO - ##### 18:01:15 INFO - Running pre-action listener: _resource_record_pre_action 18:01:15 INFO - Running main action method: run_tests 18:01:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:01:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:01:15 INFO - Python 2.7.3 18:01:15 INFO - Return code: 0 18:01:15 INFO - grabbing minidump binary from tooltool 18:01:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:15 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 0x147d1c0>, '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 0x147e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x147e550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:01:15 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 18:01:15 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 18:01:15 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 18:01:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:01:16 INFO - Return code: 0 18:01:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:01:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:01:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:01:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:01:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:01:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:01:16 INFO - Return code: 0 18:01:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 18:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 18:01:16 INFO - Using env: {'DISPLAY': ':0', 18:01:16 INFO - 'HOME': '/home/cltbld', 18:01:16 INFO - 'LANG': 'en_US.UTF-8', 18:01:16 INFO - 'LANGUAGE': 'en_US:en', 18:01:16 INFO - 'LOGNAME': 'cltbld', 18:01:16 INFO - 'MAIL': '/var/mail/cltbld', 18:01:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:01:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:16 INFO - 'MOZ_NO_REMOTE': '1', 18:01:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:01:16 INFO - 'NO_EM_RESTART': '1', 18:01:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:16 INFO - 'PWD': '/builds/slave/test', 18:01:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:01:16 INFO - 'SHELL': '/bin/bash', 18:01:16 INFO - 'SHLVL': '1', 18:01:16 INFO - 'TERM': 'linux', 18:01:16 INFO - 'TMOUT': '86400', 18:01:16 INFO - 'USER': 'cltbld', 18:01:16 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164', 18:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:16 INFO - '_': '/tools/buildbot/bin/python'} 18:01:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 18:01:17 INFO - mozversion application_buildid: 20160713152443 18:01:17 INFO - mozversion application_changeset: 709652b674013b136627e45fd90b4e9063906a19 18:01:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:01:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:01:17 INFO - mozversion application_name: Firefox 18:01:17 INFO - mozversion application_remotingname: firefox-dev 18:01:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:01:17 INFO - mozversion application_vendor: Mozilla 18:01:17 INFO - mozversion application_version: 49.0a2 18:01:17 INFO - mozversion platform_buildid: 20160713152443 18:01:17 INFO - mozversion platform_changeset: 709652b674013b136627e45fd90b4e9063906a19 18:01:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:01:17 INFO - mozversion platform_version: 49.0a2 18:01:17 INFO - using testdate: 1468458077 18:01:17 INFO - actual date: 1468458077 18:01:17 INFO - starting webserver on 'localhost:40994' 18:01:17 INFO - SUITE-START | Running 2 tests 18:01:17 INFO - TEST-START | dromaeo_css 18:01:17 INFO - operating with platform_type : linux_ 18:01:17 INFO - Initialising browser for dromaeo_css test... 18:01:17 INFO - TEST-INFO | started process 17745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdiY5g1/profile http://localhost:40994/getInfo.html) 18:01:21 INFO - PROCESS | 17745 | __metrics Screen width/height:1600/1200 18:01:21 INFO - PROCESS | 17745 | colorDepth:24 18:01:21 INFO - PROCESS | 17745 | Browser inner width/height: 1024/697 18:01:21 INFO - PROCESS | 17745 | __metrics 18:01:22 ERROR - PROCESS | 17745 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:01:23 INFO - TEST-INFO | 17745: exit 0 18:01:23 INFO - Browser initialized. 18:01:23 INFO - Running cycle 1/1 for dromaeo_css test... 18:01:23 INFO - TEST-INFO | started process 17840 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdiY5g1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:01:34 INFO - PROCESS | 17840 | RSS: Main: 145342464 18:01:34 INFO - PROCESS | 17840 | 18:02:26 INFO - PROCESS | 17840 | 1468458146079 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] 18:04:34 INFO - PROCESS | 17840 | Cycle 1(1): loaded http://localhost:40994/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40994/tests/dromaeo/cssquery-ext.html) 18:04:35 INFO - PROCESS | 17840 | RSS: Main: 254140416 18:04:35 INFO - PROCESS | 17840 | 18:07:37 INFO - PROCESS | 17840 | Cycle 1(1): loaded http://localhost:40994/tests/dromaeo/cssquery-ext.html (next: http://localhost:40994/tests/dromaeo/cssquery-jquery.html) 18:07:38 INFO - PROCESS | 17840 | RSS: Main: 229179392 18:07:38 INFO - PROCESS | 17840 | 18:10:40 INFO - PROCESS | 17840 | Cycle 1(1): loaded http://localhost:40994/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40994/tests/dromaeo/cssquery-mootools.html) 18:10:40 INFO - PROCESS | 17840 | RSS: Main: 223207424 18:10:40 INFO - PROCESS | 17840 | 18:13:42 INFO - PROCESS | 17840 | Cycle 1(1): loaded http://localhost:40994/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40994/tests/dromaeo/cssquery-prototype.html) 18:13:43 INFO - PROCESS | 17840 | RSS: Main: 223522816 18:13:43 INFO - PROCESS | 17840 | 18:16:46 INFO - PROCESS | 17840 | Cycle 1(1): loaded http://localhost:40994/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40994/tests/dromaeo/cssquery-yui.html) 18:16:46 INFO - PROCESS | 17840 | RSS: Main: 217571328 18:16:46 INFO - PROCESS | 17840 | 18:19:49 INFO - PROCESS | 17840 | Cycle 1(1): loaded http://localhost:40994/tests/dromaeo/cssquery-yui.html (next: http://localhost:40994/tests/dromaeo/cssquery-dojo.html) 18:19:49 INFO - PROCESS | 17840 | RSS: Main: 255320064 18:19:49 INFO - PROCESS | 17840 | 18:19:49 INFO - PROCESS | 17840 | __start_tp_report 18:19:49 INFO - PROCESS | 17840 | _x_x_mozilla_page_load 18:19:49 INFO - PROCESS | 17840 | _x_x_mozilla_page_load_details 18:19:49 INFO - PROCESS | 17840 | |i|pagename|runs| 18:19:49 INFO - PROCESS | 17840 | |0;dojo.html;3297.4064668359697;3304.0913748719113;3316.204111013357;3339.8163101029436;3353.6646335366468;5380.166074258491;5442.074847275962;5458.9454105458935;5466.289382380285;5474.91787623186;5502.889942201154;5539.778408863641;5558.194061861038;5558.972205138979;5579.553635709143;4932.260160975864;5029.974850125754;5042.873928151789;5087.262346959688;5117.7185254810975;4901.632377571678;5016.49835016499;5063.898722025558;5068.695878247298;5070.29015937769;4970.602351811846;5001.17480615698;5002.9499705002845;5036.722980236085;5047.419546752116;5102.311187989611;5116.872078198037;5117.437081921004;5118.181091025455;5143.43422223557;4867.221244600847;4943.530364615356;4968.652194346397;5010.223415370587;5048.974755126201;5342.866428339284;5362.302900622933;5364.865878353034;5392.164214546751;5438.782448702047;5898.262717160355;5908.734106965197;5936.554758393095;5946.583739138262;5947.821565353046;5822.330432000332;5850.941490585083;5864.266966629171;5885.646861188342;5921.703914804242;5509.090999984997;5517.172424136372;5552.972235138839;5553;5563.276774019351;5833.766649334064;6054.354650641292;6065.878682426327;6072.908906366408;6085.026395776655;5719.542436605062;5738.483536481736;5744.368119506851;5848.181254624356;5849.239598852207;5892.705364731746;5898.3216930053595;5900;5936.643801371932;5937.317208520989;5704.743286552115;5740.138979153077;5840.240768700041;5846.6784326862435;5856.502197313191;5773.740181691834;5842.211301474332;5846.766129354864;5850.5904586678525;5884.529237660977;4502.527234640381;4506.3465797459185;4507.301368287921;4509.774511274489;4538.52345503724;4006.1787333597126;4007.3788562772816;4031.9395209071886;4042.717009809344;4069.328560787437;5620.5503559715125;5630.971845140748;5644.943550564524;5645.689487078168;5668.659880407106;5907.409259074144;5916.585838991229;5929.555283353766;5933.821985340447;5964.045752679551;5489.066858634042;5544.833654990357;5578.748956296977;5578.9163162552595;5583.972080139573;5006.799728010911;5031.622628302819;5033.119204139261;5039.798408063636;5048;6111.16925576507;6115.757578772925;6123.28262147438;6127.861529871541;6129.786714141072;5710.971445142748;5778.797742079007;5797.333306669619;5816.47651711348;5893.02765043763;6067.24159480065;6080.3919608040615;6080.543959202989;6087.57386982907;6092.634441933498;5767.711614419346;5769.538436924952;5770.192173095854;5772.018756811268;5773.451522105393;5768.884622307446;5810.389909059488;5838.386969368155;5869.6771677556435;5894.6757928314355;5735.197072409949;5750.338711048283;5750.568707347049;5760.049591817303;5772.711364431846;5627.296587926509;5674.687892165971;5732.455416735404;5742.741576628978;5745.850829833967;5578.63738856973;5597.244372009726;5623.606347555632;5667;5671.319441667027;5765.1928729977;5770.942290577041;5809.970950145223;5816.82549523515;5822.272215973004;5477.123660214346;5519.724013799374;5646.181303710857;5646.435356464321;5681 18:19:49 INFO - PROCESS | 17840 | |1;ext.html;599.8830228105519;648.2804087462916;652.9934700652993;654.5320096131265;655.0796131435335;33437.33125337492;46085;46998.53001469984;47059.76470117653;47141.29288060677;48705;49409;49430.25854612184;49532.75233623827;49547.25679114807;8248.505089694638;8386.916130838705;8973.237274831647;9177.495237761954;10676.78646427071;10557;10959.890401095967;10971.341719496855;10973.177011724112;10973.725656858562;10971.670849874477;10997.230193886431;11001.284916480403;11007.06439952601;11008.449577521133;8364.707235246768;10951.288166269247;11011.174161937846;11181.664550063511;11240.044596209333;10597.788044239149;10962.945185274102;10973.23187376884;10976.012158905736;10980.450977451175;45825.312620310724;46247.537524625;46266.30600540995;46438.76780616109;46457.76771116123;3813.2564149990762;3866.903327416809;3905.33609286422;3954.4463775071513;4365.930347064989;34926.65073349259;35409.46885796715;35719.64280357189;35768.64231357679;35847.82076089629;4729.929051064237;4830.4203495580405;4887.242477416006;4900.803967841318;4936.259561065833;372521;378731;379143;381698;382106;38999.2200156001;70384;70471.64764176146;70808.2919170812;71294;40099.1980160401;41567.58432415637;41861.79069104696;41871.58128418738;41884.16231675349;15054.473093441677;15222;15228.314725837365;15230.238488075553;15238.771418428732;11361.659150225507;11995.460204290828;12195.14633975631;12239.877601224052;12494.437750301258;9511.381760185566;9519.857202141973;9528.19010384125;9579.473128977974;9606.759831004281;3555.2000799819834;3572.821358932095;3609.819509024538;3610.7833529988284;3626.3291291111227;1101.2291396022815;1119.7536541960756;1142.497301187475;1146.5184622458587;1169.363667124452;34475;34811.65188348135;34888.47667284993;35026;35115.64884351175;1194.6117511808698;1211.6062279759115;1226.3316492511603;1233.5929143382662;1274.668586167603;18190;18316.358927437475;18357.265709371743;18410.907945460454;18435;504053;504379;505386;506176;507491;65134.67432662806;65473.34526654768;65554;65684.34315656782;65927.34072659307;1338.4579245405625;1416.9504067357593;1446.5587995661424;1449.4419648435428;1474.3512854344053;33929.66070339364;35796.821015894755;35931.28137437289;36153.819230903675;36196;55986.160207596105;56514.15228771654;56859.71570142123;56948.71525642345;56956.715216423654;420149;422107;422540;422616;422934;31197.220069498446;31810;40838.59161408348;46166.76916615396;47003.76498117488;52788.47211527989;53245;53322;53467.73266133644;53780.46219537754;42728;43932.78033609811;43975;45182.77408612936;45805;43388;43494.56505434905;43740.125197496505;44340.778296108314;46527.30209046935;45370.77314613406;45865.54134458613;45894.31158532691;46271.30593041174;46298.768506157256;37853.81073094617;39943.400848986705;40228.59771402366;40601.593984060964;40688;30107.3978520424;30162.396752064396;30426.695733042387;30529.389412212076;30780.23049423782 18:19:49 INFO - PROCESS | 17840 | |2;jquery.html;426.4860842684565;428.3318023882743;432.1357285429142;438.9209207541994;439.76472587165875;18803.811961880376;20244.493887652818;20791.064402101903;21467.463313417134;21511;17153.142342882868;17517.73723394147;17717.29130834768;17717.7342339865;17723.202455889485;5750.1949727038245;5937.4656280934705;5989.251343582052;5989.8203053908455;5993.730282137292;4404.427424434819;4868.951310486886;5911.142884281798;5973.701314934257;6579.111819904299;6556.6066036037755;6641.535092543524;6651.501137414713;6654.234763002269;6719.0593316935665;6495.123158373606;6543.705533251015;6630.436412904909;6635.5023373247195;6694.598324100545;3952.229315283521;5483.287172667528;5815.505682017034;5906.881862362771;5907.645541267495;24272.757272427225;24537.38656533583;24695;24736.876315618487;24920.626190607156;2316.652502124678;2447.05788271515;2556.3736884463237;3045.3756979819304;3295.8187299698507;10468.52891619879;10514.789704205874;10728.034476897039;10796.082333001705;10925.125989920787;1920.9039548022683;2009.2867032203503;2086.2593779208314;2090.8536402451837;2148.1514801653416;65987.67006164987;84907.57546212291;84997;86240.56879715624;89456;11951.22317049389;11958.820617690742;11960.58137965167;11963.162578619413;12081.221319096481;17163.828361716474;17220.225089870986;17270.050147242022;17292.567685807957;17305.221265043103;8334.791630209293;8387.916120838836;8402.663893444316;8437.915620843713;8539;7858.607069646495;7871.17352677972;7924.841503169904;7930.920690793134;8080.595970201466;4926.482719314492;5059.19052951526;5086.949130508721;5235.345581802275;5246.291750613695;1951.6291904538093;2076.719642848196;2084.343431818972;2115.1433669363932;2171.7502487214174;990.3711143423977;1047.8323468245044;1057.3338796558119;1074.7098283463422;1142.8057230270874;19581.412557623295;19632.21471141167;19634;19743.210271588974;19944;1008.6671398438498;1021.9897801021895;1030.7989941961246;1032.746976990627;1079.9082078023298;10665.306755060896;10957.50691218897;11088.5564577416;11206.943965280121;11303.886961130447;471131;482146;552497;558677;560578;97033;98848.50575747219;100005;102699;106783.4660826691;1076.0960792933972;1086.7174534620897;1127.7293449572207;1132.8583927009288;1133.4559411482535;13696.65758356049;17057.829421705625;17641.911790440965;18201;18363.17365718519;42266.57733422626;42274.7886260579;42869.57130428656;43925.341119883866;44005.55994440015;54283.72858135684;54738.45261547333;57078.7146064267;63512.68243658752;63645;8167.509949403055;8531.976162860496;8693.869591956;8711.303095752452;8762.255208307366;12697.8095328572;13616.523421680193;13734.244616545786;14102.360327425697;14114.858851411765;12281.38593070325;12535.435905384098;12565.18326308787;12759.170653907466;12793.936030319788;12154.149209555246;12306.446209920396;12446.315452650191;12727.93636031814;12748.362581871055;12565.811512827499;12580.937095314464;12765.553205637758;12837.42231599599;12888.355582220664;9387.202087822612;9400.95299523498;9498.382605130644;9528.19010384125;9658.420494770337;12225.266484010988;12398.62804115878;12649.430775615303;12662;12673.683157920757 18:19:49 INFO - PROCESS | 17840 | |3;mootools.html;1407.8944079194064;1554.97667534987;1601.2634188273396;1778.6442711457712;1894.857885658575;9213.815723685531;9583.233341332694;9585.760355991104;9842.163416109639;9856.507174641276;9549.37929034614;9749.31754777166;9761.267904907125;9761.951190244057;9766.414015159095;2164.8809315487642;2224;2225.2211725895886;2432.501337225873;2457.1768457566736;2450.816188785848;2524.7096583892903;2526.6589010483626;2537.2895589235045;2559.2322303309024;2458.520588485246;2466.654668346433;2485.1177831869695;2495.6131799571094;2500.6874140732407;2143.089187095494;2215.0586000949693;2494.052260141144;2528.835625684334;2529.734377890332;2153.2786516516985;2384.4158181245534;2461.200109964269;2486.2168416948784;2486.751324867517;9122.680706175252;9214.585343659552;9219.124183202584;9440.811183776355;9476.431414115175;5308.177232528926;5377.973110134463;5402.486763757437;5440.401555828856;5440.945590544123;3729.216864458467;3806.6764325032404;3834.4440056191975;3989.40158976153;3996.160806230695;1222.8165775133712;1232.7041510037527;1285.787845005573;1293;1325.7282257137263;13628.795568066487;13923.443062277496;13975.37110830015;13985.510507132201;13993.720125597532;4968.6025117990475;4970.080535101018;5057.671251368649;5083.313752643419;5130.846074617767;11658.6502404928;11661.300321980709;11665.533378664759;11667.708307292385;11674.824877626843;5395.81114660985;5467.917981230285;5476.288082549323;5479.589030822704;5481.397046324901;4141.337386018223;4279.379489973936;4878.390201224847;4972;5061.670991385548;4415.977920110443;4419.337099435046;4473.507914129443;4507.143642707875;4518.796654150571;1369.9315034248248;1414.589768966988;1427.3719563392074;1429.1496559547054;1429.842717301096;896.1755185229605;1095.0820321395672;1102.311055590256;1103.3986477369854;1117.2626066796038;6357.4914006879335;6508.837279067967;6652.268250492442;6694.129763130762;6741;992.925530585209;1008.7982403519326;1011.5245834457793;1088.2762962629763;1091.5851976249132;4645.465771436328;4687.2500399936525;4723.244280915037;4743.596794272526;4793.304970779218;12122.939385303194;12428.067894907917;12448.564300249447;12469.127161098637;12480.81278780819;11427.885721142682;11715.062794976382;11799.115066369885;12248.510059597695;12326.938365308117;8859;8996.730098097067;9001.459912405277;9010.549472526478;9014.414063085878;6738.393544580815;6805.9659701701175;6878.518503704692;6981.441484681315;7077.6461176941975;11172.776544469227;11280.210385272952;11334.14993875446;11519.19365644397;11657.300561966309;11497.827532587185;11743.295402275891;11784;11944.76110477803;11946.940265298965;8608.569571521524;8621;8686.131386861263;8705.477671339486;8707.695230666895;8817.426867253607;8911.331650126136;8951.507667078373;8980.595873185592;9038;8017.398695097774;8030.879536806836;8037.31682806968;8094.433389662667;8173.468724532886;7641.503302285334;7723.304902558797;7793.454458187873;7865.4494185406475;8029.638666260149;7446.180920098893;7684.385249179941;7691.923080769121;7907.723229686933;7917.643706033357;5733.655980641175;5828.970855145697;5867.031939730067;5943.316518600416;5995.910061348996;5770.307563092288;5774.624649397776;5821.883562328814;5846.41535846412;5933.732982015733 18:19:49 INFO - PROCESS | 17840 | |4;prototype.html;346.0673484958038;355.44550501218094;356.6326683515978;362.9310431018105;366.7451121470579;5443.510084092431;5460.262864513289;5473.261109750182;5516.0898451755465;5516.310461192351;5405.216278628053;5418.729063546826;5426.484483974026;5510.228568000473;5517.751701173447;3860.2665493556274;4059.776712280823;4225.640820530259;4238.364245363189;4239.40648309237;4214.861987263453;4237.131388065454;4238.512571054322;4259.148170365924;4272.846331490496;4134.710570260083;4267.381229721688;4273.487181538219;4284.828606855722;4288.506821715511;4141.461609990697;4244.596763307481;4250.64089430366;4266.783966569544;4274.166537525184;3758.455024021529;3779.263043706478;3779.9622003779887;3788.2612890486366;3800.7529510581726;5214.765335559909;5240.187770895517;5248.422673505911;5254.500822421864;5269.394019687747;4907.803687852482;4912.729799861042;4915.5084491550915;4935.383077115361;4952.826651067231;5415;5538.83684426271;5581.944180558183;5583.413741557119;5745.3105627324985;4031.9193616127513;4058.1477889642915;4143.8135283912;4155.97922010391;4198.706090573661;5870.6477611343025;5886.381929897342;5888.263967004167;5894.233749612566;5907.379725128885;3935;4130.719476962151;4164.75011499311;4165.625093741517;4176.415301857743;4143.233501802116;4208.558101399309;4223.767692776927;4248.362745588187;4284.957150428456;4853.466118726938;4864.270359446041;4878.609711223094;4881.706347817832;4898.436679781799;5732.541396688338;5767.971160144172;5806.303243610793;5806.912896306559;5827.417258274223;1446.5515690136092;1464.5093893545782;1480.489231215229;1481.8369979302267;1484.7550154224432;919.2695320037478;926.2173463423396;929.0941332201049;950.5532399772235;952.2334520710895;5030.396352437658;5050.3434553507805;5099.311592934981;5124.180131179068;5178.83476217848;5193.922770625041;5233;5244.9737751310995;5288.435108972146;5298.390685071189;4833.777348809057;5061.304463004934;5114.897702045938;5119.3088932994315;5160.974195129075;2812.85935703214;2819.0971094511124;2830.320723026459;2842.2894276430893;2872.971270287312;5444.91832622511;5456.399796022434;5465.945340546544;5486.780528778804;5489.533389661844;5307.389650190277;5370.758315875795;5641.548676105902;6084.714254302627;6089.8477538061015;5936.970315148396;6008.3390827009;6056.939430605726;6171.352008039091;6225;5908.995470770065;5917.763289468373;5928.34788173292;5941.58408911372;5945.31628862669;5570.359408668055;5825.330087040044;5833.591648584558;5843.853903652443;5869.765209391577;6131.816045518642;6158.983767678283;6177.907331390123;6183.96908015475;6189.9690501549;4320.589543993316;4340.5225425203835;4386.100849325817;4395.7362558246605;4401.515833258275;5846.590738648254;5900.43945825146;5920.259967504062;5920.467157955804;5998.850028749316;5697.3448053474385;5698;5723.627964182315;5760.481556659921;5779.393163717749;5485.75314110858;5696.430356964271;5696.971515142398;5711.543076553782;5720.342160651412;5590.720463976866;5592.287740445961;5621.831345059655;5631.971840140773;5634.802781902614;5614.07367784311;5701.657900525815;5708.857278568069;5730.541556675539;5764.481196692318;5417.51242388187;5590.413006634245;5618.213450116905;5618.297712785902;5637.605367624227 18:19:49 INFO - PROCESS | 17840 | |5;yui.html;818.9426740128193;820.5158956215828;883.562636494935;884.310238014349;901.0841789267373;14369.425222991082;15423.151726655029;15426.228688565583;15438.305276262567;15460.995035322696;13945.233012184326;14048;14104.57686269411;14124.505642302522;14124.858751412483;708.9007538944539;814.3403842887251;833.7873842170238;836.0093289451988;842.439777547933;843.9367047471434;849.4011721736192;852.1223140165639;852.2925971443686;852.9019162796264;896.4173287363234;898.1377877237827;899.2760827533833;899.3929097858952;899.5322432335182;739.2311995524675;856.5374697663254;882.4131952251809;883.3374968773452;883.4478450968145;650.1288273713247;651.6220592056643;651.7588492257847;652.3769799841141;653;14304.141751494944;14358.71282574353;14362.64093397663;14374.92812535941;14390.28048597566;15095.094294342374;15547.067175969478;15593.220338983005;15652;15900.443484477988;13097.541586044537;13586.660333491644;13690.178589284675;13694.93152534231;13883.028188026843;4678.929816052762;4685.20351540239;4703.623710103184;4757.0723708876785;4771.28430735389;75444.62277688576;75469.62265188638;75676.62161689211;76758;78392;11976.940115299367;11990.580329688593;11993.700157495958;12057.638270851712;12305;20379.592408151755;20581.176752930016;20594.485137871674;20612.381628551168;20629.58740825175;8661.437006594551;8840.33697472692;8912.420692654956;9018.188363047357;9060.54697265134;4711.7879695413785;4829.203181475017;4860.295257187688;4882.462929077798;4887.65786394956;3670.33933891902;3772.245550889833;3779.8866034019024;3781.5840257571645;3792.924141517154;578.9015867302569;647.4658406814397;652.5106170372221;695.620886616795;700.6321681117454;695.7251885505299;798.189837315114;801.2388231180402;811.736185739637;829.8423299573183;10970.616028438966;11103.222774405876;11182.217244792786;11257.605983790529;11413;722.2957616324042;763.7555982085679;771.8610650083039;774.2799196746967;778.9104253010863;5044.243363495431;5129.281900533928;5223.4776522347465;5234;5307.920381194285;76267;76467;77434.61282693551;77455.2254477448;78553;69421.30578694148;99009;105393.14944528582;107672;110367.44816276028;94170.52914735519;94792.52603736937;95096.52451737835;95464;97975;9878.16035636979;9918.950405248217;10045.146162576262;10185.236107291834;10282.280240383101;56459.717701412876;57240.713796430755;58674.70662646659;58694.4130558706;60750;82594;85217;85592.14407855841;86921.78469291863;88339;13470.730585388434;13505.527306544223;13643.79534307006;14118.647033823825;14296.642583935485;14395.208263545606;14594.489192878198;14893.329800159236;15158.469453569072;15360.078395296317;11449.713757156138;13663.385147668578;14041.297935102999;14624.707505850036;15347;14476.565703028926;14617.85382146165;15302.464413745465;15373.615659608598;15685.686286274438;14446.494372696905;14880.479183228968;14984.700305994038;15484.767728484307;15514.146721930401;12054.009127602412;12407.25556466615;12545.184563003375;12616.116871818884;12710.110292279822;11833.091342723787;11921;11981;12013.459394327101;12153.69615759613 18:19:49 INFO - PROCESS | 17840 | __end_tp_report 18:19:49 INFO - PROCESS | 17840 | __start_cc_report 18:19:49 INFO - PROCESS | 17840 | _x_x_mozilla_cycle_collect,867 18:19:49 INFO - PROCESS | 17840 | __end_cc_report 18:19:49 INFO - PROCESS | 17840 | __startTimestamp1468459189531__endTimestamp 18:19:49 INFO - PROCESS | 17840 | 18:19:49 INFO - PROCESS | 17840 | ------- Summary: start ------- 18:19:49 INFO - PROCESS | 17840 | Number of tests: 6 18:19:49 INFO - PROCESS | 17840 | 18:19:49 INFO - PROCESS | 17840 | [#0] dojo.html Cycles:165 Average:5464.81 Median:5667.00 stddev:597.35 (10.5%) stddev-sans-first:574.48 18:19:49 INFO - PROCESS | 17840 | Values: 3297.4 3304.1 3316.2 3339.8 3353.7 5380.2 5442.1 5458.9 5466.3 5474.9 5502.9 5539.8 5558.2 5559.0 5579.6 4932.3 5030.0 5042.9 5087.3 5117.7 4901.6 5016.5 5063.9 5068.7 5070.3 4970.6 5001.2 5002.9 5036.7 5047.4 5102.3 5116.9 5117.4 5118.2 5143.4 4867.2 4943.5 4968.7 5010.2 5049.0 5342.9 5362.3 5364.9 5392.2 5438.8 5898.3 5908.7 5936.6 5946.6 5947.8 5822.3 5850.9 5864.3 5885.6 5921.7 5509.1 5517.2 5553.0 5553.0 5563.3 5833.8 6054.4 6065.9 6072.9 6085.0 5719.5 5738.5 5744.4 5848.2 5849.2 5892.7 5898.3 5900.0 5936.6 5937.3 5704.7 5740.1 5840.2 5846.7 5856.5 5773.7 5842.2 5846.8 5850.6 5884.5 4502.5 4506.3 4507.3 4509.8 4538.5 4006.2 4007.4 4031.9 4042.7 4069.3 5620.6 5631.0 5644.9 5645.7 5668.7 5907.4 5916.6 5929.6 5933.8 5964.0 5489.1 5544.8 5578.7 5578.9 5584.0 5006.8 5031.6 5033.1 5039.8 5048.0 6111.2 6115.8 6123.3 6127.9 6129.8 5711.0 5778.8 5797.3 5816.5 5893.0 6067.2 6080.4 6080.5 6087.6 6092.6 5767.7 5769.5 5770.2 5772.0 5773.5 5768.9 5810.4 5838.4 5869.7 5894.7 5735.2 5750.3 5750.6 5760.0 5772.7 5627.3 5674.7 5732.5 5742.7 5745.9 5578.6 5597.2 5623.6 5667.0 5671.3 5765.2 5770.9 5810.0 5816.8 5822.3 5477.1 5519.7 5646.2 5646.4 5681.0 18:19:49 INFO - PROCESS | 17840 | 18:19:49 INFO - PROCESS | 17840 | [#1] ext.html Cycles:180 Average:61171.15 Median:40163.90 stddev:115881.01 (288.5%) stddev-sans-first:116116.85 18:19:49 INFO - PROCESS | 17840 | Values: 599.9 648.3 653.0 654.5 655.1 33437.3 46085.0 46998.5 47059.8 47141.3 48705.0 49409.0 49430.3 49532.8 49547.3 8248.5 8386.9 8973.2 9177.5 10676.8 10557.0 10959.9 10971.3 10973.2 10973.7 10971.7 10997.2 11001.3 11007.1 11008.4 8364.7 10951.3 11011.2 11181.7 11240.0 10597.8 10962.9 10973.2 10976.0 10980.5 45825.3 46247.5 46266.3 46438.8 46457.8 3813.3 3866.9 3905.3 3954.4 4365.9 34926.7 35409.5 35719.6 35768.6 35847.8 4729.9 4830.4 4887.2 4900.8 4936.3 372521.0 378731.0 379143.0 381698.0 382106.0 38999.2 70384.0 70471.6 70808.3 71294.0 40099.2 41567.6 41861.8 41871.6 41884.2 15054.5 15222.0 15228.3 15230.2 15238.8 11361.7 11995.5 12195.1 12239.9 12494.4 9511.4 9519.9 9528.2 9579.5 9606.8 3555.2 3572.8 3609.8 3610.8 3626.3 1101.2 1119.8 1142.5 1146.5 1169.4 34475.0 34811.7 34888.5 35026.0 35115.6 1194.6 1211.6 1226.3 1233.6 1274.7 18190.0 18316.4 18357.3 18410.9 18435.0 504053.0 504379.0 505386.0 506176.0 507491.0 65134.7 65473.3 65554.0 65684.3 65927.3 1338.5 1417.0 1446.6 1449.4 1474.4 33929.7 35796.8 35931.3 36153.8 36196.0 55986.2 56514.2 56859.7 56948.7 56956.7 420149.0 422107.0 422540.0 422616.0 422934.0 31197.2 31810.0 40838.6 46166.8 47003.8 52788.5 53245.0 53322.0 53467.7 53780.5 42728.0 43932.8 43975.0 45182.8 45805.0 43388.0 43494.6 43740.1 44340.8 46527.3 45370.8 45865.5 45894.3 46271.3 46298.8 37853.8 39943.4 40228.6 40601.6 40688.0 30107.4 30162.4 30426.7 30529.4 30780.2 18:19:49 INFO - PROCESS | 17840 | 18:19:49 INFO - PROCESS | 17840 | [#2] jquery.html Cycles:180 Average:30685.66 Median:11841.38 stddev:86802.56 (733.0%) stddev-sans-first:87016.33 18:19:49 INFO - PROCESS | 17840 | Values: 426.5 428.3 432.1 438.9 439.8 18803.8 20244.5 20791.1 21467.5 21511.0 17153.1 17517.7 17717.3 17717.7 17723.2 5750.2 5937.5 5989.3 5989.8 5993.7 4404.4 4869.0 5911.1 5973.7 6579.1 6556.6 6641.5 6651.5 6654.2 6719.1 6495.1 6543.7 6630.4 6635.5 6694.6 3952.2 5483.3 5815.5 5906.9 5907.6 24272.8 24537.4 24695.0 24736.9 24920.6 2316.7 2447.1 2556.4 3045.4 3295.8 10468.5 10514.8 10728.0 10796.1 10925.1 1920.9 2009.3 2086.3 2090.9 2148.2 65987.7 84907.6 84997.0 86240.6 89456.0 11951.2 11958.8 11960.6 11963.2 12081.2 17163.8 17220.2 17270.1 17292.6 17305.2 8334.8 8387.9 8402.7 8437.9 8539.0 7858.6 7871.2 7924.8 7930.9 8080.6 4926.5 5059.2 5086.9 5235.3 5246.3 1951.6 2076.7 2084.3 2115.1 2171.8 990.4 1047.8 1057.3 1074.7 1142.8 19581.4 19632.2 19634.0 19743.2 19944.0 1008.7 1022.0 1030.8 1032.7 1079.9 10665.3 10957.5 11088.6 11206.9 11303.9 471131.0 482146.0 552497.0 558677.0 560578.0 97033.0 98848.5 100005.0 102699.0 106783.5 1076.1 1086.7 1127.7 1132.9 1133.5 13696.7 17057.8 17641.9 18201.0 18363.2 42266.6 42274.8 42869.6 43925.3 44005.6 54283.7 54738.5 57078.7 63512.7 63645.0 8167.5 8532.0 8693.9 8711.3 8762.3 12697.8 13616.5 13734.2 14102.4 14114.9 12281.4 12535.4 12565.2 12759.2 12793.9 12154.1 12306.4 12446.3 12727.9 12748.4 12565.8 12580.9 12765.6 12837.4 12888.4 9387.2 9401.0 9498.4 9528.2 9658.4 12225.3 12398.6 12649.4 12662.0 12673.7 18:19:49 INFO - PROCESS | 17840 | 18:19:49 INFO - PROCESS | 17840 | [#3] mootools.html Cycles:180 Average:6366.15 Median:4666.36 stddev:3700.22 (79.3%) stddev-sans-first:3691.84 18:19:49 INFO - PROCESS | 17840 | Values: 1407.9 1555.0 1601.3 1778.6 1894.9 9213.8 9583.2 9585.8 9842.2 9856.5 9549.4 9749.3 9761.3 9762.0 9766.4 2164.9 2224.0 2225.2 2432.5 2457.2 2450.8 2524.7 2526.7 2537.3 2559.2 2458.5 2466.7 2485.1 2495.6 2500.7 2143.1 2215.1 2494.1 2528.8 2529.7 2153.3 2384.4 2461.2 2486.2 2486.8 9122.7 9214.6 9219.1 9440.8 9476.4 5308.2 5378.0 5402.5 5440.4 5440.9 3729.2 3806.7 3834.4 3989.4 3996.2 1222.8 1232.7 1285.8 1293.0 1325.7 13628.8 13923.4 13975.4 13985.5 13993.7 4968.6 4970.1 5057.7 5083.3 5130.8 11658.7 11661.3 11665.5 11667.7 11674.8 5395.8 5467.9 5476.3 5479.6 5481.4 4141.3 4279.4 4878.4 4972.0 5061.7 4416.0 4419.3 4473.5 4507.1 4518.8 1369.9 1414.6 1427.4 1429.1 1429.8 896.2 1095.1 1102.3 1103.4 1117.3 6357.5 6508.8 6652.3 6694.1 6741.0 992.9 1008.8 1011.5 1088.3 1091.6 4645.5 4687.3 4723.2 4743.6 4793.3 12122.9 12428.1 12448.6 12469.1 12480.8 11427.9 11715.1 11799.1 12248.5 12326.9 8859.0 8996.7 9001.5 9010.5 9014.4 6738.4 6806.0 6878.5 6981.4 7077.6 11172.8 11280.2 11334.1 11519.2 11657.3 11497.8 11743.3 11784.0 11944.8 11946.9 8608.6 8621.0 8686.1 8705.5 8707.7 8817.4 8911.3 8951.5 8980.6 9038.0 8017.4 8030.9 8037.3 8094.4 8173.5 7641.5 7723.3 7793.5 7865.4 8029.6 7446.2 7684.4 7691.9 7907.7 7917.6 5733.7 5829.0 5867.0 5943.3 5995.9 5770.3 5774.6 5821.9 5846.4 5933.7 18:19:49 INFO - PROCESS | 17840 | 18:19:49 INFO - PROCESS | 17840 | [#4] prototype.html Cycles:180 Average:4751.05 Median:5339.07 stddev:1396.63 (26.2%) stddev-sans-first:1360.85 18:19:49 INFO - PROCESS | 17840 | Values: 346.1 355.4 356.6 362.9 366.7 5443.5 5460.3 5473.3 5516.1 5516.3 5405.2 5418.7 5426.5 5510.2 5517.8 3860.3 4059.8 4225.6 4238.4 4239.4 4214.9 4237.1 4238.5 4259.1 4272.8 4134.7 4267.4 4273.5 4284.8 4288.5 4141.5 4244.6 4250.6 4266.8 4274.2 3758.5 3779.3 3780.0 3788.3 3800.8 5214.8 5240.2 5248.4 5254.5 5269.4 4907.8 4912.7 4915.5 4935.4 4952.8 5415.0 5538.8 5581.9 5583.4 5745.3 4031.9 4058.1 4143.8 4156.0 4198.7 5870.6 5886.4 5888.3 5894.2 5907.4 3935.0 4130.7 4164.8 4165.6 4176.4 4143.2 4208.6 4223.8 4248.4 4285.0 4853.5 4864.3 4878.6 4881.7 4898.4 5732.5 5768.0 5806.3 5806.9 5827.4 1446.6 1464.5 1480.5 1481.8 1484.8 919.3 926.2 929.1 950.6 952.2 5030.4 5050.3 5099.3 5124.2 5178.8 5193.9 5233.0 5245.0 5288.4 5298.4 4833.8 5061.3 5114.9 5119.3 5161.0 2812.9 2819.1 2830.3 2842.3 2873.0 5444.9 5456.4 5465.9 5486.8 5489.5 5307.4 5370.8 5641.5 6084.7 6089.8 5937.0 6008.3 6056.9 6171.4 6225.0 5909.0 5917.8 5928.3 5941.6 5945.3 5570.4 5825.3 5833.6 5843.9 5869.8 6131.8 6159.0 6177.9 6184.0 6190.0 4320.6 4340.5 4386.1 4395.7 4401.5 5846.6 5900.4 5920.3 5920.5 5998.9 5697.3 5698.0 5723.6 5760.5 5779.4 5485.8 5696.4 5697.0 5711.5 5720.3 5590.7 5592.3 5621.8 5632.0 5634.8 5614.1 5701.7 5708.9 5730.5 5764.5 5417.5 5590.4 5618.2 5618.3 5637.6 18:19:49 INFO - PROCESS | 17840 | 18:19:49 INFO - PROCESS | 17840 | [#5] yui.html Cycles:180 Average:20829.40 Median:4764.18 stddev:28633.00 (601.0%) stddev-sans-first:28673.90 18:19:49 INFO - PROCESS | 17840 | Values: 818.9 820.5 883.6 884.3 901.1 14369.4 15423.2 15426.2 15438.3 15461.0 13945.2 14048.0 14104.6 14124.5 14124.9 708.9 814.3 833.8 836.0 842.4 843.9 849.4 852.1 852.3 852.9 896.4 898.1 899.3 899.4 899.5 739.2 856.5 882.4 883.3 883.4 650.1 651.6 651.8 652.4 653.0 14304.1 14358.7 14362.6 14374.9 14390.3 15095.1 15547.1 15593.2 15652.0 15900.4 13097.5 13586.7 13690.2 13694.9 13883.0 4678.9 4685.2 4703.6 4757.1 4771.3 75444.6 75469.6 75676.6 76758.0 78392.0 11976.9 11990.6 11993.7 12057.6 12305.0 20379.6 20581.2 20594.5 20612.4 20629.6 8661.4 8840.3 8912.4 9018.2 9060.5 4711.8 4829.2 4860.3 4882.5 4887.7 3670.3 3772.2 3779.9 3781.6 3792.9 578.9 647.5 652.5 695.6 700.6 695.7 798.2 801.2 811.7 829.8 10970.6 11103.2 11182.2 11257.6 11413.0 722.3 763.8 771.9 774.3 778.9 5044.2 5129.3 5223.5 5234.0 5307.9 76267.0 76467.0 77434.6 77455.2 78553.0 69421.3 99009.0 105393.1 107672.0 110367.4 94170.5 94792.5 95096.5 95464.0 97975.0 9878.2 9919.0 10045.1 10185.2 10282.3 56459.7 57240.7 58674.7 58694.4 60750.0 82594.0 85217.0 85592.1 86921.8 88339.0 13470.7 13505.5 13643.8 14118.6 14296.6 14395.2 14594.5 14893.3 15158.5 15360.1 11449.7 13663.4 14041.3 14624.7 15347.0 14476.6 14617.9 15302.5 15373.6 15685.7 14446.5 14880.5 14984.7 15484.8 15514.1 12054.0 12407.3 12545.2 12616.1 12710.1 11833.1 11921.0 11981.0 12013.5 12153.7 18:19:49 INFO - PROCESS | 17840 | -------- Summary: end -------- 18:19:49 INFO - PROCESS | 17840 | 18:19:50 INFO - TEST-INFO | 17840: exit 0 18:19:50 INFO - TEST-OK | dromaeo_css | took 1113035ms 18:19:50 INFO - TEST-START | kraken 18:19:50 INFO - operating with platform_type : linux_ 18:19:50 INFO - Initialising browser for kraken test... 18:19:50 INFO - TEST-INFO | started process 18029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkg47p0/profile http://localhost:40994/getInfo.html) 18:19:54 INFO - PROCESS | 18029 | __metrics Screen width/height:1600/1200 18:19:54 INFO - PROCESS | 18029 | colorDepth:24 18:19:54 INFO - PROCESS | 18029 | Browser inner width/height: 1024/697 18:19:54 INFO - PROCESS | 18029 | __metrics 18:19:55 ERROR - PROCESS | 18029 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:19:55 INFO - TEST-INFO | 18029: exit 0 18:19:55 INFO - Browser initialized. 18:19:55 INFO - Running cycle 1/1 for kraken test... 18:19:55 INFO - TEST-INFO | started process 18119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkg47p0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:20:07 INFO - PROCESS | 18119 | RSS: Main: 145096704 18:20:07 INFO - PROCESS | 18119 | 18:20:10 INFO - PROCESS | 18119 | Cycle 1(1): loaded http://localhost:40994/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40994/tests/kraken/driver.html?testName=audio-beat-detection) 18:20:11 INFO - PROCESS | 18119 | RSS: Main: 194076672 18:20:11 INFO - PROCESS | 18119 | 18:20:13 INFO - PROCESS | 18119 | Cycle 1(1): loaded http://localhost:40994/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40994/tests/kraken/driver.html?testName=audio-dft) 18:20:14 INFO - PROCESS | 18119 | RSS: Main: 193048576 18:20:14 INFO - PROCESS | 18119 | 18:20:17 INFO - PROCESS | 18119 | Cycle 1(1): loaded http://localhost:40994/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40994/tests/kraken/driver.html?testName=audio-fft) 18:20:17 INFO - PROCESS | 18119 | RSS: Main: 278368256 18:20:17 INFO - PROCESS | 18119 | 18:20:19 INFO - PROCESS | 18119 | Cycle 1(1): loaded http://localhost:40994/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40994/tests/kraken/driver.html?testName=audio-oscillator) 18:20:20 INFO - PROCESS | 18119 | RSS: Main: 187060224 18:20:20 INFO - PROCESS | 18119 | 18:20:22 INFO - PROCESS | 18119 | Cycle 1(1): loaded http://localhost:40994/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40994/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:20:23 INFO - PROCESS | 18119 | RSS: Main: 187723776 18:20:23 INFO - PROCESS | 18119 | 18:20:26 INFO - PROCESS | 18119 | Cycle 1(1): loaded http://localhost:40994/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40994/tests/kraken/driver.html?testName=imaging-darkroom) 18:20:26 INFO - PROCESS | 18119 | RSS: Main: 223150080 18:20:26 INFO - PROCESS | 18119 | 18:20:30 INFO - PROCESS | 18119 | Cycle 1(1): loaded http://localhost:40994/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40994/tests/kraken/driver.html?testName=imaging-desaturate) 18:20:30 INFO - PROCESS | 18119 | RSS: Main: 223801344 18:20:30 INFO - PROCESS | 18119 | 18:20:33 INFO - PROCESS | 18119 | Cycle 1(1): loaded http://localhost:40994/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40994/tests/kraken/driver.html?testName=json-parse-financial) 18:20:34 INFO - PROCESS | 18119 | RSS: Main: 223768576 18:20:34 INFO - PROCESS | 18119 | 18:20:35 INFO - PROCESS | 18119 | Cycle 1(1): loaded http://localhost:40994/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40994/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:20:36 INFO - PROCESS | 18119 | RSS: Main: 201318400 18:20:36 INFO - PROCESS | 18119 | 18:20:37 INFO - PROCESS | 18119 | Cycle 1(1): loaded http://localhost:40994/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40994/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:20:38 INFO - PROCESS | 18119 | RSS: Main: 202055680 18:20:38 INFO - PROCESS | 18119 | 18:20:40 INFO - PROCESS | 18119 | Cycle 1(1): loaded http://localhost:40994/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40994/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:20:41 INFO - PROCESS | 18119 | RSS: Main: 208920576 18:20:41 INFO - PROCESS | 18119 | 18:20:43 INFO - PROCESS | 18119 | Cycle 1(1): loaded http://localhost:40994/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40994/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:20:44 INFO - PROCESS | 18119 | RSS: Main: 215019520 18:20:44 INFO - PROCESS | 18119 | 18:20:47 INFO - PROCESS | 18119 | Cycle 1(1): loaded http://localhost:40994/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40994/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:20:47 INFO - PROCESS | 18119 | RSS: Main: 214192128 18:20:47 INFO - PROCESS | 18119 | 18:20:49 INFO - PROCESS | 18119 | Cycle 1(1): loaded http://localhost:40994/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40994/tests/kraken/driver.html?testName=ai-astar) 18:20:49 INFO - PROCESS | 18119 | RSS: Main: 256983040 18:20:49 INFO - PROCESS | 18119 | 18:20:49 INFO - PROCESS | 18119 | __start_tp_report 18:20:49 INFO - PROCESS | 18119 | _x_x_mozilla_page_load 18:20:49 INFO - PROCESS | 18119 | _x_x_mozilla_page_load_details 18:20:49 INFO - PROCESS | 18119 | |i|pagename|runs| 18:20:49 INFO - PROCESS | 18119 | |0;ai-astar;111;104;108;109;109;110;109;109;109;108 18:20:49 INFO - PROCESS | 18119 | |1;audio-beat-detection;153;123;131;182;124;125;155;123;151;125 18:20:49 INFO - PROCESS | 18119 | |2;audio-dft;162;161;162;161;161;160;161;161;161;160 18:20:49 INFO - PROCESS | 18119 | |3;audio-fft;74;75;75;120;75;75;74;82;103;75 18:20:49 INFO - PROCESS | 18119 | |4;audio-oscillator;84;84;114;84;84;86;127;85;85;124 18:20:49 INFO - PROCESS | 18119 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;117;117;117 18:20:49 INFO - PROCESS | 18119 | |6;imaging-darkroom;145;146;145;146;146;145;146;145;145;145 18:20:49 INFO - PROCESS | 18119 | |7;imaging-desaturate;94;94;95;94;95;94;94;94;94;94 18:20:49 INFO - PROCESS | 18119 | |8;json-parse-financial;50;51;50;50;54;51;51;51;51;51 18:20:49 INFO - PROCESS | 18119 | |9;json-stringify-tinderbox;59;59;59;59;60;59;60;60;60;62 18:20:49 INFO - PROCESS | 18119 | |10;stanford-crypto-aes;81;82;74;77;77;76;76;77;111;76 18:20:49 INFO - PROCESS | 18119 | |11;stanford-crypto-ccm;119;115;130;114;120;118;117;122;127;119 18:20:49 INFO - PROCESS | 18119 | |12;stanford-crypto-pbkdf2;159;159;155;154;154;153;155;152;151;155 18:20:49 INFO - PROCESS | 18119 | |13;stanford-crypto-sha256-iterative;63;60;61;60;62;60;60;61;59;61 18:20:49 INFO - PROCESS | 18119 | __end_tp_report 18:20:49 INFO - PROCESS | 18119 | __start_cc_report 18:20:49 INFO - PROCESS | 18119 | _x_x_mozilla_cycle_collect,1570 18:20:49 INFO - PROCESS | 18119 | __end_cc_report 18:20:49 INFO - PROCESS | 18119 | __startTimestamp1468459249510__endTimestamp 18:20:49 INFO - PROCESS | 18119 | 18:20:49 INFO - PROCESS | 18119 | ------- Summary: start ------- 18:20:49 INFO - PROCESS | 18119 | Number of tests: 14 18:20:49 INFO - PROCESS | 18119 | 18:20:49 INFO - PROCESS | 18119 | [#0] ai-astar Cycles:10 Average:108.60 Median:109.00 stddev:1.84 (1.7%) stddev-sans-first:1.73 18:20:49 INFO - PROCESS | 18119 | Values: 111.0 104.0 108.0 109.0 109.0 110.0 109.0 109.0 109.0 108.0 18:20:49 INFO - PROCESS | 18119 | 18:20:49 INFO - PROCESS | 18119 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:141.00 stddev:20.10 (14.3%) stddev-sans-first:20.69 18:20:49 INFO - PROCESS | 18119 | Values: 153.0 123.0 131.0 182.0 124.0 125.0 155.0 123.0 151.0 125.0 18:20:49 INFO - PROCESS | 18119 | 18:20:49 INFO - PROCESS | 18119 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 18:20:49 INFO - PROCESS | 18119 | Values: 162.0 161.0 162.0 161.0 161.0 160.0 161.0 161.0 161.0 160.0 18:20:49 INFO - PROCESS | 18119 | 18:20:49 INFO - PROCESS | 18119 | [#3] audio-fft Cycles:10 Average:82.80 Median:75.00 stddev:15.82 (21.1%) stddev-sans-first:16.45 18:20:49 INFO - PROCESS | 18119 | Values: 74.0 75.0 75.0 120.0 75.0 75.0 74.0 82.0 103.0 75.0 18:20:49 INFO - PROCESS | 18119 | 18:20:49 INFO - PROCESS | 18119 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:84.00 stddev:18.22 (21.7%) stddev-sans-first:18.82 18:20:49 INFO - PROCESS | 18119 | Values: 84.0 84.0 114.0 84.0 84.0 86.0 127.0 85.0 85.0 124.0 18:20:49 INFO - PROCESS | 18119 | 18:20:49 INFO - PROCESS | 18119 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:20:49 INFO - PROCESS | 18119 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 18:20:49 INFO - PROCESS | 18119 | 18:20:49 INFO - PROCESS | 18119 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 18:20:49 INFO - PROCESS | 18119 | Values: 145.0 146.0 145.0 146.0 146.0 145.0 146.0 145.0 145.0 145.0 18:20:49 INFO - PROCESS | 18119 | 18:20:49 INFO - PROCESS | 18119 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:20:49 INFO - PROCESS | 18119 | Values: 94.0 94.0 95.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 18:20:49 INFO - PROCESS | 18119 | 18:20:49 INFO - PROCESS | 18119 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.00 stddev:1.15 (2.3%) stddev-sans-first:1.17 18:20:49 INFO - PROCESS | 18119 | Values: 50.0 51.0 50.0 50.0 54.0 51.0 51.0 51.0 51.0 51.0 18:20:49 INFO - PROCESS | 18119 | 18:20:49 INFO - PROCESS | 18119 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.95 (1.6%) stddev-sans-first:0.97 18:20:49 INFO - PROCESS | 18119 | Values: 59.0 59.0 59.0 59.0 60.0 59.0 60.0 60.0 60.0 62.0 18:20:49 INFO - PROCESS | 18119 | 18:20:49 INFO - PROCESS | 18119 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:77.00 stddev:10.91 (14.2%) stddev-sans-first:11.58 18:20:49 INFO - PROCESS | 18119 | Values: 81.0 82.0 74.0 77.0 77.0 76.0 76.0 77.0 111.0 76.0 18:20:49 INFO - PROCESS | 18119 | 18:20:49 INFO - PROCESS | 18119 | [#11] stanford-crypto-ccm Cycles:10 Average:120.10 Median:119.50 stddev:5.04 (4.2%) stddev-sans-first:5.33 18:20:49 INFO - PROCESS | 18119 | Values: 119.0 115.0 130.0 114.0 120.0 118.0 117.0 122.0 127.0 119.0 18:20:49 INFO - PROCESS | 18119 | 18:20:49 INFO - PROCESS | 18119 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.70 Median:155.00 stddev:2.63 (1.7%) stddev-sans-first:2.28 18:20:49 INFO - PROCESS | 18119 | Values: 159.0 159.0 155.0 154.0 154.0 153.0 155.0 152.0 151.0 155.0 18:20:49 INFO - PROCESS | 18119 | 18:20:49 INFO - PROCESS | 18119 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.70 Median:61.00 stddev:1.16 (1.9%) stddev-sans-first:0.88 18:20:49 INFO - PROCESS | 18119 | Values: 63.0 60.0 61.0 60.0 62.0 60.0 60.0 61.0 59.0 61.0 18:20:49 INFO - PROCESS | 18119 | -------- Summary: end -------- 18:20:49 INFO - PROCESS | 18119 | 18:20:50 INFO - TEST-INFO | 18119: exit 0 18:20:50 INFO - TEST-OK | kraken | took 60227ms 18:20:50 INFO - SUITE-END | took 1173s 18:20:50 INFO - Completed test suite (00:19:33) 18:20:50 INFO - javascript benchmark 18:20:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3297.4064668359697, 3304.0913748719113, 3316.204111013357, 3339.8163101029436, 3353.6646335366468, 5380.166074258491, 5442.074847275962, 5458.9454105458935, 5466.289382380285, 5474.91787623186, 5502.889942201154, 5539.778408863641, 5558.194061861038, 5558.972205138979, 5579.553635709143, 4932.260160975864, 5029.974850125754, 5042.873928151789, 5087.262346959688, 5117.7185254810975, 4901.632377571678, 5016.49835016499, 5063.898722025558, 5068.695878247298, 5070.29015937769, 4970.602351811846, 5001.17480615698, 5002.9499705002845, 5036.722980236085, 5047.419546752116, 5102.311187989611, 5116.872078198037, 5117.437081921004, 5118.181091025455, 5143.43422223557, 4867.221244600847, 4943.530364615356, 4968.652194346397, 5010.223415370587, 5048.974755126201, 5342.866428339284, 5362.302900622933, 5364.865878353034, 5392.164214546751, 5438.782448702047, 5898.262717160355, 5908.734106965197, 5936.554758393095, 5946.583739138262, 5947.821565353046, 5822.330432000332, 5850.941490585083, 5864.266966629171, 5885.646861188342, 5921.703914804242, 5509.090999984997, 5517.172424136372, 5552.972235138839, 5553.0, 5563.276774019351, 5833.766649334064, 6054.354650641292, 6065.878682426327, 6072.908906366408, 6085.026395776655, 5719.542436605062, 5738.483536481736, 5744.368119506851, 5848.181254624356, 5849.239598852207, 5892.705364731746, 5898.3216930053595, 5900.0, 5936.643801371932, 5937.317208520989, 5704.743286552115, 5740.138979153077, 5840.240768700041, 5846.6784326862435, 5856.502197313191, 5773.740181691834, 5842.211301474332, 5846.766129354864, 5850.5904586678525, 5884.529237660977, 4502.527234640381, 4506.3465797459185, 4507.301368287921, 4509.774511274489, 4538.52345503724, 4006.1787333597126, 4007.3788562772816, 4031.9395209071886, 4042.717009809344, 4069.328560787437, 5620.5503559715125, 5630.971845140748, 5644.943550564524, 5645.689487078168, 5668.659880407106, 5907.409259074144, 5916.585838991229, 5929.555283353766, 5933.821985340447, 5964.045752679551, 5489.066858634042, 5544.833654990357, 5578.748956296977, 5578.9163162552595, 5583.972080139573, 5006.799728010911, 5031.622628302819, 5033.119204139261, 5039.798408063636, 5048.0, 6111.16925576507, 6115.757578772925, 6123.28262147438, 6127.861529871541, 6129.786714141072, 5710.971445142748, 5778.797742079007, 5797.333306669619, 5816.47651711348, 5893.02765043763, 6067.24159480065, 6080.3919608040615, 6080.543959202989, 6087.57386982907, 6092.634441933498, 5767.711614419346, 5769.538436924952, 5770.192173095854, 5772.018756811268, 5773.451522105393, 5768.884622307446, 5810.389909059488, 5838.386969368155, 5869.6771677556435, 5894.6757928314355, 5735.197072409949, 5750.338711048283, 5750.568707347049, 5760.049591817303, 5772.711364431846, 5627.296587926509, 5674.687892165971, 5732.455416735404, 5742.741576628978, 5745.850829833967, 5578.63738856973, 5597.244372009726, 5623.606347555632, 5667.0, 5671.319441667027, 5765.1928729977, 5770.942290577041, 5809.970950145223, 5816.82549523515, 5822.272215973004, 5477.123660214346, 5519.724013799374, 5646.181303710857, 5646.435356464321, 5681.0], "value": 5426.569909400899, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.8830228105519, 648.2804087462916, 652.9934700652993, 654.5320096131265, 655.0796131435335, 33437.33125337492, 46085.0, 46998.53001469984, 47059.76470117653, 47141.29288060677, 48705.0, 49409.0, 49430.25854612184, 49532.75233623827, 49547.25679114807, 8248.505089694638, 8386.916130838705, 8973.237274831647, 9177.495237761954, 10676.78646427071, 10557.0, 10959.890401095967, 10971.341719496855, 10973.177011724112, 10973.725656858562, 10971.670849874477, 10997.230193886431, 11001.284916480403, 11007.06439952601, 11008.449577521133, 8364.707235246768, 10951.288166269247, 11011.174161937846, 11181.664550063511, 11240.044596209333, 10597.788044239149, 10962.945185274102, 10973.23187376884, 10976.012158905736, 10980.450977451175, 45825.312620310724, 46247.537524625, 46266.30600540995, 46438.76780616109, 46457.76771116123, 3813.2564149990762, 3866.903327416809, 3905.33609286422, 3954.4463775071513, 4365.930347064989, 34926.65073349259, 35409.46885796715, 35719.64280357189, 35768.64231357679, 35847.82076089629, 4729.929051064237, 4830.4203495580405, 4887.242477416006, 4900.803967841318, 4936.259561065833, 372521.0, 378731.0, 379143.0, 381698.0, 382106.0, 38999.2200156001, 70384.0, 70471.64764176146, 70808.2919170812, 71294.0, 40099.1980160401, 41567.58432415637, 41861.79069104696, 41871.58128418738, 41884.16231675349, 15054.473093441677, 15222.0, 15228.314725837365, 15230.238488075553, 15238.771418428732, 11361.659150225507, 11995.460204290828, 12195.14633975631, 12239.877601224052, 12494.437750301258, 9511.381760185566, 9519.857202141973, 9528.19010384125, 9579.473128977974, 9606.759831004281, 3555.2000799819834, 3572.821358932095, 3609.819509024538, 3610.7833529988284, 3626.3291291111227, 1101.2291396022815, 1119.7536541960756, 1142.497301187475, 1146.5184622458587, 1169.363667124452, 34475.0, 34811.65188348135, 34888.47667284993, 35026.0, 35115.64884351175, 1194.6117511808698, 1211.6062279759115, 1226.3316492511603, 1233.5929143382662, 1274.668586167603, 18190.0, 18316.358927437475, 18357.265709371743, 18410.907945460454, 18435.0, 504053.0, 504379.0, 505386.0, 506176.0, 507491.0, 65134.67432662806, 65473.34526654768, 65554.0, 65684.34315656782, 65927.34072659307, 1338.4579245405625, 1416.9504067357593, 1446.5587995661424, 1449.4419648435428, 1474.3512854344053, 33929.66070339364, 35796.821015894755, 35931.28137437289, 36153.819230903675, 36196.0, 55986.160207596105, 56514.15228771654, 56859.71570142123, 56948.71525642345, 56956.715216423654, 420149.0, 422107.0, 422540.0, 422616.0, 422934.0, 31197.220069498446, 31810.0, 40838.59161408348, 46166.76916615396, 47003.76498117488, 52788.47211527989, 53245.0, 53322.0, 53467.73266133644, 53780.46219537754, 42728.0, 43932.78033609811, 43975.0, 45182.77408612936, 45805.0, 43388.0, 43494.56505434905, 43740.125197496505, 44340.778296108314, 46527.30209046935, 45370.77314613406, 45865.54134458613, 45894.31158532691, 46271.30593041174, 46298.768506157256, 37853.81073094617, 39943.400848986705, 40228.59771402366, 40601.593984060964, 40688.0, 30107.3978520424, 30162.396752064396, 30426.695733042387, 30529.389412212076, 30780.23049423782], "value": 20821.211814044378, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.4860842684565, 428.3318023882743, 432.1357285429142, 438.9209207541994, 439.76472587165875, 18803.811961880376, 20244.493887652818, 20791.064402101903, 21467.463313417134, 21511.0, 17153.142342882868, 17517.73723394147, 17717.29130834768, 17717.7342339865, 17723.202455889485, 5750.1949727038245, 5937.4656280934705, 5989.251343582052, 5989.8203053908455, 5993.730282137292, 4404.427424434819, 4868.951310486886, 5911.142884281798, 5973.701314934257, 6579.111819904299, 6556.6066036037755, 6641.535092543524, 6651.501137414713, 6654.234763002269, 6719.0593316935665, 6495.123158373606, 6543.705533251015, 6630.436412904909, 6635.5023373247195, 6694.598324100545, 3952.229315283521, 5483.287172667528, 5815.505682017034, 5906.881862362771, 5907.645541267495, 24272.757272427225, 24537.38656533583, 24695.0, 24736.876315618487, 24920.626190607156, 2316.652502124678, 2447.05788271515, 2556.3736884463237, 3045.3756979819304, 3295.8187299698507, 10468.52891619879, 10514.789704205874, 10728.034476897039, 10796.082333001705, 10925.125989920787, 1920.9039548022683, 2009.2867032203503, 2086.2593779208314, 2090.8536402451837, 2148.1514801653416, 65987.67006164987, 84907.57546212291, 84997.0, 86240.56879715624, 89456.0, 11951.22317049389, 11958.820617690742, 11960.58137965167, 11963.162578619413, 12081.221319096481, 17163.828361716474, 17220.225089870986, 17270.050147242022, 17292.567685807957, 17305.221265043103, 8334.791630209293, 8387.916120838836, 8402.663893444316, 8437.915620843713, 8539.0, 7858.607069646495, 7871.17352677972, 7924.841503169904, 7930.920690793134, 8080.595970201466, 4926.482719314492, 5059.19052951526, 5086.949130508721, 5235.345581802275, 5246.291750613695, 1951.6291904538093, 2076.719642848196, 2084.343431818972, 2115.1433669363932, 2171.7502487214174, 990.3711143423977, 1047.8323468245044, 1057.3338796558119, 1074.7098283463422, 1142.8057230270874, 19581.412557623295, 19632.21471141167, 19634.0, 19743.210271588974, 19944.0, 1008.6671398438498, 1021.9897801021895, 1030.7989941961246, 1032.746976990627, 1079.9082078023298, 10665.306755060896, 10957.50691218897, 11088.5564577416, 11206.943965280121, 11303.886961130447, 471131.0, 482146.0, 552497.0, 558677.0, 560578.0, 97033.0, 98848.50575747219, 100005.0, 102699.0, 106783.4660826691, 1076.0960792933972, 1086.7174534620897, 1127.7293449572207, 1132.8583927009288, 1133.4559411482535, 13696.65758356049, 17057.829421705625, 17641.911790440965, 18201.0, 18363.17365718519, 42266.57733422626, 42274.7886260579, 42869.57130428656, 43925.341119883866, 44005.55994440015, 54283.72858135684, 54738.45261547333, 57078.7146064267, 63512.68243658752, 63645.0, 8167.509949403055, 8531.976162860496, 8693.869591956, 8711.303095752452, 8762.255208307366, 12697.8095328572, 13616.523421680193, 13734.244616545786, 14102.360327425697, 14114.858851411765, 12281.38593070325, 12535.435905384098, 12565.18326308787, 12759.170653907466, 12793.936030319788, 12154.149209555246, 12306.446209920396, 12446.315452650191, 12727.93636031814, 12748.362581871055, 12565.811512827499, 12580.937095314464, 12765.553205637758, 12837.42231599599, 12888.355582220664, 9387.202087822612, 9400.95299523498, 9498.382605130644, 9528.19010384125, 9658.420494770337, 12225.266484010988, 12398.62804115878, 12649.430775615303, 12662.0, 12673.683157920757], "value": 9726.920385559864, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.8944079194064, 1554.97667534987, 1601.2634188273396, 1778.6442711457712, 1894.857885658575, 9213.815723685531, 9583.233341332694, 9585.760355991104, 9842.163416109639, 9856.507174641276, 9549.37929034614, 9749.31754777166, 9761.267904907125, 9761.951190244057, 9766.414015159095, 2164.8809315487642, 2224.0, 2225.2211725895886, 2432.501337225873, 2457.1768457566736, 2450.816188785848, 2524.7096583892903, 2526.6589010483626, 2537.2895589235045, 2559.2322303309024, 2458.520588485246, 2466.654668346433, 2485.1177831869695, 2495.6131799571094, 2500.6874140732407, 2143.089187095494, 2215.0586000949693, 2494.052260141144, 2528.835625684334, 2529.734377890332, 2153.2786516516985, 2384.4158181245534, 2461.200109964269, 2486.2168416948784, 2486.751324867517, 9122.680706175252, 9214.585343659552, 9219.124183202584, 9440.811183776355, 9476.431414115175, 5308.177232528926, 5377.973110134463, 5402.486763757437, 5440.401555828856, 5440.945590544123, 3729.216864458467, 3806.6764325032404, 3834.4440056191975, 3989.40158976153, 3996.160806230695, 1222.8165775133712, 1232.7041510037527, 1285.787845005573, 1293.0, 1325.7282257137263, 13628.795568066487, 13923.443062277496, 13975.37110830015, 13985.510507132201, 13993.720125597532, 4968.6025117990475, 4970.080535101018, 5057.671251368649, 5083.313752643419, 5130.846074617767, 11658.6502404928, 11661.300321980709, 11665.533378664759, 11667.708307292385, 11674.824877626843, 5395.81114660985, 5467.917981230285, 5476.288082549323, 5479.589030822704, 5481.397046324901, 4141.337386018223, 4279.379489973936, 4878.390201224847, 4972.0, 5061.670991385548, 4415.977920110443, 4419.337099435046, 4473.507914129443, 4507.143642707875, 4518.796654150571, 1369.9315034248248, 1414.589768966988, 1427.3719563392074, 1429.1496559547054, 1429.842717301096, 896.1755185229605, 1095.0820321395672, 1102.311055590256, 1103.3986477369854, 1117.2626066796038, 6357.4914006879335, 6508.837279067967, 6652.268250492442, 6694.129763130762, 6741.0, 992.925530585209, 1008.7982403519326, 1011.5245834457793, 1088.2762962629763, 1091.5851976249132, 4645.465771436328, 4687.2500399936525, 4723.244280915037, 4743.596794272526, 4793.304970779218, 12122.939385303194, 12428.067894907917, 12448.564300249447, 12469.127161098637, 12480.81278780819, 11427.885721142682, 11715.062794976382, 11799.115066369885, 12248.510059597695, 12326.938365308117, 8859.0, 8996.730098097067, 9001.459912405277, 9010.549472526478, 9014.414063085878, 6738.393544580815, 6805.9659701701175, 6878.518503704692, 6981.441484681315, 7077.6461176941975, 11172.776544469227, 11280.210385272952, 11334.14993875446, 11519.19365644397, 11657.300561966309, 11497.827532587185, 11743.295402275891, 11784.0, 11944.76110477803, 11946.940265298965, 8608.569571521524, 8621.0, 8686.131386861263, 8705.477671339486, 8707.695230666895, 8817.426867253607, 8911.331650126136, 8951.507667078373, 8980.595873185592, 9038.0, 8017.398695097774, 8030.879536806836, 8037.31682806968, 8094.433389662667, 8173.468724532886, 7641.503302285334, 7723.304902558797, 7793.454458187873, 7865.4494185406475, 8029.638666260149, 7446.180920098893, 7684.385249179941, 7691.923080769121, 7907.723229686933, 7917.643706033357, 5733.655980641175, 5828.970855145697, 5867.031939730067, 5943.316518600416, 5995.910061348996, 5770.307563092288, 5774.624649397776, 5821.883562328814, 5846.41535846412, 5933.732982015733], "value": 5060.13907781596, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.0673484958038, 355.44550501218094, 356.6326683515978, 362.9310431018105, 366.7451121470579, 5443.510084092431, 5460.262864513289, 5473.261109750182, 5516.0898451755465, 5516.310461192351, 5405.216278628053, 5418.729063546826, 5426.484483974026, 5510.228568000473, 5517.751701173447, 3860.2665493556274, 4059.776712280823, 4225.640820530259, 4238.364245363189, 4239.40648309237, 4214.861987263453, 4237.131388065454, 4238.512571054322, 4259.148170365924, 4272.846331490496, 4134.710570260083, 4267.381229721688, 4273.487181538219, 4284.828606855722, 4288.506821715511, 4141.461609990697, 4244.596763307481, 4250.64089430366, 4266.783966569544, 4274.166537525184, 3758.455024021529, 3779.263043706478, 3779.9622003779887, 3788.2612890486366, 3800.7529510581726, 5214.765335559909, 5240.187770895517, 5248.422673505911, 5254.500822421864, 5269.394019687747, 4907.803687852482, 4912.729799861042, 4915.5084491550915, 4935.383077115361, 4952.826651067231, 5415.0, 5538.83684426271, 5581.944180558183, 5583.413741557119, 5745.3105627324985, 4031.9193616127513, 4058.1477889642915, 4143.8135283912, 4155.97922010391, 4198.706090573661, 5870.6477611343025, 5886.381929897342, 5888.263967004167, 5894.233749612566, 5907.379725128885, 3935.0, 4130.719476962151, 4164.75011499311, 4165.625093741517, 4176.415301857743, 4143.233501802116, 4208.558101399309, 4223.767692776927, 4248.362745588187, 4284.957150428456, 4853.466118726938, 4864.270359446041, 4878.609711223094, 4881.706347817832, 4898.436679781799, 5732.541396688338, 5767.971160144172, 5806.303243610793, 5806.912896306559, 5827.417258274223, 1446.5515690136092, 1464.5093893545782, 1480.489231215229, 1481.8369979302267, 1484.7550154224432, 919.2695320037478, 926.2173463423396, 929.0941332201049, 950.5532399772235, 952.2334520710895, 5030.396352437658, 5050.3434553507805, 5099.311592934981, 5124.180131179068, 5178.83476217848, 5193.922770625041, 5233.0, 5244.9737751310995, 5288.435108972146, 5298.390685071189, 4833.777348809057, 5061.304463004934, 5114.897702045938, 5119.3088932994315, 5160.974195129075, 2812.85935703214, 2819.0971094511124, 2830.320723026459, 2842.2894276430893, 2872.971270287312, 5444.91832622511, 5456.399796022434, 5465.945340546544, 5486.780528778804, 5489.533389661844, 5307.389650190277, 5370.758315875795, 5641.548676105902, 6084.714254302627, 6089.8477538061015, 5936.970315148396, 6008.3390827009, 6056.939430605726, 6171.352008039091, 6225.0, 5908.995470770065, 5917.763289468373, 5928.34788173292, 5941.58408911372, 5945.31628862669, 5570.359408668055, 5825.330087040044, 5833.591648584558, 5843.853903652443, 5869.765209391577, 6131.816045518642, 6158.983767678283, 6177.907331390123, 6183.96908015475, 6189.9690501549, 4320.589543993316, 4340.5225425203835, 4386.100849325817, 4395.7362558246605, 4401.515833258275, 5846.590738648254, 5900.43945825146, 5920.259967504062, 5920.467157955804, 5998.850028749316, 5697.3448053474385, 5698.0, 5723.627964182315, 5760.481556659921, 5779.393163717749, 5485.75314110858, 5696.430356964271, 5696.971515142398, 5711.543076553782, 5720.342160651412, 5590.720463976866, 5592.287740445961, 5621.831345059655, 5631.971840140773, 5634.802781902614, 5614.07367784311, 5701.657900525815, 5708.857278568069, 5730.541556675539, 5764.481196692318, 5417.51242388187, 5590.413006634245, 5618.213450116905, 5618.297712785902, 5637.605367624227], "value": 4310.150557448736, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [818.9426740128193, 820.5158956215828, 883.562636494935, 884.310238014349, 901.0841789267373, 14369.425222991082, 15423.151726655029, 15426.228688565583, 15438.305276262567, 15460.995035322696, 13945.233012184326, 14048.0, 14104.57686269411, 14124.505642302522, 14124.858751412483, 708.9007538944539, 814.3403842887251, 833.7873842170238, 836.0093289451988, 842.439777547933, 843.9367047471434, 849.4011721736192, 852.1223140165639, 852.2925971443686, 852.9019162796264, 896.4173287363234, 898.1377877237827, 899.2760827533833, 899.3929097858952, 899.5322432335182, 739.2311995524675, 856.5374697663254, 882.4131952251809, 883.3374968773452, 883.4478450968145, 650.1288273713247, 651.6220592056643, 651.7588492257847, 652.3769799841141, 653.0, 14304.141751494944, 14358.71282574353, 14362.64093397663, 14374.92812535941, 14390.28048597566, 15095.094294342374, 15547.067175969478, 15593.220338983005, 15652.0, 15900.443484477988, 13097.541586044537, 13586.660333491644, 13690.178589284675, 13694.93152534231, 13883.028188026843, 4678.929816052762, 4685.20351540239, 4703.623710103184, 4757.0723708876785, 4771.28430735389, 75444.62277688576, 75469.62265188638, 75676.62161689211, 76758.0, 78392.0, 11976.940115299367, 11990.580329688593, 11993.700157495958, 12057.638270851712, 12305.0, 20379.592408151755, 20581.176752930016, 20594.485137871674, 20612.381628551168, 20629.58740825175, 8661.437006594551, 8840.33697472692, 8912.420692654956, 9018.188363047357, 9060.54697265134, 4711.7879695413785, 4829.203181475017, 4860.295257187688, 4882.462929077798, 4887.65786394956, 3670.33933891902, 3772.245550889833, 3779.8866034019024, 3781.5840257571645, 3792.924141517154, 578.9015867302569, 647.4658406814397, 652.5106170372221, 695.620886616795, 700.6321681117454, 695.7251885505299, 798.189837315114, 801.2388231180402, 811.736185739637, 829.8423299573183, 10970.616028438966, 11103.222774405876, 11182.217244792786, 11257.605983790529, 11413.0, 722.2957616324042, 763.7555982085679, 771.8610650083039, 774.2799196746967, 778.9104253010863, 5044.243363495431, 5129.281900533928, 5223.4776522347465, 5234.0, 5307.920381194285, 76267.0, 76467.0, 77434.61282693551, 77455.2254477448, 78553.0, 69421.30578694148, 99009.0, 105393.14944528582, 107672.0, 110367.44816276028, 94170.52914735519, 94792.52603736937, 95096.52451737835, 95464.0, 97975.0, 9878.16035636979, 9918.950405248217, 10045.146162576262, 10185.236107291834, 10282.280240383101, 56459.717701412876, 57240.713796430755, 58674.70662646659, 58694.4130558706, 60750.0, 82594.0, 85217.0, 85592.14407855841, 86921.78469291863, 88339.0, 13470.730585388434, 13505.527306544223, 13643.79534307006, 14118.647033823825, 14296.642583935485, 14395.208263545606, 14594.489192878198, 14893.329800159236, 15158.469453569072, 15360.078395296317, 11449.713757156138, 13663.385147668578, 14041.297935102999, 14624.707505850036, 15347.0, 14476.565703028926, 14617.85382146165, 15302.464413745465, 15373.615659608598, 15685.686286274438, 14446.494372696905, 14880.479183228968, 14984.700305994038, 15484.767728484307, 15514.146721930401, 12054.009127602412, 12407.25556466615, 12545.184563003375, 12616.116871818884, 12710.110292279822, 11833.091342723787, 11921.0, 11981.0, 12013.459394327101, 12153.69615759613], "value": 7918.0996753898435, "unit": "score"}], "name": "dromaeo_css", "value": 7580.903643259912, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 108.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 108.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 131.0, 182.0, 124.0, 125.0, 155.0, 123.0, 151.0, 125.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 120.0, 75.0, 75.0, 74.0, 82.0, 103.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 114.0, 84.0, 84.0, 86.0, 127.0, 85.0, 85.0, 124.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 50.0, 54.0, 51.0, 51.0, 51.0, 51.0, 51.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 60.0, 60.0, 60.0, 62.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 74.0, 77.0, 77.0, 76.0, 76.0, 77.0, 111.0, 76.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 115.0, 130.0, 114.0, 120.0, 118.0, 117.0, 122.0, 127.0, 119.0], "value": 120.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 155.0, 154.0, 154.0, 153.0, 155.0, 152.0, 151.0, 155.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 61.0, 60.0, 62.0, 60.0, 60.0, 61.0, 59.0, 61.0], "value": 60.7, "unit": "score"}], "name": "kraken", "value": 1470.6, "alertThreshold": 2.0}]} 18:20:50 INFO - Return code: 0 18:20:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:20:50 ERROR - # TBPL SUCCESS # 18:20:50 INFO - Running post-action listener: _resource_record_post_action 18:20:50 INFO - ##### 18:20:50 INFO - ##### Finished run-tests step (success) 18:20:50 INFO - ##### 18:20:50 INFO - Running post-run listener: _resource_record_post_run 18:20:50 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 290816; Write bytes: 506822656; Read time: 36; Write time: 436300 18:20:50 INFO - TinderboxPrint: CPU usage
13.1% 18:20:50 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 36 18:20:50 INFO - TinderboxPrint: I/O write bytes / time
506,822,656 / 436,300 18:20:50 INFO - TinderboxPrint: CPU idle
8,254.2 (86.9%) 18:20:50 INFO - TinderboxPrint: CPU user
1,198.7 (12.6%) 18:20:50 INFO - TinderboxPrint: Swap in / out
0 / 0 18:20:50 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252317696; Read time: 0; Write time: 258200 18:20:50 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 254504960; Read time: 28; Write time: 178100 18:20:51 INFO - Running post-run listener: _upload_blobber_files 18:20:51 INFO - Blob upload gear active. 18:20:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:20:51 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 18:20:51 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:20:51 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:20:51 INFO - (blobuploader) - INFO - Open directory for files ... 18:20:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:20:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:20:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:20:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:20:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:20:52 INFO - (blobuploader) - INFO - Done attempting. 18:20:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:20:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:20:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:20:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:20:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:20:53 INFO - (blobuploader) - INFO - Done attempting. 18:20:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:20:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:20:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:20:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:20:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:20:56 INFO - (blobuploader) - INFO - Done attempting. 18:20:56 INFO - (blobuploader) - INFO - Iteration through files over. 18:20:56 INFO - Return code: 0 18:20:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:20:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:20:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8294688d35834e9f7b17adc778f697776f381216820e37b5968fe27c9282efbc1982fda91bbbb3fad056b029eb30949ab9f0dc14e8e27ca137d8b009dca499b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21146393e74bb58c92d1d2eb3453b50aca84c7642582dc52f2acbb5273719c83959908ca883aa89ae2e1a113ccf4e922f7d4b6b2220afbe6c373211ffbf34c47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c9c56512fd4a5fcbc45212561e48e905c8cef9102ad0be5da8d07ed71c692ddff766383a249379ca7a149e61784df8b30a8731330236d8c9b8fdd3f9db9c889"} 18:20:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:20:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:20:56 INFO - Contents: 18:20:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8294688d35834e9f7b17adc778f697776f381216820e37b5968fe27c9282efbc1982fda91bbbb3fad056b029eb30949ab9f0dc14e8e27ca137d8b009dca499b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21146393e74bb58c92d1d2eb3453b50aca84c7642582dc52f2acbb5273719c83959908ca883aa89ae2e1a113ccf4e922f7d4b6b2220afbe6c373211ffbf34c47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c9c56512fd4a5fcbc45212561e48e905c8cef9102ad0be5da8d07ed71c692ddff766383a249379ca7a149e61784df8b30a8731330236d8c9b8fdd3f9db9c889"} 18:20:56 INFO - Running post-run listener: copy_logs_to_upload_dir 18:20:56 INFO - Copying logs to upload dir... 18:20:56 INFO - mkdir: /builds/slave/test/build/upload/logs 18:20:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.666384 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-13 18:20:56.599564) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 18:20:56.602962) ========= 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=4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8294688d35834e9f7b17adc778f697776f381216820e37b5968fe27c9282efbc1982fda91bbbb3fad056b029eb30949ab9f0dc14e8e27ca137d8b009dca499b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21146393e74bb58c92d1d2eb3453b50aca84c7642582dc52f2acbb5273719c83959908ca883aa89ae2e1a113ccf4e922f7d4b6b2220afbe6c373211ffbf34c47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c9c56512fd4a5fcbc45212561e48e905c8cef9102ad0be5da8d07ed71c692ddff766383a249379ca7a149e61784df8b30a8731330236d8c9b8fdd3f9db9c889"} build_url:https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011218 build_url: 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8294688d35834e9f7b17adc778f697776f381216820e37b5968fe27c9282efbc1982fda91bbbb3fad056b029eb30949ab9f0dc14e8e27ca137d8b009dca499b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21146393e74bb58c92d1d2eb3453b50aca84c7642582dc52f2acbb5273719c83959908ca883aa89ae2e1a113ccf4e922f7d4b6b2220afbe6c373211ffbf34c47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0c9c56512fd4a5fcbc45212561e48e905c8cef9102ad0be5da8d07ed71c692ddff766383a249379ca7a149e61784df8b30a8731330236d8c9b8fdd3f9db9c889"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 18:20:56.629176) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:20:56.629543) ========= 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=4ac8d263c7293b36a1be1aed000001be-1468457376.423694-566305164 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 18:20:56.714264) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 18:20:56.714577) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 18:20:56.714882) ========= ========= Total master_lag: 0.20 =========