builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0203 starttime: 1474971253.53 results: success (0) buildid: 20160927005551 builduid: b5e41d7ba2e542db968c239e96300758 revision: 816341411190bd0d2745d11fe6cd927a001ac68d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 03:14:13.532331) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 03:14:13.532793) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 03:14:13.533079) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 03:14:13.557693) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:14:13.558065) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ipjnvpNQW3/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-27 03:14:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to 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% 163M=0s 2016-09-27 03:14:13 (163 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107709 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:14:13.688671) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:14:13.688996) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ipjnvpNQW3/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.026725 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:14:13.737836) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 03:14:13.738201) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 816341411190bd0d2745d11fe6cd927a001ac68d --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 816341411190bd0d2745d11fe6cd927a001ac68d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ipjnvpNQW3/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-27 03:14:13,833 truncating revision to first 12 chars 2016-09-27 03:14:13,833 Setting DEBUG logging. 2016-09-27 03:14:13,833 attempt 1/10 2016-09-27 03:14:13,833 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/816341411190?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 03:14:15,208 unpacking tar archive at: mozilla-aurora-816341411190/testing/mozharness/ program finished with exit code 0 elapsedTime=1.656395 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 03:14:15.425416) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 03:14:15.425762) ========= script_repo_revision: 816341411190bd0d2745d11fe6cd927a001ac68d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 03:14:15.426153) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 03:14:15.426417) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 03:14:15.445168) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-09-27 03:14:15.445467) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_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/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ipjnvpNQW3/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:14:15 INFO - MultiFileLogger online at 20160927 03:14:15 in /builds/slave/test 03:14:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:14:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:14:15 INFO - {'append_to_log': False, 03:14:15 INFO - 'base_work_dir': '/builds/slave/test', 03:14:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:14:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:14:15 INFO - 'branch': 'Mozilla-Aurora', 03:14:15 INFO - 'buildbot_json_path': 'buildprops.json', 03:14:15 INFO - 'config_files': ('talos/mac_config.py',), 03:14:15 INFO - 'default_actions': ('clobber', 03:14:15 INFO - 'read-buildbot-config', 03:14:15 INFO - 'download-and-extract', 03:14:15 INFO - 'populate-webroot', 03:14:15 INFO - 'create-virtualenv', 03:14:15 INFO - 'install', 03:14:15 INFO - 'run-tests'), 03:14:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:14:15 INFO - 'download_minidump_stackwalk': True, 03:14:15 INFO - 'download_symbols': 'ondemand', 03:14:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:14:15 INFO - 'tooltool.py': '/tools/tooltool.py', 03:14:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:14:15 INFO - '/tools/misc-python/virtualenv.py')}, 03:14:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:14:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:14:15 INFO - 'installer_path': 'installer.exe', 03:14:15 INFO - 'log_level': 'info', 03:14:15 INFO - 'log_name': 'talos', 03:14:15 INFO - 'log_to_console': True, 03:14:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:14:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:14:15 INFO - 'opt_config_files': (), 03:14:15 INFO - 'pip_index': False, 03:14:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:14:15 INFO - 'cmd': ('bash', 03:14:15 INFO - '-c', 03:14:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:14:15 INFO - 'enabled': True, 03:14:15 INFO - 'halt_on_failure': False, 03:14:15 INFO - 'name': 'check_screen_resolution'},), 03:14:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:14:15 INFO - 'cmd': ('bash', 03:14:15 INFO - '-c', 03:14:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:14:15 INFO - 'enabled': True, 03:14:15 INFO - 'halt_on_failure': False, 03:14:15 INFO - 'name': 'check_screen_resolution'},), 03:14:15 INFO - 'run_cmd_checks_enabled': True, 03:14:15 INFO - 'sps_profile': False, 03:14:15 INFO - 'sps_profile_interval': 0, 03:14:15 INFO - 'suite': 'dromaeojs', 03:14:15 INFO - 'system_bits': '32', 03:14:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:14:15 INFO - 'title': 't-yosemite-r7-0203', 03:14:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:14:15 INFO - 'use_talos_json': True, 03:14:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:14:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:14:15 INFO - 'work_dir': 'build'} 03:14:15 INFO - [mozharness: 2016-09-27 10:14:15.644485Z] Running clobber step. 03:14:15 INFO - Running pre-action listener: _resource_record_pre_action 03:14:15 INFO - Running main action method: clobber 03:14:15 INFO - rmtree: /builds/slave/test/build 03:14:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:14:17 INFO - Running post-action listener: _resource_record_post_action 03:14:17 INFO - [mozharness: 2016-09-27 10:14:17.645601Z] Finished clobber step (success) 03:14:17 INFO - [mozharness: 2016-09-27 10:14:17.645769Z] Running read-buildbot-config step. 03:14:17 INFO - Running pre-action listener: _resource_record_pre_action 03:14:17 INFO - Running main action method: read_buildbot_config 03:14:17 INFO - Using buildbot properties: 03:14:17 INFO - { 03:14:17 INFO - "project": "", 03:14:17 INFO - "product": "firefox", 03:14:17 INFO - "script_repo_revision": "production", 03:14:17 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:14:17 INFO - "repository": "", 03:14:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:14:17 INFO - "buildid": "20160927005551", 03:14:17 INFO - "pgo_build": "False", 03:14:17 INFO - "basedir": "/builds/slave/test", 03:14:17 INFO - "buildnumber": 50, 03:14:17 INFO - "slavename": "t-yosemite-r7-0203", 03:14:17 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 03:14:17 INFO - "platform": "yosemite_r7", 03:14:17 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:14:17 INFO - "branch": "mozilla-aurora", 03:14:17 INFO - "repo_path": "releases/mozilla-aurora", 03:14:17 INFO - "revision": "816341411190bd0d2745d11fe6cd927a001ac68d", 03:14:17 INFO - "stage_platform": "macosx64", 03:14:17 INFO - "builduid": "b5e41d7ba2e542db968c239e96300758", 03:14:17 INFO - "slavebuilddir": "test" 03:14:17 INFO - } 03:14:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:14:17 INFO - Running post-action listener: _resource_record_post_action 03:14:17 INFO - [mozharness: 2016-09-27 10:14:17.649124Z] Finished read-buildbot-config step (success) 03:14:17 INFO - [mozharness: 2016-09-27 10:14:17.649219Z] Running download-and-extract step. 03:14:17 INFO - Running pre-action listener: _resource_record_pre_action 03:14:17 INFO - Running main action method: download_and_extract 03:14:17 INFO - mkdir: /builds/slave/test/build/tests 03:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:17 INFO - trying https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:14:17 INFO - Downloading https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:14:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 03:14:18 INFO - Downloaded 1199 bytes. 03:14:18 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:14:18 INFO - Using the following test package requirements: 03:14:18 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:14:18 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:14:18 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:14:18 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:14:18 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:14:18 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:14:18 INFO - u'jsshell-mac.zip'], 03:14:18 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:14:18 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:14:18 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:14:18 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:14:18 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:14:18 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:14:18 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:14:18 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:14:18 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:14:18 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:14:18 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:14:18 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:14:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:14:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:14:18 INFO - Fetch https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:14:19 INFO - Expected file size: 16431995 03:14:26 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:14:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:14:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:14:26 INFO - Fetch https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:14:26 INFO - Expected file size: 16431995 03:14:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:14:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:14:33 INFO - Fetch https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:14:33 INFO - Expected file size: 14414059 03:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:34 INFO - trying https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:14:34 INFO - Downloading https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 03:14:37 INFO - Downloaded 115256693 bytes. 03:14:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:14:37 INFO - mkdir: /builds/slave/test/properties 03:14:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:14:37 INFO - Writing to file /builds/slave/test/properties/build_url 03:14:37 INFO - Contents: 03:14:37 INFO - build_url:https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:14:38 INFO - Running post-action listener: _resource_record_post_action 03:14:38 INFO - Running post-action listener: set_extra_try_arguments 03:14:38 INFO - [mozharness: 2016-09-27 10:14:38.178998Z] Finished download-and-extract step (success) 03:14:38 INFO - [mozharness: 2016-09-27 10:14:38.179158Z] Running populate-webroot step. 03:14:38 INFO - Running pre-action listener: _resource_record_pre_action 03:14:38 INFO - Running main action method: populate_webroot 03:14:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:14:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:14:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:14:38 INFO - '--tppagecycles', 03:14:38 INFO - '7'], 03:14:38 INFO - 'tests': ['tsvgm']}}, 03:14:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:14:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:14:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:14:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:14:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:14:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:14:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:14:38 INFO - 'talos_options': ['--disable-e10s'], 03:14:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:14:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:14:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:14:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:14:38 INFO - 'talos_options': ['--disable-e10s'], 03:14:38 INFO - 'tests': ['damp', 'tps']}, 03:14:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:14:38 INFO - 'tests': ['damp', 'tps']}, 03:14:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:14:38 INFO - 'tests': ['dromaeo_dom']}, 03:14:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:14:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:14:38 INFO - 'tests': ['basic_compositor_video']}, 03:14:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:14:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:14:38 INFO - 'tests': ['a11yr', 03:14:38 INFO - 'ts_paint', 03:14:38 INFO - 'tpaint', 03:14:38 INFO - 'sessionrestore', 03:14:38 INFO - 'sessionrestore_no_auto_restore', 03:14:38 INFO - 'tabpaint']}, 03:14:38 INFO - 'other-e10s': {'tests': ['a11yr', 03:14:38 INFO - 'ts_paint', 03:14:38 INFO - 'tpaint', 03:14:38 INFO - 'sessionrestore', 03:14:38 INFO - 'sessionrestore_no_auto_restore', 03:14:38 INFO - 'tabpaint']}, 03:14:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:14:38 INFO - 'ts_paint', 03:14:38 INFO - 'tpaint', 03:14:38 INFO - 'sessionrestore', 03:14:38 INFO - 'sessionrestore_no_auto_restore', 03:14:38 INFO - 'tabpaint']}, 03:14:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:14:38 INFO - 'ts_paint', 03:14:38 INFO - 'tpaint', 03:14:38 INFO - 'sessionrestore', 03:14:38 INFO - 'sessionrestore_no_auto_restore', 03:14:38 INFO - 'tabpaint']}, 03:14:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:14:38 INFO - 'tests': ['a11yr', 03:14:38 INFO - 'ts_paint', 03:14:38 INFO - 'tpaint', 03:14:38 INFO - 'sessionrestore', 03:14:38 INFO - 'sessionrestore_no_auto_restore', 03:14:38 INFO - 'tabpaint']}, 03:14:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:14:38 INFO - 'tests': ['a11yr', 03:14:38 INFO - 'ts_paint', 03:14:38 INFO - 'tpaint', 03:14:38 INFO - 'sessionrestore', 03:14:38 INFO - 'sessionrestore_no_auto_restore', 03:14:38 INFO - 'tabpaint']}, 03:14:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:14:38 INFO - 'tests': ['tsvgx', 03:14:38 INFO - 'tsvgr_opacity', 03:14:38 INFO - 'tart', 03:14:38 INFO - 'tscrollx', 03:14:38 INFO - 'cart']}, 03:14:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:14:38 INFO - 'tsvgr_opacity', 03:14:38 INFO - 'tart', 03:14:38 INFO - 'tscrollx', 03:14:38 INFO - 'cart']}, 03:14:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:14:38 INFO - 'talos_options': ['--disable-e10s'], 03:14:38 INFO - 'tests': ['tp5o']}, 03:14:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:14:38 INFO - 'tests': ['tp5o']}, 03:14:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:14:38 INFO - 'talos_options': ['--disable-e10s', 03:14:38 INFO - '--xperf_path', 03:14:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:14:38 INFO - 'tests': ['tp5n']}, 03:14:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:14:38 INFO - 'talos_options': ['--xperf_path', 03:14:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:14:38 INFO - 'tests': ['tp5n']}}, 03:14:38 INFO - 'talos.zip': {'path': '', 03:14:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:14:38 INFO - Running post-action listener: _resource_record_post_action 03:14:38 INFO - [mozharness: 2016-09-27 10:14:38.198069Z] Finished populate-webroot step (success) 03:14:38 INFO - [mozharness: 2016-09-27 10:14:38.198198Z] Running create-virtualenv step. 03:14:38 INFO - Running pre-action listener: _resource_record_pre_action 03:14:38 INFO - Running main action method: create_virtualenv 03:14:38 INFO - Creating virtualenv /builds/slave/test/build/venv 03:14:38 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 03:14:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:14:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:14:38 INFO - Using real prefix '/tools/python27' 03:14:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:14:39 INFO - Installing distribute.............................................................................................................................................................................................done. 03:14:41 INFO - Installing pip.................done. 03:14:41 INFO - Return code: 0 03:14:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:41 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 0x108309490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10827f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febe8d51400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10811dd30>, '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 0x107f83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108115b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:14:41 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 03:14:41 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 03:14:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 03:14:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:41 INFO - 'HOME': '/Users/cltbld', 03:14:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:41 INFO - 'LOGNAME': 'cltbld', 03:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:41 INFO - 'MOZ_NO_REMOTE': '1', 03:14:41 INFO - 'NO_EM_RESTART': '1', 03:14:41 INFO - 'PAGER': '/bin/cat', 03:14:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:41 INFO - 'PWD': '/builds/slave/test', 03:14:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:41 INFO - 'SHELL': '/bin/bash', 03:14:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 03:14:41 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:14:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:41 INFO - 'USER': 'cltbld', 03:14:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:41 INFO - 'XPC_FLAGS': '0x0', 03:14:41 INFO - 'XPC_SERVICE_NAME': '0', 03:14:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:42 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 03:14:42 INFO - Cleaning up... 03:14:42 INFO - Return code: 0 03:14:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14: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', '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 0x108309490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10827f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febe8d51400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10811dd30>, '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 0x107f83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108115b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:14: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:14: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 psutil>=3.1.1 03:14:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 03:14:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:42 INFO - 'HOME': '/Users/cltbld', 03:14:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:42 INFO - 'LOGNAME': 'cltbld', 03:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:42 INFO - 'MOZ_NO_REMOTE': '1', 03:14:42 INFO - 'NO_EM_RESTART': '1', 03:14:42 INFO - 'PAGER': '/bin/cat', 03:14:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:42 INFO - 'PWD': '/builds/slave/test', 03:14:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:42 INFO - 'SHELL': '/bin/bash', 03:14:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 03:14:42 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:14:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:42 INFO - 'USER': 'cltbld', 03:14:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:42 INFO - 'XPC_FLAGS': '0x0', 03:14:42 INFO - 'XPC_SERVICE_NAME': '0', 03:14:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:42 INFO - Downloading/unpacking psutil>=3.1.1 03:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:14:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:14:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:14:46 INFO - Installing collected packages: psutil 03:14:46 INFO - Running setup.py install for psutil 03:14:46 INFO - building 'psutil._psutil_osx' extension 03:14:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:14:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:14:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:14:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:14:47 INFO - building 'psutil._psutil_posix' extension 03:14:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:14:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:14:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:14:47 INFO - ^ 03:14:47 INFO - 1 warning generated. 03:14:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:14:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:14:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:14:47 INFO - Successfully installed psutil 03:14:47 INFO - Cleaning up... 03:14:47 INFO - Return code: 0 03:14:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:47 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 0x108309490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10827f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febe8d51400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10811dd30>, '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 0x107f83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108115b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:14:47 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 03:14:47 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 03:14:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 03:14:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:47 INFO - 'HOME': '/Users/cltbld', 03:14:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:47 INFO - 'LOGNAME': 'cltbld', 03:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:47 INFO - 'MOZ_NO_REMOTE': '1', 03:14:47 INFO - 'NO_EM_RESTART': '1', 03:14:47 INFO - 'PAGER': '/bin/cat', 03:14:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:47 INFO - 'PWD': '/builds/slave/test', 03:14:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:47 INFO - 'SHELL': '/bin/bash', 03:14:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 03:14:47 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:14:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:47 INFO - 'USER': 'cltbld', 03:14:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:47 INFO - 'XPC_FLAGS': '0x0', 03:14:47 INFO - 'XPC_SERVICE_NAME': '0', 03:14:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:14: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 03:14: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 03:14: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 03:14: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 03:14: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 03:14: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 03:14:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:14:50 INFO - Installing collected packages: mozsystemmonitor 03:14:50 INFO - Running setup.py install for mozsystemmonitor 03:14:50 INFO - Successfully installed mozsystemmonitor 03:14:50 INFO - Cleaning up... 03:14:50 INFO - Return code: 0 03:14:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108309490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10827f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febe8d51400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10811dd30>, '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 0x107f83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108115b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:14:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:14:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 03:14:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:50 INFO - 'HOME': '/Users/cltbld', 03:14:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:50 INFO - 'LOGNAME': 'cltbld', 03:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:50 INFO - 'MOZ_NO_REMOTE': '1', 03:14:50 INFO - 'NO_EM_RESTART': '1', 03:14:50 INFO - 'PAGER': '/bin/cat', 03:14:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:50 INFO - 'PWD': '/builds/slave/test', 03:14:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:50 INFO - 'SHELL': '/bin/bash', 03:14:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 03:14:50 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:14:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:50 INFO - 'USER': 'cltbld', 03:14:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:50 INFO - 'XPC_FLAGS': '0x0', 03:14:50 INFO - 'XPC_SERVICE_NAME': '0', 03:14:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:50 INFO - Downloading/unpacking jsonschema==2.5.1 03:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:14:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:14:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:14: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 03:14: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 03:14: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 03:14: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 03:14: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 03:14: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 03:14:53 INFO - Downloading functools32-3.2.3-2.tar.gz 03:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:14:53 INFO - warning: no files found matching '*.txt' 03:14:53 INFO - no previously-included directories found matching 'build' 03:14:53 INFO - no previously-included directories found matching 'dist' 03:14:53 INFO - no previously-included directories found matching '.git*' 03:14:53 INFO - Installing collected packages: jsonschema, functools32 03:14:53 INFO - Running setup.py install for functools32 03:14:53 INFO - warning: no files found matching '*.txt' 03:14:53 INFO - no previously-included directories found matching 'build' 03:14:53 INFO - no previously-included directories found matching 'dist' 03:14:53 INFO - no previously-included directories found matching '.git*' 03:14:53 INFO - Successfully installed jsonschema functools32 03:14:53 INFO - Cleaning up... 03:14:53 INFO - Return code: 0 03:14:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108309490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10827f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febe8d51400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10811dd30>, '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 0x107f83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108115b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:14:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:14:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 03:14:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:53 INFO - 'HOME': '/Users/cltbld', 03:14:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:53 INFO - 'LOGNAME': 'cltbld', 03:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:53 INFO - 'MOZ_NO_REMOTE': '1', 03:14:53 INFO - 'NO_EM_RESTART': '1', 03:14:53 INFO - 'PAGER': '/bin/cat', 03:14:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:53 INFO - 'PWD': '/builds/slave/test', 03:14:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:53 INFO - 'SHELL': '/bin/bash', 03:14:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 03:14:53 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:14:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:53 INFO - 'USER': 'cltbld', 03:14:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:53 INFO - 'XPC_FLAGS': '0x0', 03:14:53 INFO - 'XPC_SERVICE_NAME': '0', 03:14:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:14:54 INFO - Cleaning up... 03:14:54 INFO - Return code: 0 03:14:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108309490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10827f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febe8d51400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10811dd30>, '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 0x107f83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108115b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:14:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 03:14:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:54 INFO - 'HOME': '/Users/cltbld', 03:14:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:54 INFO - 'LOGNAME': 'cltbld', 03:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:54 INFO - 'MOZ_NO_REMOTE': '1', 03:14:54 INFO - 'NO_EM_RESTART': '1', 03:14:54 INFO - 'PAGER': '/bin/cat', 03:14:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:54 INFO - 'PWD': '/builds/slave/test', 03:14:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:54 INFO - 'SHELL': '/bin/bash', 03:14:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 03:14:54 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:14:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:54 INFO - 'USER': 'cltbld', 03:14:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:54 INFO - 'XPC_FLAGS': '0x0', 03:14:54 INFO - 'XPC_SERVICE_NAME': '0', 03:14:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:54 INFO - Downloading/unpacking blobuploader==1.2.4 03:14:54 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 03:14:54 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 03:14:54 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 03:14:54 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 03:14:54 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 03:14:54 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 03:14:56 INFO - Downloading blobuploader-1.2.4.tar.gz 03:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:14:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:14: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 03:14: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 03:14: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 03:14: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 03:14: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 03:14: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 03:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:14:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:58 INFO - Downloading docopt-0.6.1.tar.gz 03:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:14:58 INFO - Installing collected packages: blobuploader, requests, docopt 03:14:58 INFO - Running setup.py install for blobuploader 03:14:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:14:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:14:58 INFO - Running setup.py install for requests 03:14:58 INFO - Running setup.py install for docopt 03:14:58 INFO - Successfully installed blobuploader requests docopt 03:14:58 INFO - Cleaning up... 03:14:59 INFO - Return code: 0 03:14:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:14:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108309490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10827f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febe8d51400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10811dd30>, '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 0x107f83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108115b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:14:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 03:14:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:59 INFO - 'HOME': '/Users/cltbld', 03:14:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:59 INFO - 'LOGNAME': 'cltbld', 03:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:59 INFO - 'MOZ_NO_REMOTE': '1', 03:14:59 INFO - 'NO_EM_RESTART': '1', 03:14:59 INFO - 'PAGER': '/bin/cat', 03:14:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:59 INFO - 'PWD': '/builds/slave/test', 03:14:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:59 INFO - 'SHELL': '/bin/bash', 03:14:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 03:14:59 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:14:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:59 INFO - 'USER': 'cltbld', 03:14:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:59 INFO - 'XPC_FLAGS': '0x0', 03:14:59 INFO - 'XPC_SERVICE_NAME': '0', 03:14:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:14:59 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-3KPkAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:14:59 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-vyYWYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:14:59 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-C9dMPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:14:59 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-pUyb2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:14:59 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-xQhYg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:14:59 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-LH_j1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:14:59 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-QNvHKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:15:00 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-Su7teJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:15:00 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-5lWrJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:15:00 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-a5uLng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:15:00 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-9d09JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:15:00 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-SZMmbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:15:00 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-V2ngWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:15:00 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-7sPLZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:00 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-fiCc4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:15:00 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-Vmp0bP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:15:00 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-2eyVcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:15:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:15:01 INFO - Running setup.py install for manifestparser 03:15:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:15:01 INFO - Running setup.py install for mozcrash 03:15:01 INFO - Running setup.py install for mozdebug 03:15:01 INFO - Running setup.py install for mozdevice 03:15:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:15:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:15:01 INFO - Running setup.py install for mozfile 03:15:01 INFO - Running setup.py install for mozhttpd 03:15:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:15:01 INFO - Running setup.py install for mozinfo 03:15:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:15:02 INFO - Running setup.py install for mozInstall 03:15:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:15:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:15:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:15:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:15:02 INFO - Running setup.py install for mozleak 03:15:02 INFO - Running setup.py install for mozlog 03:15:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:15:02 INFO - Running setup.py install for moznetwork 03:15:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:15:02 INFO - Running setup.py install for mozprocess 03:15:02 INFO - Running setup.py install for mozprofile 03:15:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:15:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:15:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:15:02 INFO - Running setup.py install for mozrunner 03:15:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:15:03 INFO - Running setup.py install for mozscreenshot 03:15:03 INFO - Running setup.py install for moztest 03:15:03 INFO - Running setup.py install for mozversion 03:15:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:15:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:15:03 INFO - Cleaning up... 03:15:03 INFO - Return code: 0 03:15:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:15:03 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:03 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:03 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 0x108309490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10827f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febe8d51400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10811dd30>, '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 0x107f83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108115b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:15:03 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 03:15:03 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 03:15:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 03:15:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:03 INFO - 'HOME': '/Users/cltbld', 03:15:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:03 INFO - 'LOGNAME': 'cltbld', 03:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:03 INFO - 'MOZ_NO_REMOTE': '1', 03:15:03 INFO - 'NO_EM_RESTART': '1', 03:15:03 INFO - 'PAGER': '/bin/cat', 03:15:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:03 INFO - 'PWD': '/builds/slave/test', 03:15:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:03 INFO - 'SHELL': '/bin/bash', 03:15:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 03:15:03 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:15:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:03 INFO - 'USER': 'cltbld', 03:15:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:03 INFO - 'XPC_FLAGS': '0x0', 03:15:03 INFO - 'XPC_SERVICE_NAME': '0', 03:15:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:15:04 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-qE5zS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:15:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:15:04 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-3sUNd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:15:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:15:04 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-m4UJJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:15:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:15:04 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-QRgPuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:15:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:15:04 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-u3jbyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:15:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:15:04 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-xJzzWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:15:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:15:04 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-szt9R_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:15:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:15:04 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-IHm6zQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:15:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:15:04 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-lCIOO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:15:05 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)) 03:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:15:05 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-ijf9l0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 03:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:15:05 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-2_4YvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:15:05 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-I9uZD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:15:05 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)) 03:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:15:05 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-W4z9hS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:15:05 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-7VKU7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:15:05 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)) 03:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:05 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-PmBWUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:15:05 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-HSLpW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:15:05 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-a1hGmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:15:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:08 INFO - Downloading blessings-1.6.tar.gz 03:15:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:15:08 INFO - Installing collected packages: blessings 03:15:08 INFO - Running setup.py install for blessings 03:15:08 INFO - Successfully installed blessings 03:15:08 INFO - Cleaning up... 03:15:08 INFO - Return code: 0 03:15:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:15:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:15:09 INFO - Reading from file tmpfile_stdout 03:15:09 INFO - Current package versions: 03:15:09 INFO - blessings == 1.6 03:15:09 INFO - blobuploader == 1.2.4 03:15:09 INFO - docopt == 0.6.1 03:15:09 INFO - functools32 == 3.2.3-2 03:15:09 INFO - jsonschema == 2.5.1 03:15:09 INFO - manifestparser == 1.1 03:15:09 INFO - mozInstall == 1.12 03:15:09 INFO - mozcrash == 0.17 03:15:09 INFO - mozdebug == 0.1 03:15:09 INFO - mozdevice == 0.48 03:15:09 INFO - mozfile == 1.2 03:15:09 INFO - mozhttpd == 0.7 03:15:09 INFO - mozinfo == 0.9 03:15:09 INFO - mozleak == 0.1 03:15:09 INFO - mozlog == 3.4 03:15:09 INFO - moznetwork == 0.27 03:15:09 INFO - mozprocess == 0.23 03:15:09 INFO - mozprofile == 0.28 03:15:09 INFO - mozrunner == 6.12 03:15:09 INFO - mozscreenshot == 0.1 03:15:09 INFO - mozsystemmonitor == 0.3 03:15:09 INFO - moztest == 0.7 03:15:09 INFO - mozversion == 1.4 03:15:09 INFO - psutil == 3.1.1 03:15:09 INFO - requests == 1.2.3 03:15:09 INFO - wsgiref == 0.1.2 03:15:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:15:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:09 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 0x108309490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10827f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febe8d51400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10811dd30>, '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 0x107f83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108115b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:15:09 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 03:15:09 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 03:15:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 03:15:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:09 INFO - 'HOME': '/Users/cltbld', 03:15:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:09 INFO - 'LOGNAME': 'cltbld', 03:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:09 INFO - 'MOZ_NO_REMOTE': '1', 03:15:09 INFO - 'NO_EM_RESTART': '1', 03:15:09 INFO - 'PAGER': '/bin/cat', 03:15:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:09 INFO - 'PWD': '/builds/slave/test', 03:15:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:09 INFO - 'SHELL': '/bin/bash', 03:15:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 03:15:09 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:15:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:09 INFO - 'USER': 'cltbld', 03:15:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:09 INFO - 'XPC_FLAGS': '0x0', 03:15:09 INFO - 'XPC_SERVICE_NAME': '0', 03:15:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:09 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)) 03:15:09 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)) 03:15:09 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)) 03:15:09 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)) 03:15:09 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)) 03:15:09 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)) 03:15:09 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)) 03:15:09 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)) 03:15:09 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)) 03:15:09 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)) 03:15:09 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)) 03:15:09 INFO - Cleaning up... 03:15:09 INFO - Return code: 0 03:15:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:15:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:09 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 0x108309490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10827f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febe8d51400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10811dd30>, '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 0x107f83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108115b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:15:09 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 03:15:09 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 03:15:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 03:15:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:09 INFO - 'HOME': '/Users/cltbld', 03:15:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:09 INFO - 'LOGNAME': 'cltbld', 03:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:09 INFO - 'MOZ_NO_REMOTE': '1', 03:15:09 INFO - 'NO_EM_RESTART': '1', 03:15:09 INFO - 'PAGER': '/bin/cat', 03:15:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:09 INFO - 'PWD': '/builds/slave/test', 03:15:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:09 INFO - 'SHELL': '/bin/bash', 03:15:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 03:15:09 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:15:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:09 INFO - 'USER': 'cltbld', 03:15:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:09 INFO - 'XPC_FLAGS': '0x0', 03:15:09 INFO - 'XPC_SERVICE_NAME': '0', 03:15:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:15:09 INFO - Cleaning up... 03:15:09 INFO - Return code: 0 03:15:09 INFO - Running post-action listener: _resource_record_post_action 03:15:09 INFO - Running post-action listener: _start_resource_monitoring 03:15:09 INFO - Starting resource monitoring. 03:15:09 INFO - [mozharness: 2016-09-27 10:15:09.608543Z] Finished create-virtualenv step (success) 03:15:09 INFO - [mozharness: 2016-09-27 10:15:09.609489Z] Running install step. 03:15:09 INFO - Running pre-action listener: _resource_record_pre_action 03:15:09 INFO - Running main action method: install 03:15:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:15:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:15:09 INFO - Reading from file tmpfile_stdout 03:15:09 INFO - Detecting whether we're running mozinstall >=1.0... 03:15:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:15:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:15:09 INFO - Reading from file tmpfile_stdout 03:15:09 INFO - Output received: 03:15:09 INFO - Usage: mozinstall [options] installer 03:15:09 INFO - Options: 03:15:09 INFO - -h, --help show this help message and exit 03:15:09 INFO - -d DEST, --destination=DEST 03:15:09 INFO - Directory to install application into. [default: 03:15:09 INFO - "/builds/slave/test"] 03:15:09 INFO - --app=APP Application being installed. [default: firefox] 03:15:09 INFO - mkdir: /builds/slave/test/build/application 03:15:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:15:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:15:41 INFO - Reading from file tmpfile_stdout 03:15:41 INFO - Output received: 03:15:41 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:15:41 INFO - Running post-action listener: _resource_record_post_action 03:15:41 INFO - [mozharness: 2016-09-27 10:15:41.939725Z] Finished install step (success) 03:15:41 INFO - [mozharness: 2016-09-27 10:15:41.939881Z] Running run-tests step. 03:15:41 INFO - Running pre-action listener: _resource_record_pre_action 03:15:41 INFO - Running main action method: run_tests 03:15:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:15:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:15:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:15:41 INFO - 2016-09-27 03:15:41.954 screenresolution[1638:7602] starting screenresolution argv=screenresolution get 03:15:41 INFO - 2016-09-27 03:15:41.957 screenresolution[1638:7602] Display 0: 1600x1200x32@60 03:15:41 INFO - 2016-09-27 03:15:41.963 screenresolution[1639:7604] starting screenresolution argv=screenresolution list 03:15:41 INFO - Available Modes on Display 0 03:15:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:15:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:15:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:15:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:15:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:15:42 INFO - Intel Iris: 03:15:42 INFO - Chipset Model: Intel Iris 03:15:42 INFO - Type: GPU 03:15:42 INFO - Bus: Built-In 03:15:42 INFO - VRAM (Dynamic, Max): 1536 MB 03:15:42 INFO - Vendor: Intel (0x8086) 03:15:42 INFO - Device ID: 0x0a2e 03:15:42 INFO - Revision ID: 0x0009 03:15:42 INFO - Displays: 03:15:42 INFO - Display: 03:15:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:15:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:15:42 INFO - Display Serial Number: 1600x1200 60 03:15:42 INFO - Main Display: Yes 03:15:42 INFO - Mirror: Off 03:15:42 INFO - Online: Yes 03:15:42 INFO - Rotation: Supported 03:15:42 INFO - Return code: 0 03:15:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:15:42 INFO - Python 2.7.3 03:15:42 INFO - Return code: 0 03:15:42 INFO - grabbing minidump binary from tooltool 03:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:42 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/macosx64/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 0x10811dd30>, '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 0x107f83db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108115b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:15:42 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:15:42 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:15:42 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:15:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:15:42 INFO - Return code: 0 03:15:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:15:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:15:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:15:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:15:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:15:42 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/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0203', '--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 03:15:42 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/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0203 --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 03:15:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ipjnvpNQW3/Render', 03:15:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:42 INFO - 'HOME': '/Users/cltbld', 03:15:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:42 INFO - 'LOGNAME': 'cltbld', 03:15:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:15:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:42 INFO - 'MOZ_NO_REMOTE': '1', 03:15:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:15:42 INFO - 'NO_EM_RESTART': '1', 03:15:42 INFO - 'PAGER': '/bin/cat', 03:15:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:42 INFO - 'PWD': '/builds/slave/test', 03:15:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:15:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:42 INFO - 'SHELL': '/bin/bash', 03:15:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners', 03:15:42 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:15:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:42 INFO - 'USER': 'cltbld', 03:15:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:42 INFO - 'XPC_FLAGS': '0x0', 03:15:42 INFO - 'XPC_SERVICE_NAME': '0', 03:15:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:42 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/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0203', '--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 03:15:42 INFO - mozversion application_buildid: 20160927005551 03:15:42 INFO - mozversion application_changeset: 816341411190bd0d2745d11fe6cd927a001ac68d 03:15:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:15:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:15:42 INFO - mozversion application_name: Firefox 03:15:42 INFO - mozversion application_remotingname: firefox-dev 03:15:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:15:42 INFO - mozversion application_vendor: Mozilla 03:15:42 INFO - mozversion application_version: 51.0a2 03:15:42 INFO - mozversion platform_buildid: 20160927005551 03:15:42 INFO - mozversion platform_changeset: 816341411190bd0d2745d11fe6cd927a001ac68d 03:15:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:15:42 INFO - mozversion platform_version: 51.0a2 03:15:42 INFO - using testdate: 1474971342 03:15:42 INFO - actual date: 1474971342 03:15:42 INFO - starting webserver on 'localhost:49266' 03:15:42 INFO - SUITE-START | Running 2 tests 03:15:42 INFO - TEST-START | dromaeo_css 03:15:42 INFO - operating with platform_type : mac_ 03:15:42 INFO - Initialising browser for dromaeo_css test... 03:15:42 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpT1czjG/profile http://localhost:49266/getInfo.html) 03:15:45 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 03:15:45 INFO - PROCESS | 1649 | colorDepth:24 03:15:45 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 03:15:45 INFO - PROCESS | 1649 | __metrics 03:15:45 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:15:45 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:15:45 INFO - TEST-INFO | 1649: exit 0 03:15:45 INFO - Browser initialized. 03:15:45 INFO - Running cycle 1/1 for dromaeo_css test... 03:15:45 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpT1czjG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:15:58 INFO - PROCESS | 1651 | RSS: Main: 218996736 03:15:58 INFO - PROCESS | 1651 | 03:16:49 INFO - PROCESS | 1651 | 1474971409097 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] 03:19:00 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 03:19:02 INFO - PROCESS | 1651 | RSS: Main: 363085824 03:19:02 INFO - PROCESS | 1651 | 03:22:05 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 03:22:05 INFO - PROCESS | 1651 | RSS: Main: 353411072 03:22:05 INFO - PROCESS | 1651 | 03:25:08 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 03:25:08 INFO - PROCESS | 1651 | RSS: Main: 316321792 03:25:08 INFO - PROCESS | 1651 | 03:28:10 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 03:28:11 INFO - PROCESS | 1651 | RSS: Main: 314753024 03:28:11 INFO - PROCESS | 1651 | 03:31:15 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 03:31:15 INFO - PROCESS | 1651 | RSS: Main: 309211136 03:31:15 INFO - PROCESS | 1651 | 03:34:18 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 03:34:18 INFO - PROCESS | 1651 | RSS: Main: 402747392 03:34:18 INFO - PROCESS | 1651 | 03:34:18 INFO - PROCESS | 1651 | __start_tp_report 03:34:18 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 03:34:18 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 03:34:18 INFO - PROCESS | 1651 | |i|pagename|runs| 03:34:18 INFO - PROCESS | 1651 | |0;dojo.html;3355.8154301513414;3372.258103217292;3397.9490307645387;3406.5230867678515;3447.03483024753;4743.4545027321865;5766.654000759957;5790.942090579093;5820.359760426355;5840.620359676624;5766.1639062335935;5833.854153646161;5838.649681019131;5842.357340692521;5857.941420585793;5262.42308804611;5300.25796388504;5321.988822123803;5347.598930080259;5361.705106219157;5204.895902081956;5243.554297884684;5269.683818970855;5328.49379308965;5377.354717433894;5318.574514038867;5325.467453254682;5338.3060202173665;5342.839714808562;5349.786008559653;5315.229291752674;5322.7072511011875;5330.973345133289;5365.195220716884;5385.865353366158;5275.815346462894;5322.20166974953;5323.893522129574;5328.3605967284175;5332.92000619991;5724.16999535065;5755.165501002373;5756.338021127582;5881.911771323434;5884.941150588482;6228.470580000705;6279.309275979638;6301.40136687014;6359.046143078529;6378;6247.375262473762;6323.399277068671;6325.746970121189;6330.050492426127;6337.714802833883;5807.361190269067;5834.679092649945;5952.0476723724;5961.970190149108;5975.402459754033;6281.78013769525;6294.559380843389;6401.743930242831;6424.196975378078;6431.710573024132;6279.3720627937755;6285.308616052231;6294.685265736786;6297.370262973757;6302.936970630327;6186.721597528122;6336.651484168415;6338.968305158537;6345.904811427832;6361.8727625448155;6145.600535965148;6205.441510264098;6234.719437625317;6283.434490895841;6301.495880329563;6338.968305158444;6349.492040636738;6349.52378571609;6357.777477788348;6367.299597044322;4972.57733092684;5017.698938063655;5024.497550244946;5031.52200540948;5056.747162641853;4444.933326000112;4449.822007119744;4493.123840851003;4499.055198408306;4529.365888775574;5830.125481177773;5888.5289176865745;5894.941050589525;5919.378465261086;5970.134330522137;5204.635675502678;6315.905261421082;6330;6335.303116657164;6337.207849018872;4767.570918617341;5870.647761134345;5891.293044834647;5909.763609455659;5912.704364781744;4656.161890859677;5427.6472029317965;5436.537894278951;5498.395176530578;5499.560035197174;6368.42684158428;6457.4188323049275;6466.708998095097;6466.7736629219635;6481.740730370732;6338.651374174465;6352.968235158794;6353.491720662243;6366.936330636634;6371.39471750183;6254.124422580933;6328.493720502441;6360.236771587439;6403.263624683221;6455.67721613908;6246.6876656167915;6291.748330066746;6321.33625969285;6329.778457753957;6339.873202536016;6335.018072198816;6340.841478963062;6347.619142851444;6362.204724409449;6364.904526432015;6087.086936959491;6124.203853499017;6142.355052719578;6266.248050234001;6268.686565671789;6159.1069294951085;6183.3816618337805;6234.844128896814;6274.560780745304;6280.654563999024;6132.325444201045;6136.938630613637;6147.631142131487;6153.261608606996;6153.261608606996;6112.908306375497;6217.658028808459;6220.533459990428;6262.937370626418;6263.311035785969;5704.515116215002;6053.969730151321;6091.208142941389;6104.114903338902;6141.3551577085545 03:34:18 INFO - PROCESS | 1651 | |1;ext.html;522.5845452864971;525.1413938211025;531.9335083114611;535.9169328754042;550.9586780991422;24011.75988240117;41203.58796412035;42571.93570160747;42602.99999999996;42779;41642.58357416425;43455.34816977748;43757.56242437575;43765.56234437654;43906.682799515984;9096.22682072023;9736.415815051085;9740.269479789009;9756.024397560259;9759.756006099833;8733.737987860375;8893.77765555863;11839.28964262147;12030.218035827644;12060.216085954386;12028.69928251792;12105.878941210563;12107.697307567294;12108.636740897788;12127.332996685178;11994.280343179436;12075.852793984557;12076.335801530913;12080;12086.576969806103;11785.351805650685;11881.40592970348;11893.226940248942;11895.04839612829;11897.762044759056;30890.536641950388;40276;40534;40664;40720.185596287905;3269.7547683923563;3485.233248685285;3718.2191739734417;3920.7843568603716;3982.2234664240486;29677.40645187084;29691.406171876442;29751.5537266939;31573.684263157535;31638.683613163805;3133.4673105572106;3216.5979252593424;3223.5003574446;3400.387930172593;3400.778949368308;465096;469634;470815;473217;474211;59484.40515594788;60038.099428508605;60051.39948600545;60145.699271504236;60146.69926650339;62491;62603.68698156571;62623.6868815653;62720.372796271455;62789.37210627835;15702.528924132293;15846.683066338608;16083.437079702388;16094.678106437806;16095.356185752438;10990.890091099147;11254.155938304497;12207.755844883053;12574;12574.559890403974;13312.534061307808;13389.19664820114;13407.530736424178;13455.730885382238;15621.453249136226;5942.821715348547;6556.901646475307;6590.176227971504;6633.535652504278;6672.96663516689;895.8253140637513;920.6133423961952;1002.7292630989592;1030.2427715629008;1032.0608246495653;29423.411531769674;29516.852415738213;29947.101586952427;30387.2403189922;30920;1065.3128731967993;1066.7785385733448;1091.901728844392;1140.6235942139074;1234.4444999750149;15035.624109397133;15296.541103766906;15376.692466150615;15463.458778942682;15922.92038539823;646379;652004;654660;657134;657879;57835.42164578385;57936.42063579395;57955;57957;58093.67625294941;1229.2133034857698;1270.4283072617175;1274.0444666500125;1373.9313034348443;1402.200745575033;29659.68468805705;32620;32818.83590582032;33155.33689326248;33346.499802503466;54992.17511737247;56629;56651;59284;59443;634530;640844;642508;644894;645718;25719.742802571735;25771.613425798252;26152.34619134537;26379.076732315043;26490.86754566215;47281.527184729086;47450.52549474599;47605.28592071052;47813.56559303227;48078.75960620175;37995.05012374602;38780.80609597047;39327.80336098301;40274.395884061174;40593;38747.41878871763;39005.804970976096;39124.60430220072;40210.39684404678;40406.79796600998;38068;38655.80672096734;38720;38914.83255502339;40210.597894020684;29015;32104;34660;34720.652793471745;35201.29597408089;25381.61927571051;25833.741662583132;25849.741502584733;25951.610725839506;26161.60757588676 03:34:18 INFO - PROCESS | 1651 | |2;jquery.html;354.397524208845;371.4409813231087;379.6052105809958;386.7238114223064;404.4701441112143;14940.028898121627;15220.695586088272;17164.65670686587;20637.587248255062;21008.474788130305;20309.695354569692;20748.48128796777;20897.686534701992;21051.684224736604;21157.259495917646;5745.741441635126;5787.450192231731;5944.554158438113;6036.396360363972;6045.516358691316;5751.367349591542;5936.347001829795;5939.613925094876;5941.910871336933;5943.316518600352;4097.528784189812;4174.276543332759;5889.528837692996;6418.839529011789;6492.15601971743;5177.223416487519;6577.539572229945;6596.835079123012;6600.570962887397;6604.042413850013;5782.624129431573;5894.17481552583;5896.557758168112;5896.941030589682;5903.291605007384;12851.421686024058;14532.927335363256;21126.366209013755;25019.749802501923;25265.747342526523;2013.6677448221026;2368.2066507719933;2455.2143314139485;2668.310948230001;2859.1565488181036;8172.305354044914;9410.482423466707;9595.42427454355;10033.297669163161;10334.948325258325;1695.0846542866836;1803.7023891057959;1842.3459671816447;1844.317602487075;1850.80566540514;118018;119828.57427617499;130078;134121.6587834119;134383;11524.078073754079;11566.595169169206;11642.068634509218;11685.357305348287;11780.057595392347;14755.77866332006;14763.704725905422;14779.704405911822;14794.704105917821;14799;8192.836143277102;8412.495250285003;8416;8463.957680211683;8489.193526614961;8245.505269683837;8277.337812975067;8297.875531867026;8426.915730842737;8472.534010629352;4073.920411091063;4308.827646894152;4463.24124898768;4519.683622146418;4624.606908412823;1629.6496253305359;1646.777685012532;1791.6506281275288;1932.8743631663897;1943.5529828139606;898.1377877237925;934.7195841247734;947.199616324205;956.6699488676395;1011.1556850030161;20105.698414523795;21457.927103644754;21551.137954481957;21552.676709849366;21680;917.1149840404042;924.242121460396;926.2636204217663;931.6133804471204;947.4362754161263;9465.47939863314;10518.263721539572;11293.774124517464;11413.771724565628;11463.54145834174;578880;606961;619989.9000504969;630597;634376;74054;78861;86351.61962908653;102777;138909;882.3294296334832;922.2990527199377;935.2517985611483;937.723371605378;938.1884669760744;18948.526286842938;19821;19994;20026.599468010267;20034.499137521678;54028.45971540234;55416;55813.32560023043;57972.970946016685;58071;78730.60634696789;80413;82231.06215830089;82821;83570;8029.5583742894705;8158;8194.016717993878;8211.384146189179;8244.340452763645;12210.694732631755;12643.178193417398;12850.293233872228;12987.545435909698;13037.47850086024;10715.892841071489;10993.61522346714;10993.670189894316;11035.448227588427;11273.436328183721;10787.514561844893;10869.293495923055;10871.78256434851;10899.56401743953;11022.779544409228;10128.069206150074;10890.455477226265;11034.613788517363;11376.317420954769;11565.479553419947;6979.616121113185;7159.355657990805;7261.419086473175;7918.722844700408;8372;9486.146246837818;10843.349399036084;10868.891311086787;10991.835122473009;11207.271527350696 03:34:18 INFO - PROCESS | 1651 | |3;mootools.html;1499.100539676194;1514.333693175003;1727.3608764757041;1877.3804644467327;1913.8277555020045;8562.571871406428;9044.412113212637;9044.502552359625;9053.728388148349;9074.410163339386;7970.083440404355;8140.43016988811;8173.5504547249875;8663.003754568226;8848.42485238459;2322.4542232575373;2364.73987861336;2368.04094341791;2372.383180373098;2373.857568545884;2315.1896836107394;2333.6032874411308;2354.0819080558595;2358.84667496613;2361.504084142332;2086.2906611752;2148.4628842789302;2154.0952799824113;2160.6758986152045;2163.491579478821;2142.507223338633;2319.9188028419007;2375.560521303564;2379.476515166678;2385.6779334789753;2349.4361353275262;2355.611324131516;2359.3511784259294;2365.6215005599192;2380.369202161429;8752.8687069694;8967.730968070968;8979.730608081769;8980.416272942302;8986.14631609996;5189.351331083614;5323.387810401776;5340.759665815009;5343;5344.732763361855;3455.1189446690933;3534.3991521441417;3597.6762091411897;3612.0789198754414;3613.223157021253;1035.662913545952;1062.585591619269;1084.5661735305862;1086.2721976275914;1096.9341839489657;11564.132690048196;11574.305541667443;11583.710407239801;11588.30470171784;11613.825792613117;3760.52993375828;4670.089332580114;4820.542048505386;4830.420349558076;4838.491958344393;9930.751731206634;9935.950320248352;9951.104400603981;9957.452340121217;9984.550695218733;4563.452385713736;5348.625596208306;5353.437889021675;5353.491418315254;5354.785808567692;4754.548317909793;4832.830850920201;4888.340074090023;4900.583450406684;4904.852854414374;3983.8605648802154;4008.376607473978;4029.1135950090934;4070.2266569351727;4099.426080348694;1285.9357032148355;1286.279683377293;1288.8968882489378;1301.2777908260816;1306.3337697774205;799.6041959230218;809.9915605071724;892.9330300227509;929.8419268724198;941.317544780029;5906.26171728534;5908.940910590925;6021.54838387114;6026.246719160105;6237.95111523975;908.2824568590739;909.60432211988;914.277720600718;934.1825902335456;1009.4700282351824;3940.665043471337;4063.5326937401987;4106.926481861546;4150.418941348214;4206.642435392964;10845.783084338427;11055.11559075272;11138.387388693538;11150.49822757978;11202;11078.390688512209;11092;11096;11097.55609775616;11105.38920359388;7872.212778722196;8177.182281771894;8245.340372770164;8374.706885258987;8380.664773409117;5777.277840269966;6116.480099191618;6130.172426722514;6137.110119032626;6207.286162091236;9205.86191207119;10374.481275936323;10379.896201038195;10380.948095259475;10394.272400931863;9950.45272510019;10033.397996120257;10280.691579252634;10470.110040646327;10497.370157790558;7564.583947882919;7817.882731758915;7826.921730782847;7839.294463498312;7854;8364.079951205484;8392.748217553482;8414.873776893473;8479.576021198793;8490.405671602928;7575.507592006502;7655.119661239029;7661.731839385595;7666.655000525101;7696.422768292288;7458;7486.401087912845;7522.736704215326;7569.772906812585;7596;7121.038659780863;7134.85730285381;7235.095613048369;7237.1677257114;7242.167150777728;4933.136701077226;5044.520770526794;5140.306058682179;5193.76628051731;5311.203319502106;4968.900621987467;5075.974620126875;5158.638895277445;5245.160774276097;5286.207068939536 03:34:18 INFO - PROCESS | 1651 | |4;prototype.html;286.435721628392;302.9621297337833;303.4053255618985;311.41298652040905;315.7884217574225;3830.5484489926434;4667.743274119922;5211.296474975878;5370.167624018283;5370.3287089113865;4594.635096658171;4701.882452938678;5266.683998960065;5273.1035723926925;5302.628815982883;3811.942820857689;4028.113814960704;4035.4955630546183;4041.2725709372303;4066.6949978751563;3810.504634397538;3899.902502437433;3940.960590394088;4031.5565287818317;4036.374361973884;3458.896233112998;3950.960490395102;3959.3467077932105;3967.940480892789;3975.3043217436975;3293.637699853014;3532.275883443888;3750.774953502799;3967.583403742623;3970;3420.486926960976;3423.9144021399416;3433.9828300858585;3443.9311213775836;3445.500402441657;4270.462633451954;4566.748828814414;4702.835400760991;4854.757262136879;5117.513836185556;4515.600163949153;4516.23224051912;4519.209138400766;4526.130158714318;4540.9772951135365;5495.8351249462185;5515.834524964257;5518.834434966958;5556.583256255797;5566.944330556683;3416.3167366526795;3601.171730501973;3736.4965473132793;3767.397216445383;3768.811559422018;5405.540454109373;5683.232763576905;5764;5802.709864506758;5807.941920580783;3246.480563109891;3819.3385877143533;3822.8340356191075;3830;3861.8841434757;3745.6628903398823;3829.329867273216;3903.726739128234;3909.550401703784;3914.3345631242187;3993.221321842213;4197.538270790211;4373.759443230653;4383.846565370197;4501.549845015472;4690.6012988895645;5522.530584900329;5552.833414997556;5564.693941833157;5576.386597474275;1099.4777480696764;1275.6300672804969;1304.2978912519063;1304.589054447846;1305.1973036582433;778.6451574260745;789.3685051958411;813.3371302388534;816.9714060007872;818.3862103422433;3784.1023745542134;4359.474184035562;4390.165868485042;4444.644428445717;4447.155040542287;4248.426462427595;4727.5653038685105;4746.311784791186;4787.3776409066595;4804.231322988305;3811;3856.9035774105873;4148.2947898857265;4150.592656259362;4310.935335969963;2331.135091926452;2391.3901955001365;2488.0545392751;2504.423982484039;2518.055729101587;4212.620864122183;4356.869293921124;4672.813087476531;4857.906970931583;4872.902541949141;4398.208322501916;4431.534688857688;4781.52184781526;4790.856274311706;4835.516448355136;4214.452121224283;4314;4862.756862156878;4888.902221955612;4891.559759621651;4390.495093064211;4535.324158746355;4586.380838586748;4727.57451829337;4770.785314660918;4148.377743338523;4650.465196502446;4677.672562920563;4687.140844085037;4729.716217026989;4374.715643483163;4534.825847286543;4600.3099535070005;4938.8765280868265;4960.280759289811;3315.9171020724675;3323;3334.76656634043;3347.3807345641135;3353.7652364334263;3954.525456945185;4297.935530967101;4556.840510582114;4569.337446070234;4785.736784476887;4127.607877251657;4264.758783324633;4802.807887684454;4924.532169443897;5184.766685499086;4469.7318160910445;5544.833654990357;5554.333919718639;5563.5271001963665;5584.972075139598;5453.481919217668;5456.907319510367;5465.808696695596;5468.808591699271;5535.5848311376;4665.460398068697;5217.0870097733505;5283.418823929442;5640.548756099584;5707.714614269353;4907.018596280829;5116.7953281869795;5556.694381809039;5561.610687252015;5588.944110558842 03:34:18 INFO - PROCESS | 1651 | |5;yui.html;705.2735682247286;791.9960400197998;796.350973956226;806.8910697055895;816.9754907352782;15606.843931560696;16529.090900000494;16542.503724888244;16593.419230326926;16648.66702665946;14701.55895323142;15342.386304547832;15574.766378504331;15707.764383534257;16475.83524164758;866.5623859950732;877.6401675313123;891.269159289383;892.1435421994893;892.7009451833643;688.41140824595;706.826827427281;851.7827953871754;871.6687658689689;878.7056336127405;911.8723378726984;923.6305477808896;926.7683079230193;928.0951072704127;929.995350023249;920.0845159066705;921.5208091792231;922.3589605224372;922.6032805893464;931.0410277414308;491.85736136520364;499.20127795526867;683.893996430554;685.9691313890887;686.1012074182787;12649.683757906034;12855.87144128556;12858.357082145949;15261;15506.689866202612;13982.860171398257;14280.727301742443;14365.066270692372;14508.1295122293;14534.636634084232;11382.544698212061;11823.34971576563;11828.349440780754;11853.111016673784;12115.878841211563;3788.886333410002;3860.3823388258024;3888.9222215555815;3939.960600393988;3964.3657014877767;104597;108443;110821.22946926391;112400;113898;10820;10853.945730271456;10981.12151027916;10997.285176463503;11013.614523491638;21505.462363441038;21544.353669389944;21636.35090947274;21691.89154054251;21699.674504882438;7012.5974805039195;7060.399866011447;7204.639768011579;7207.423406127497;7461.1419686735635;4185.689146652775;4231.661467082626;4424.225760491901;4438.511763705989;4445.977770111129;3533.293341331744;3678.393065144221;3680.3375392429084;3685.447182922583;3699.741018128759;625.4902254662436;633.8985762278013;655.1973832055694;664.9534532582769;669.2738378858895;521.3665396543219;590.4833270887973;613.7729040255134;622.4366947912147;649.078308801503;9377.437353758796;9505.892658066577;9603;9849.261305402124;9868.506574671237;638.2118084166051;654.1332734127301;679.5817040287362;681.8987335453207;685.9862802743917;4498.572635599613;4712.481627021025;4717.481077081518;4732.810687572527;4757.6193904488255;102705;135978;154713.67929481066;164522.1773891123;169305;130956;139784;140605.1878962415;141454;144863;115786.42106789412;116507;116873.41563292129;118360;118842;8648.82702345937;9133.680321188727;9170.403923744936;9194.402363846328;9211.677591284273;59382.70308648429;61416.69291653513;61997.690011549654;62611;64261;94778.05221947968;95158;97429;97975;102242;11463.828042579535;11725.941370293094;11747.001504872182;12042.096842736655;12199.963003144832;12339.197952133083;12799.616011519669;12945.158564693265;13151;13732;11983.400829958642;12088.697782555506;12356.443960022001;12374.75250494967;12468.563600273947;10665.786684266115;11657.242279252161;11844.348560828892;12218.327991960528;12296.569620063256;11802.468888899848;11975.281483110693;12052.09609279325;12183.878161218274;12640.936795315965;8480.61837217339;9964.800703985735;10247.538860751136;10399.480025998519;10763.031327180592;10102.646407376;10361.63734269297;10529.473526323807;10582.259241852997;10625.787484250426 03:34:18 INFO - PROCESS | 1651 | __end_tp_report 03:34:18 INFO - PROCESS | 1651 | __start_cc_report 03:34:18 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1354 03:34:18 INFO - PROCESS | 1651 | __end_cc_report 03:34:18 INFO - PROCESS | 1651 | __startTimestamp1474972458907__endTimestamp 03:34:18 INFO - PROCESS | 1651 | 03:34:18 INFO - PROCESS | 1651 | ------- Summary: start ------- 03:34:18 INFO - PROCESS | 1651 | Number of tests: 6 03:34:18 INFO - PROCESS | 1651 | 03:34:18 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5830.05 Median:6124.20 stddev:666.08 (10.9%) stddev-sans-first:639.22 03:34:18 INFO - PROCESS | 1651 | Values: 3355.8 3372.3 3397.9 3406.5 3447.0 4743.5 5766.7 5790.9 5820.4 5840.6 5766.2 5833.9 5838.6 5842.4 5857.9 5262.4 5300.3 5322.0 5347.6 5361.7 5204.9 5243.6 5269.7 5328.5 5377.4 5318.6 5325.5 5338.3 5342.8 5349.8 5315.2 5322.7 5331.0 5365.2 5385.9 5275.8 5322.2 5323.9 5328.4 5332.9 5724.2 5755.2 5756.3 5881.9 5884.9 6228.5 6279.3 6301.4 6359.0 6378.0 6247.4 6323.4 6325.7 6330.1 6337.7 5807.4 5834.7 5952.0 5962.0 5975.4 6281.8 6294.6 6401.7 6424.2 6431.7 6279.4 6285.3 6294.7 6297.4 6302.9 6186.7 6336.7 6339.0 6345.9 6361.9 6145.6 6205.4 6234.7 6283.4 6301.5 6339.0 6349.5 6349.5 6357.8 6367.3 4972.6 5017.7 5024.5 5031.5 5056.7 4444.9 4449.8 4493.1 4499.1 4529.4 5830.1 5888.5 5894.9 5919.4 5970.1 5204.6 6315.9 6330.0 6335.3 6337.2 4767.6 5870.6 5891.3 5909.8 5912.7 4656.2 5427.6 5436.5 5498.4 5499.6 6368.4 6457.4 6466.7 6466.8 6481.7 6338.7 6353.0 6353.5 6366.9 6371.4 6254.1 6328.5 6360.2 6403.3 6455.7 6246.7 6291.7 6321.3 6329.8 6339.9 6335.0 6340.8 6347.6 6362.2 6364.9 6087.1 6124.2 6142.4 6266.2 6268.7 6159.1 6183.4 6234.8 6274.6 6280.7 6132.3 6136.9 6147.6 6153.3 6153.3 6112.9 6217.7 6220.5 6262.9 6263.3 5704.5 6054.0 6091.2 6104.1 6141.4 03:34:18 INFO - PROCESS | 1651 | 03:34:18 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:72185.01 Median:20856.63 stddev:159063.22 (762.7%) stddev-sans-first:159418.43 03:34:18 INFO - PROCESS | 1651 | Values: 522.6 525.1 531.9 535.9 551.0 24011.8 41203.6 42571.9 42603.0 42779.0 41642.6 43455.3 43757.6 43765.6 43906.7 9096.2 9736.4 9740.3 9756.0 9759.8 8733.7 8893.8 11839.3 12030.2 12060.2 12028.7 12105.9 12107.7 12108.6 12127.3 11994.3 12075.9 12076.3 12080.0 12086.6 11785.4 11881.4 11893.2 11895.0 11897.8 30890.5 40276.0 40534.0 40664.0 40720.2 3269.8 3485.2 3718.2 3920.8 3982.2 29677.4 29691.4 29751.6 31573.7 31638.7 3133.5 3216.6 3223.5 3400.4 3400.8 465096.0 469634.0 470815.0 473217.0 474211.0 59484.4 60038.1 60051.4 60145.7 60146.7 62491.0 62603.7 62623.7 62720.4 62789.4 15702.5 15846.7 16083.4 16094.7 16095.4 10990.9 11254.2 12207.8 12574.0 12574.6 13312.5 13389.2 13407.5 13455.7 15621.5 5942.8 6556.9 6590.2 6633.5 6673.0 895.8 920.6 1002.7 1030.2 1032.1 29423.4 29516.9 29947.1 30387.2 30920.0 1065.3 1066.8 1091.9 1140.6 1234.4 15035.6 15296.5 15376.7 15463.5 15922.9 646379.0 652004.0 654660.0 657134.0 657879.0 57835.4 57936.4 57955.0 57957.0 58093.7 1229.2 1270.4 1274.0 1373.9 1402.2 29659.7 32620.0 32818.8 33155.3 33346.5 54992.2 56629.0 56651.0 59284.0 59443.0 634530.0 640844.0 642508.0 644894.0 645718.0 25719.7 25771.6 26152.3 26379.1 26490.9 47281.5 47450.5 47605.3 47813.6 48078.8 37995.1 38780.8 39327.8 40274.4 40593.0 38747.4 39005.8 39124.6 40210.4 40406.8 38068.0 38655.8 38720.0 38914.8 40210.6 29015.0 32104.0 34660.0 34720.7 35201.3 25381.6 25833.7 25849.7 25951.6 26161.6 03:34:18 INFO - PROCESS | 1651 | 03:34:18 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:34818.19 Median:383.16 stddev:102144.79 (26658.2%) stddev-sans-first:102398.55 03:34:18 INFO - PROCESS | 1651 | Values: 354.4 371.4 379.6 386.7 404.5 14940.0 15220.7 17164.7 20637.6 21008.5 20309.7 20748.5 20897.7 21051.7 21157.3 5745.7 5787.5 5944.6 6036.4 6045.5 5751.4 5936.3 5939.6 5941.9 5943.3 4097.5 4174.3 5889.5 6418.8 6492.2 5177.2 6577.5 6596.8 6600.6 6604.0 5782.6 5894.2 5896.6 5896.9 5903.3 12851.4 14532.9 21126.4 25019.7 25265.7 2013.7 2368.2 2455.2 2668.3 2859.2 8172.3 9410.5 9595.4 10033.3 10334.9 1695.1 1803.7 1842.3 1844.3 1850.8 118018.0 119828.6 130078.0 134121.7 134383.0 11524.1 11566.6 11642.1 11685.4 11780.1 14755.8 14763.7 14779.7 14794.7 14799.0 8192.8 8412.5 8416.0 8464.0 8489.2 8245.5 8277.3 8297.9 8426.9 8472.5 4073.9 4308.8 4463.2 4519.7 4624.6 1629.6 1646.8 1791.7 1932.9 1943.6 898.1 934.7 947.2 956.7 1011.2 20105.7 21457.9 21551.1 21552.7 21680.0 917.1 924.2 926.3 931.6 947.4 9465.5 10518.3 11293.8 11413.8 11463.5 578880.0 606961.0 619989.9 630597.0 634376.0 74054.0 78861.0 86351.6 102777.0 138909.0 882.3 922.3 935.3 937.7 938.2 18948.5 19821.0 19994.0 20026.6 20034.5 54028.5 55416.0 55813.3 57973.0 58071.0 78730.6 80413.0 82231.1 82821.0 83570.0 8029.6 8158.0 8194.0 8211.4 8244.3 12210.7 12643.2 12850.3 12987.5 13037.5 10715.9 10993.6 10993.7 11035.4 11273.4 10787.5 10869.3 10871.8 10899.6 11022.8 10128.1 10890.5 11034.6 11376.3 11565.5 6979.6 7159.4 7261.4 7918.7 8372.0 9486.1 10843.3 10868.9 10991.8 11207.3 03:34:18 INFO - PROCESS | 1651 | 03:34:18 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5793.28 Median:4951.02 stddev:3261.82 (65.9%) stddev-sans-first:3255.00 03:34:18 INFO - PROCESS | 1651 | Values: 1499.1 1514.3 1727.4 1877.4 1913.8 8562.6 9044.4 9044.5 9053.7 9074.4 7970.1 8140.4 8173.6 8663.0 8848.4 2322.5 2364.7 2368.0 2372.4 2373.9 2315.2 2333.6 2354.1 2358.8 2361.5 2086.3 2148.5 2154.1 2160.7 2163.5 2142.5 2319.9 2375.6 2379.5 2385.7 2349.4 2355.6 2359.4 2365.6 2380.4 8752.9 8967.7 8979.7 8980.4 8986.1 5189.4 5323.4 5340.8 5343.0 5344.7 3455.1 3534.4 3597.7 3612.1 3613.2 1035.7 1062.6 1084.6 1086.3 1096.9 11564.1 11574.3 11583.7 11588.3 11613.8 3760.5 4670.1 4820.5 4830.4 4838.5 9930.8 9936.0 9951.1 9957.5 9984.6 4563.5 5348.6 5353.4 5353.5 5354.8 4754.5 4832.8 4888.3 4900.6 4904.9 3983.9 4008.4 4029.1 4070.2 4099.4 1285.9 1286.3 1288.9 1301.3 1306.3 799.6 810.0 892.9 929.8 941.3 5906.3 5908.9 6021.5 6026.2 6238.0 908.3 909.6 914.3 934.2 1009.5 3940.7 4063.5 4106.9 4150.4 4206.6 10845.8 11055.1 11138.4 11150.5 11202.0 11078.4 11092.0 11096.0 11097.6 11105.4 7872.2 8177.2 8245.3 8374.7 8380.7 5777.3 6116.5 6130.2 6137.1 6207.3 9205.9 10374.5 10379.9 10380.9 10394.3 9950.5 10033.4 10280.7 10470.1 10497.4 7564.6 7817.9 7826.9 7839.3 7854.0 8364.1 8392.7 8414.9 8479.6 8490.4 7575.5 7655.1 7661.7 7666.7 7696.4 7458.0 7486.4 7522.7 7569.8 7596.0 7121.0 7134.9 7235.1 7237.2 7242.2 4933.1 5044.5 5140.3 5193.8 5311.2 4968.9 5076.0 5158.6 5245.2 5286.2 03:34:18 INFO - PROCESS | 1651 | 03:34:18 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4157.35 Median:4485.64 stddev:1259.99 (28.1%) stddev-sans-first:1229.57 03:34:18 INFO - PROCESS | 1651 | Values: 286.4 303.0 303.4 311.4 315.8 3830.5 4667.7 5211.3 5370.2 5370.3 4594.6 4701.9 5266.7 5273.1 5302.6 3811.9 4028.1 4035.5 4041.3 4066.7 3810.5 3899.9 3941.0 4031.6 4036.4 3458.9 3951.0 3959.3 3967.9 3975.3 3293.6 3532.3 3750.8 3967.6 3970.0 3420.5 3423.9 3434.0 3443.9 3445.5 4270.5 4566.7 4702.8 4854.8 5117.5 4515.6 4516.2 4519.2 4526.1 4541.0 5495.8 5515.8 5518.8 5556.6 5566.9 3416.3 3601.2 3736.5 3767.4 3768.8 5405.5 5683.2 5764.0 5802.7 5807.9 3246.5 3819.3 3822.8 3830.0 3861.9 3745.7 3829.3 3903.7 3909.6 3914.3 3993.2 4197.5 4373.8 4383.8 4501.5 4690.6 5522.5 5552.8 5564.7 5576.4 1099.5 1275.6 1304.3 1304.6 1305.2 778.6 789.4 813.3 817.0 818.4 3784.1 4359.5 4390.2 4444.6 4447.2 4248.4 4727.6 4746.3 4787.4 4804.2 3811.0 3856.9 4148.3 4150.6 4310.9 2331.1 2391.4 2488.1 2504.4 2518.1 4212.6 4356.9 4672.8 4857.9 4872.9 4398.2 4431.5 4781.5 4790.9 4835.5 4214.5 4314.0 4862.8 4888.9 4891.6 4390.5 4535.3 4586.4 4727.6 4770.8 4148.4 4650.5 4677.7 4687.1 4729.7 4374.7 4534.8 4600.3 4938.9 4960.3 3315.9 3323.0 3334.8 3347.4 3353.8 3954.5 4297.9 4556.8 4569.3 4785.7 4127.6 4264.8 4802.8 4924.5 5184.8 4469.7 5544.8 5554.3 5563.5 5585.0 5453.5 5456.9 5465.8 5468.8 5535.6 4665.5 5217.1 5283.4 5640.5 5707.7 4907.0 5116.8 5556.7 5561.6 5588.9 03:34:18 INFO - PROCESS | 1651 | 03:34:18 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:25190.72 Median:3679.37 stddev:41110.74 (1117.3%) stddev-sans-first:41184.96 03:34:18 INFO - PROCESS | 1651 | Values: 705.3 792.0 796.4 806.9 817.0 15606.8 16529.1 16542.5 16593.4 16648.7 14701.6 15342.4 15574.8 15707.8 16475.8 866.6 877.6 891.3 892.1 892.7 688.4 706.8 851.8 871.7 878.7 911.9 923.6 926.8 928.1 930.0 920.1 921.5 922.4 922.6 931.0 491.9 499.2 683.9 686.0 686.1 12649.7 12855.9 12858.4 15261.0 15506.7 13982.9 14280.7 14365.1 14508.1 14534.6 11382.5 11823.3 11828.3 11853.1 12115.9 3788.9 3860.4 3888.9 3940.0 3964.4 104597.0 108443.0 110821.2 112400.0 113898.0 10820.0 10853.9 10981.1 10997.3 11013.6 21505.5 21544.4 21636.4 21691.9 21699.7 7012.6 7060.4 7204.6 7207.4 7461.1 4185.7 4231.7 4424.2 4438.5 4446.0 3533.3 3678.4 3680.3 3685.4 3699.7 625.5 633.9 655.2 665.0 669.3 521.4 590.5 613.8 622.4 649.1 9377.4 9505.9 9603.0 9849.3 9868.5 638.2 654.1 679.6 681.9 686.0 4498.6 4712.5 4717.5 4732.8 4757.6 102705.0 135978.0 154713.7 164522.2 169305.0 130956.0 139784.0 140605.2 141454.0 144863.0 115786.4 116507.0 116873.4 118360.0 118842.0 8648.8 9133.7 9170.4 9194.4 9211.7 59382.7 61416.7 61997.7 62611.0 64261.0 94778.1 95158.0 97429.0 97975.0 102242.0 11463.8 11725.9 11747.0 12042.1 12200.0 12339.2 12799.6 12945.2 13151.0 13732.0 11983.4 12088.7 12356.4 12374.8 12468.6 10665.8 11657.2 11844.3 12218.3 12296.6 11802.5 11975.3 12052.1 12183.9 12640.9 8480.6 9964.8 10247.5 10399.5 10763.0 10102.6 10361.6 10529.5 10582.3 10625.8 03:34:18 INFO - PROCESS | 1651 | -------- Summary: end -------- 03:34:18 INFO - PROCESS | 1651 | 03:34:19 INFO - TEST-INFO | 1651: exit 0 03:34:19 INFO - TEST-OK | dromaeo_css | took 1116955ms 03:34:19 INFO - TEST-START | kraken 03:34:19 INFO - operating with platform_type : mac_ 03:34:19 INFO - Initialising browser for kraken test... 03:34:19 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmp8hswsL/profile http://localhost:49266/getInfo.html) 03:34:21 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 03:34:21 INFO - PROCESS | 1658 | colorDepth:24 03:34:21 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 03:34:21 INFO - PROCESS | 1658 | __metrics 03:34:21 INFO - PROCESS | 1658 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:34:21 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:34:22 INFO - TEST-INFO | 1658: exit 0 03:34:22 INFO - Browser initialized. 03:34:22 INFO - Running cycle 1/1 for kraken test... 03:34:22 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmp8hswsL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:34:34 INFO - PROCESS | 1659 | RSS: Main: 219287552 03:34:34 INFO - PROCESS | 1659 | 03:34:37 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 03:34:38 INFO - PROCESS | 1659 | RSS: Main: 269467648 03:34:38 INFO - PROCESS | 1659 | 03:34:41 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 03:34:41 INFO - PROCESS | 1659 | RSS: Main: 279851008 03:34:41 INFO - PROCESS | 1659 | 03:34:45 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 03:34:45 INFO - PROCESS | 1659 | RSS: Main: 377126912 03:34:45 INFO - PROCESS | 1659 | 03:34:47 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 03:34:48 INFO - PROCESS | 1659 | RSS: Main: 278990848 03:34:48 INFO - PROCESS | 1659 | 03:34:50 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:34:50 INFO - PROCESS | 1659 | RSS: Main: 279638016 03:34:50 INFO - PROCESS | 1659 | 03:34:53 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 03:34:54 INFO - PROCESS | 1659 | RSS: Main: 316665856 03:34:54 INFO - PROCESS | 1659 | 03:34:57 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 03:34:57 INFO - PROCESS | 1659 | RSS: Main: 319598592 03:34:57 INFO - PROCESS | 1659 | 03:35:00 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 03:35:01 INFO - PROCESS | 1659 | RSS: Main: 318300160 03:35:01 INFO - PROCESS | 1659 | 03:35:02 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:35:03 INFO - PROCESS | 1659 | RSS: Main: 289873920 03:35:03 INFO - PROCESS | 1659 | 03:35:05 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:35:06 INFO - PROCESS | 1659 | RSS: Main: 295858176 03:35:06 INFO - PROCESS | 1659 | 03:35:08 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:35:08 INFO - PROCESS | 1659 | RSS: Main: 299524096 03:35:08 INFO - PROCESS | 1659 | 03:35:11 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:35:12 INFO - PROCESS | 1659 | RSS: Main: 313552896 03:35:12 INFO - PROCESS | 1659 | 03:35:15 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:35:16 INFO - PROCESS | 1659 | RSS: Main: 309706752 03:35:16 INFO - PROCESS | 1659 | 03:35:17 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 03:35:18 INFO - PROCESS | 1659 | RSS: Main: 353361920 03:35:18 INFO - PROCESS | 1659 | 03:35:18 INFO - PROCESS | 1659 | __start_tp_report 03:35:18 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 03:35:18 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 03:35:18 INFO - PROCESS | 1659 | |i|pagename|runs| 03:35:18 INFO - PROCESS | 1659 | |0;ai-astar;115;114;116;115;114;114;114;115;114;115 03:35:18 INFO - PROCESS | 1659 | |1;audio-beat-detection;142;109;108;144;110;110;117;140;174;112 03:35:18 INFO - PROCESS | 1659 | |2;audio-dft;185;181;185;183;183;184;185;184;183;184 03:35:18 INFO - PROCESS | 1659 | |3;audio-fft;83;60;59;89;61;59;59;58;85;81 03:35:18 INFO - PROCESS | 1659 | |4;audio-oscillator;90;71;93;70;67;70;91;68;68;93 03:35:18 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;88;85;88;85;87;85;89;85;89;84 03:35:18 INFO - PROCESS | 1659 | |6;imaging-darkroom;94;93;94;109;152;126;94;93;94;94 03:35:18 INFO - PROCESS | 1659 | |7;imaging-desaturate;86;84;91;85;86;86;85;86;85;86 03:35:18 INFO - PROCESS | 1659 | |8;json-parse-financial;56;54;53;53;55;58;58;57;57;57 03:35:18 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;66;81;105;104;114;70;69;70;69;71 03:35:18 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;80;88;83;86;86;81;85;81;89;90 03:35:18 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;140;155;149;146;135;133;148;154;188;143 03:35:18 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;148;196;223;210;168;164;164;163;162;219 03:35:18 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;66;67;66;65;67;67;66;66;72;70 03:35:18 INFO - PROCESS | 1659 | __end_tp_report 03:35:18 INFO - PROCESS | 1659 | __start_cc_report 03:35:18 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,2003 03:35:18 INFO - PROCESS | 1659 | __end_cc_report 03:35:18 INFO - PROCESS | 1659 | __startTimestamp1474972518152__endTimestamp 03:35:18 INFO - PROCESS | 1659 | 03:35:18 INFO - PROCESS | 1659 | ------- Summary: start ------- 03:35:18 INFO - PROCESS | 1659 | Number of tests: 14 03:35:18 INFO - PROCESS | 1659 | 03:35:18 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 03:35:18 INFO - PROCESS | 1659 | Values: 115.0 114.0 116.0 115.0 114.0 114.0 114.0 115.0 114.0 115.0 03:35:18 INFO - PROCESS | 1659 | 03:35:18 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:126.60 Median:128.50 stddev:22.31 (17.4%) stddev-sans-first:22.95 03:35:18 INFO - PROCESS | 1659 | Values: 142.0 109.0 108.0 144.0 110.0 110.0 117.0 140.0 174.0 112.0 03:35:18 INFO - PROCESS | 1659 | 03:35:18 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.00 stddev:1.25 (0.7%) stddev-sans-first:1.24 03:35:18 INFO - PROCESS | 1659 | Values: 185.0 181.0 185.0 183.0 183.0 184.0 185.0 184.0 183.0 184.0 03:35:18 INFO - PROCESS | 1659 | 03:35:18 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:69.40 Median:71.00 stddev:13.17 (18.5%) stddev-sans-first:13.01 03:35:18 INFO - PROCESS | 1659 | Values: 83.0 60.0 59.0 89.0 61.0 59.0 59.0 58.0 85.0 81.0 03:35:18 INFO - PROCESS | 1659 | 03:35:18 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:80.50 stddev:11.84 (14.7%) stddev-sans-first:11.74 03:35:18 INFO - PROCESS | 1659 | Values: 90.0 71.0 93.0 70.0 67.0 70.0 91.0 68.0 68.0 93.0 03:35:18 INFO - PROCESS | 1659 | 03:35:18 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:87.50 stddev:1.90 (2.2%) stddev-sans-first:1.94 03:35:18 INFO - PROCESS | 1659 | Values: 88.0 85.0 88.0 85.0 87.0 85.0 89.0 85.0 89.0 84.0 03:35:18 INFO - PROCESS | 1659 | 03:35:18 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:104.30 Median:94.00 stddev:19.87 (21.1%) stddev-sans-first:20.73 03:35:18 INFO - PROCESS | 1659 | Values: 94.0 93.0 94.0 109.0 152.0 126.0 94.0 93.0 94.0 94.0 03:35:18 INFO - PROCESS | 1659 | 03:35:18 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.00 stddev:1.89 (2.2%) stddev-sans-first:2.00 03:35:18 INFO - PROCESS | 1659 | Values: 86.0 84.0 91.0 85.0 86.0 86.0 85.0 86.0 85.0 86.0 03:35:18 INFO - PROCESS | 1659 | 03:35:18 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:57.00 stddev:1.93 (3.4%) stddev-sans-first:2.05 03:35:18 INFO - PROCESS | 1659 | Values: 56.0 54.0 53.0 53.0 55.0 58.0 58.0 57.0 57.0 57.0 03:35:18 INFO - PROCESS | 1659 | 03:35:18 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:81.90 Median:69.50 stddev:18.38 (26.4%) stddev-sans-first:18.57 03:35:18 INFO - PROCESS | 1659 | Values: 66.0 81.0 105.0 104.0 114.0 70.0 69.0 70.0 69.0 71.0 03:35:18 INFO - PROCESS | 1659 | 03:35:18 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:86.00 stddev:3.54 (4.1%) stddev-sans-first:3.28 03:35:18 INFO - PROCESS | 1659 | Values: 80.0 88.0 83.0 86.0 86.0 81.0 85.0 81.0 89.0 90.0 03:35:18 INFO - PROCESS | 1659 | 03:35:18 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:149.10 Median:148.50 stddev:15.50 (10.4%) stddev-sans-first:16.08 03:35:18 INFO - PROCESS | 1659 | Values: 140.0 155.0 149.0 146.0 135.0 133.0 148.0 154.0 188.0 143.0 03:35:18 INFO - PROCESS | 1659 | 03:35:18 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.70 Median:182.00 stddev:27.47 (15.1%) stddev-sans-first:26.29 03:35:18 INFO - PROCESS | 1659 | Values: 148.0 196.0 223.0 210.0 168.0 164.0 164.0 163.0 162.0 219.0 03:35:18 INFO - PROCESS | 1659 | 03:35:18 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:2.15 (3.2%) stddev-sans-first:2.24 03:35:18 INFO - PROCESS | 1659 | Values: 66.0 67.0 66.0 65.0 67.0 67.0 66.0 66.0 72.0 70.0 03:35:18 INFO - PROCESS | 1659 | -------- Summary: end -------- 03:35:18 INFO - PROCESS | 1659 | 03:35:19 INFO - TEST-INFO | 1659: exit 0 03:35:19 INFO - TEST-OK | kraken | took 59554ms 03:35:19 INFO - SUITE-END | took 1176s 03:35:19 INFO - Completed test suite (00:19:36) 03:35:19 INFO - javascript benchmark 03:35:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3355.8154301513414, 3372.258103217292, 3397.9490307645387, 3406.5230867678515, 3447.03483024753, 4743.4545027321865, 5766.654000759957, 5790.942090579093, 5820.359760426355, 5840.620359676624, 5766.1639062335935, 5833.854153646161, 5838.649681019131, 5842.357340692521, 5857.941420585793, 5262.42308804611, 5300.25796388504, 5321.988822123803, 5347.598930080259, 5361.705106219157, 5204.895902081956, 5243.554297884684, 5269.683818970855, 5328.49379308965, 5377.354717433894, 5318.574514038867, 5325.467453254682, 5338.3060202173665, 5342.839714808562, 5349.786008559653, 5315.229291752674, 5322.7072511011875, 5330.973345133289, 5365.195220716884, 5385.865353366158, 5275.815346462894, 5322.20166974953, 5323.893522129574, 5328.3605967284175, 5332.92000619991, 5724.16999535065, 5755.165501002373, 5756.338021127582, 5881.911771323434, 5884.941150588482, 6228.470580000705, 6279.309275979638, 6301.40136687014, 6359.046143078529, 6378.0, 6247.375262473762, 6323.399277068671, 6325.746970121189, 6330.050492426127, 6337.714802833883, 5807.361190269067, 5834.679092649945, 5952.0476723724, 5961.970190149108, 5975.402459754033, 6281.78013769525, 6294.559380843389, 6401.743930242831, 6424.196975378078, 6431.710573024132, 6279.3720627937755, 6285.308616052231, 6294.685265736786, 6297.370262973757, 6302.936970630327, 6186.721597528122, 6336.651484168415, 6338.968305158537, 6345.904811427832, 6361.8727625448155, 6145.600535965148, 6205.441510264098, 6234.719437625317, 6283.434490895841, 6301.495880329563, 6338.968305158444, 6349.492040636738, 6349.52378571609, 6357.777477788348, 6367.299597044322, 4972.57733092684, 5017.698938063655, 5024.497550244946, 5031.52200540948, 5056.747162641853, 4444.933326000112, 4449.822007119744, 4493.123840851003, 4499.055198408306, 4529.365888775574, 5830.125481177773, 5888.5289176865745, 5894.941050589525, 5919.378465261086, 5970.134330522137, 5204.635675502678, 6315.905261421082, 6330.0, 6335.303116657164, 6337.207849018872, 4767.570918617341, 5870.647761134345, 5891.293044834647, 5909.763609455659, 5912.704364781744, 4656.161890859677, 5427.6472029317965, 5436.537894278951, 5498.395176530578, 5499.560035197174, 6368.42684158428, 6457.4188323049275, 6466.708998095097, 6466.7736629219635, 6481.740730370732, 6338.651374174465, 6352.968235158794, 6353.491720662243, 6366.936330636634, 6371.39471750183, 6254.124422580933, 6328.493720502441, 6360.236771587439, 6403.263624683221, 6455.67721613908, 6246.6876656167915, 6291.748330066746, 6321.33625969285, 6329.778457753957, 6339.873202536016, 6335.018072198816, 6340.841478963062, 6347.619142851444, 6362.204724409449, 6364.904526432015, 6087.086936959491, 6124.203853499017, 6142.355052719578, 6266.248050234001, 6268.686565671789, 6159.1069294951085, 6183.3816618337805, 6234.844128896814, 6274.560780745304, 6280.654563999024, 6132.325444201045, 6136.938630613637, 6147.631142131487, 6153.261608606996, 6153.261608606996, 6112.908306375497, 6217.658028808459, 6220.533459990428, 6262.937370626418, 6263.311035785969, 5704.515116215002, 6053.969730151321, 6091.208142941389, 6104.114903338902, 6141.3551577085545], "value": 5787.269759750756, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.5845452864971, 525.1413938211025, 531.9335083114611, 535.9169328754042, 550.9586780991422, 24011.75988240117, 41203.58796412035, 42571.93570160747, 42602.99999999996, 42779.0, 41642.58357416425, 43455.34816977748, 43757.56242437575, 43765.56234437654, 43906.682799515984, 9096.22682072023, 9736.415815051085, 9740.269479789009, 9756.024397560259, 9759.756006099833, 8733.737987860375, 8893.77765555863, 11839.28964262147, 12030.218035827644, 12060.216085954386, 12028.69928251792, 12105.878941210563, 12107.697307567294, 12108.636740897788, 12127.332996685178, 11994.280343179436, 12075.852793984557, 12076.335801530913, 12080.0, 12086.576969806103, 11785.351805650685, 11881.40592970348, 11893.226940248942, 11895.04839612829, 11897.762044759056, 30890.536641950388, 40276.0, 40534.0, 40664.0, 40720.185596287905, 3269.7547683923563, 3485.233248685285, 3718.2191739734417, 3920.7843568603716, 3982.2234664240486, 29677.40645187084, 29691.406171876442, 29751.5537266939, 31573.684263157535, 31638.683613163805, 3133.4673105572106, 3216.5979252593424, 3223.5003574446, 3400.387930172593, 3400.778949368308, 465096.0, 469634.0, 470815.0, 473217.0, 474211.0, 59484.40515594788, 60038.099428508605, 60051.39948600545, 60145.699271504236, 60146.69926650339, 62491.0, 62603.68698156571, 62623.6868815653, 62720.372796271455, 62789.37210627835, 15702.528924132293, 15846.683066338608, 16083.437079702388, 16094.678106437806, 16095.356185752438, 10990.890091099147, 11254.155938304497, 12207.755844883053, 12574.0, 12574.559890403974, 13312.534061307808, 13389.19664820114, 13407.530736424178, 13455.730885382238, 15621.453249136226, 5942.821715348547, 6556.901646475307, 6590.176227971504, 6633.535652504278, 6672.96663516689, 895.8253140637513, 920.6133423961952, 1002.7292630989592, 1030.2427715629008, 1032.0608246495653, 29423.411531769674, 29516.852415738213, 29947.101586952427, 30387.2403189922, 30920.0, 1065.3128731967993, 1066.7785385733448, 1091.901728844392, 1140.6235942139074, 1234.4444999750149, 15035.624109397133, 15296.541103766906, 15376.692466150615, 15463.458778942682, 15922.92038539823, 646379.0, 652004.0, 654660.0, 657134.0, 657879.0, 57835.42164578385, 57936.42063579395, 57955.0, 57957.0, 58093.67625294941, 1229.2133034857698, 1270.4283072617175, 1274.0444666500125, 1373.9313034348443, 1402.200745575033, 29659.68468805705, 32620.0, 32818.83590582032, 33155.33689326248, 33346.499802503466, 54992.17511737247, 56629.0, 56651.0, 59284.0, 59443.0, 634530.0, 640844.0, 642508.0, 644894.0, 645718.0, 25719.742802571735, 25771.613425798252, 26152.34619134537, 26379.076732315043, 26490.86754566215, 47281.527184729086, 47450.52549474599, 47605.28592071052, 47813.56559303227, 48078.75960620175, 37995.05012374602, 38780.80609597047, 39327.80336098301, 40274.395884061174, 40593.0, 38747.41878871763, 39005.804970976096, 39124.60430220072, 40210.39684404678, 40406.79796600998, 38068.0, 38655.80672096734, 38720.0, 38914.83255502339, 40210.597894020684, 29015.0, 32104.0, 34660.0, 34720.652793471745, 35201.29597408089, 25381.61927571051, 25833.741662583132, 25849.741502584733, 25951.610725839506, 26161.60757588676], "value": 20365.031253180066, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.397524208845, 371.4409813231087, 379.6052105809958, 386.7238114223064, 404.4701441112143, 14940.028898121627, 15220.695586088272, 17164.65670686587, 20637.587248255062, 21008.474788130305, 20309.695354569692, 20748.48128796777, 20897.686534701992, 21051.684224736604, 21157.259495917646, 5745.741441635126, 5787.450192231731, 5944.554158438113, 6036.396360363972, 6045.516358691316, 5751.367349591542, 5936.347001829795, 5939.613925094876, 5941.910871336933, 5943.316518600352, 4097.528784189812, 4174.276543332759, 5889.528837692996, 6418.839529011789, 6492.15601971743, 5177.223416487519, 6577.539572229945, 6596.835079123012, 6600.570962887397, 6604.042413850013, 5782.624129431573, 5894.17481552583, 5896.557758168112, 5896.941030589682, 5903.291605007384, 12851.421686024058, 14532.927335363256, 21126.366209013755, 25019.749802501923, 25265.747342526523, 2013.6677448221026, 2368.2066507719933, 2455.2143314139485, 2668.310948230001, 2859.1565488181036, 8172.305354044914, 9410.482423466707, 9595.42427454355, 10033.297669163161, 10334.948325258325, 1695.0846542866836, 1803.7023891057959, 1842.3459671816447, 1844.317602487075, 1850.80566540514, 118018.0, 119828.57427617499, 130078.0, 134121.6587834119, 134383.0, 11524.078073754079, 11566.595169169206, 11642.068634509218, 11685.357305348287, 11780.057595392347, 14755.77866332006, 14763.704725905422, 14779.704405911822, 14794.704105917821, 14799.0, 8192.836143277102, 8412.495250285003, 8416.0, 8463.957680211683, 8489.193526614961, 8245.505269683837, 8277.337812975067, 8297.875531867026, 8426.915730842737, 8472.534010629352, 4073.920411091063, 4308.827646894152, 4463.24124898768, 4519.683622146418, 4624.606908412823, 1629.6496253305359, 1646.777685012532, 1791.6506281275288, 1932.8743631663897, 1943.5529828139606, 898.1377877237925, 934.7195841247734, 947.199616324205, 956.6699488676395, 1011.1556850030161, 20105.698414523795, 21457.927103644754, 21551.137954481957, 21552.676709849366, 21680.0, 917.1149840404042, 924.242121460396, 926.2636204217663, 931.6133804471204, 947.4362754161263, 9465.47939863314, 10518.263721539572, 11293.774124517464, 11413.771724565628, 11463.54145834174, 578880.0, 606961.0, 619989.9000504969, 630597.0, 634376.0, 74054.0, 78861.0, 86351.61962908653, 102777.0, 138909.0, 882.3294296334832, 922.2990527199377, 935.2517985611483, 937.723371605378, 938.1884669760744, 18948.526286842938, 19821.0, 19994.0, 20026.599468010267, 20034.499137521678, 54028.45971540234, 55416.0, 55813.32560023043, 57972.970946016685, 58071.0, 78730.60634696789, 80413.0, 82231.06215830089, 82821.0, 83570.0, 8029.5583742894705, 8158.0, 8194.016717993878, 8211.384146189179, 8244.340452763645, 12210.694732631755, 12643.178193417398, 12850.293233872228, 12987.545435909698, 13037.47850086024, 10715.892841071489, 10993.61522346714, 10993.670189894316, 11035.448227588427, 11273.436328183721, 10787.514561844893, 10869.293495923055, 10871.78256434851, 10899.56401743953, 11022.779544409228, 10128.069206150074, 10890.455477226265, 11034.613788517363, 11376.317420954769, 11565.479553419947, 6979.616121113185, 7159.355657990805, 7261.419086473175, 7918.722844700408, 8372.0, 9486.146246837818, 10843.349399036084, 10868.891311086787, 10991.835122473009, 11207.271527350696], "value": 9408.905066516843, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1499.100539676194, 1514.333693175003, 1727.3608764757041, 1877.3804644467327, 1913.8277555020045, 8562.571871406428, 9044.412113212637, 9044.502552359625, 9053.728388148349, 9074.410163339386, 7970.083440404355, 8140.43016988811, 8173.5504547249875, 8663.003754568226, 8848.42485238459, 2322.4542232575373, 2364.73987861336, 2368.04094341791, 2372.383180373098, 2373.857568545884, 2315.1896836107394, 2333.6032874411308, 2354.0819080558595, 2358.84667496613, 2361.504084142332, 2086.2906611752, 2148.4628842789302, 2154.0952799824113, 2160.6758986152045, 2163.491579478821, 2142.507223338633, 2319.9188028419007, 2375.560521303564, 2379.476515166678, 2385.6779334789753, 2349.4361353275262, 2355.611324131516, 2359.3511784259294, 2365.6215005599192, 2380.369202161429, 8752.8687069694, 8967.730968070968, 8979.730608081769, 8980.416272942302, 8986.14631609996, 5189.351331083614, 5323.387810401776, 5340.759665815009, 5343.0, 5344.732763361855, 3455.1189446690933, 3534.3991521441417, 3597.6762091411897, 3612.0789198754414, 3613.223157021253, 1035.662913545952, 1062.585591619269, 1084.5661735305862, 1086.2721976275914, 1096.9341839489657, 11564.132690048196, 11574.305541667443, 11583.710407239801, 11588.30470171784, 11613.825792613117, 3760.52993375828, 4670.089332580114, 4820.542048505386, 4830.420349558076, 4838.491958344393, 9930.751731206634, 9935.950320248352, 9951.104400603981, 9957.452340121217, 9984.550695218733, 4563.452385713736, 5348.625596208306, 5353.437889021675, 5353.491418315254, 5354.785808567692, 4754.548317909793, 4832.830850920201, 4888.340074090023, 4900.583450406684, 4904.852854414374, 3983.8605648802154, 4008.376607473978, 4029.1135950090934, 4070.2266569351727, 4099.426080348694, 1285.9357032148355, 1286.279683377293, 1288.8968882489378, 1301.2777908260816, 1306.3337697774205, 799.6041959230218, 809.9915605071724, 892.9330300227509, 929.8419268724198, 941.317544780029, 5906.26171728534, 5908.940910590925, 6021.54838387114, 6026.246719160105, 6237.95111523975, 908.2824568590739, 909.60432211988, 914.277720600718, 934.1825902335456, 1009.4700282351824, 3940.665043471337, 4063.5326937401987, 4106.926481861546, 4150.418941348214, 4206.642435392964, 10845.783084338427, 11055.11559075272, 11138.387388693538, 11150.49822757978, 11202.0, 11078.390688512209, 11092.0, 11096.0, 11097.55609775616, 11105.38920359388, 7872.212778722196, 8177.182281771894, 8245.340372770164, 8374.706885258987, 8380.664773409117, 5777.277840269966, 6116.480099191618, 6130.172426722514, 6137.110119032626, 6207.286162091236, 9205.86191207119, 10374.481275936323, 10379.896201038195, 10380.948095259475, 10394.272400931863, 9950.45272510019, 10033.397996120257, 10280.691579252634, 10470.110040646327, 10497.370157790558, 7564.583947882919, 7817.882731758915, 7826.921730782847, 7839.294463498312, 7854.0, 8364.079951205484, 8392.748217553482, 8414.873776893473, 8479.576021198793, 8490.405671602928, 7575.507592006502, 7655.119661239029, 7661.731839385595, 7666.655000525101, 7696.422768292288, 7458.0, 7486.401087912845, 7522.736704215326, 7569.772906812585, 7596.0, 7121.038659780863, 7134.85730285381, 7235.095613048369, 7237.1677257114, 7242.167150777728, 4933.136701077226, 5044.520770526794, 5140.306058682179, 5193.76628051731, 5311.203319502106, 4968.900621987467, 5075.974620126875, 5158.638895277445, 5245.160774276097, 5286.207068939536], "value": 4637.389492603381, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.435721628392, 302.9621297337833, 303.4053255618985, 311.41298652040905, 315.7884217574225, 3830.5484489926434, 4667.743274119922, 5211.296474975878, 5370.167624018283, 5370.3287089113865, 4594.635096658171, 4701.882452938678, 5266.683998960065, 5273.1035723926925, 5302.628815982883, 3811.942820857689, 4028.113814960704, 4035.4955630546183, 4041.2725709372303, 4066.6949978751563, 3810.504634397538, 3899.902502437433, 3940.960590394088, 4031.5565287818317, 4036.374361973884, 3458.896233112998, 3950.960490395102, 3959.3467077932105, 3967.940480892789, 3975.3043217436975, 3293.637699853014, 3532.275883443888, 3750.774953502799, 3967.583403742623, 3970.0, 3420.486926960976, 3423.9144021399416, 3433.9828300858585, 3443.9311213775836, 3445.500402441657, 4270.462633451954, 4566.748828814414, 4702.835400760991, 4854.757262136879, 5117.513836185556, 4515.600163949153, 4516.23224051912, 4519.209138400766, 4526.130158714318, 4540.9772951135365, 5495.8351249462185, 5515.834524964257, 5518.834434966958, 5556.583256255797, 5566.944330556683, 3416.3167366526795, 3601.171730501973, 3736.4965473132793, 3767.397216445383, 3768.811559422018, 5405.540454109373, 5683.232763576905, 5764.0, 5802.709864506758, 5807.941920580783, 3246.480563109891, 3819.3385877143533, 3822.8340356191075, 3830.0, 3861.8841434757, 3745.6628903398823, 3829.329867273216, 3903.726739128234, 3909.550401703784, 3914.3345631242187, 3993.221321842213, 4197.538270790211, 4373.759443230653, 4383.846565370197, 4501.549845015472, 4690.6012988895645, 5522.530584900329, 5552.833414997556, 5564.693941833157, 5576.386597474275, 1099.4777480696764, 1275.6300672804969, 1304.2978912519063, 1304.589054447846, 1305.1973036582433, 778.6451574260745, 789.3685051958411, 813.3371302388534, 816.9714060007872, 818.3862103422433, 3784.1023745542134, 4359.474184035562, 4390.165868485042, 4444.644428445717, 4447.155040542287, 4248.426462427595, 4727.5653038685105, 4746.311784791186, 4787.3776409066595, 4804.231322988305, 3811.0, 3856.9035774105873, 4148.2947898857265, 4150.592656259362, 4310.935335969963, 2331.135091926452, 2391.3901955001365, 2488.0545392751, 2504.423982484039, 2518.055729101587, 4212.620864122183, 4356.869293921124, 4672.813087476531, 4857.906970931583, 4872.902541949141, 4398.208322501916, 4431.534688857688, 4781.52184781526, 4790.856274311706, 4835.516448355136, 4214.452121224283, 4314.0, 4862.756862156878, 4888.902221955612, 4891.559759621651, 4390.495093064211, 4535.324158746355, 4586.380838586748, 4727.57451829337, 4770.785314660918, 4148.377743338523, 4650.465196502446, 4677.672562920563, 4687.140844085037, 4729.716217026989, 4374.715643483163, 4534.825847286543, 4600.3099535070005, 4938.8765280868265, 4960.280759289811, 3315.9171020724675, 3323.0, 3334.76656634043, 3347.3807345641135, 3353.7652364334263, 3954.525456945185, 4297.935530967101, 4556.840510582114, 4569.337446070234, 4785.736784476887, 4127.607877251657, 4264.758783324633, 4802.807887684454, 4924.532169443897, 5184.766685499086, 4469.7318160910445, 5544.833654990357, 5554.333919718639, 5563.5271001963665, 5584.972075139598, 5453.481919217668, 5456.907319510367, 5465.808696695596, 5468.808591699271, 5535.5848311376, 4665.460398068697, 5217.0870097733505, 5283.418823929442, 5640.548756099584, 5707.714614269353, 4907.018596280829, 5116.7953281869795, 5556.694381809039, 5561.610687252015, 5588.944110558842], "value": 3763.53860934335, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.2735682247286, 791.9960400197998, 796.350973956226, 806.8910697055895, 816.9754907352782, 15606.843931560696, 16529.090900000494, 16542.503724888244, 16593.419230326926, 16648.66702665946, 14701.55895323142, 15342.386304547832, 15574.766378504331, 15707.764383534257, 16475.83524164758, 866.5623859950732, 877.6401675313123, 891.269159289383, 892.1435421994893, 892.7009451833643, 688.41140824595, 706.826827427281, 851.7827953871754, 871.6687658689689, 878.7056336127405, 911.8723378726984, 923.6305477808896, 926.7683079230193, 928.0951072704127, 929.995350023249, 920.0845159066705, 921.5208091792231, 922.3589605224372, 922.6032805893464, 931.0410277414308, 491.85736136520364, 499.20127795526867, 683.893996430554, 685.9691313890887, 686.1012074182787, 12649.683757906034, 12855.87144128556, 12858.357082145949, 15261.0, 15506.689866202612, 13982.860171398257, 14280.727301742443, 14365.066270692372, 14508.1295122293, 14534.636634084232, 11382.544698212061, 11823.34971576563, 11828.349440780754, 11853.111016673784, 12115.878841211563, 3788.886333410002, 3860.3823388258024, 3888.9222215555815, 3939.960600393988, 3964.3657014877767, 104597.0, 108443.0, 110821.22946926391, 112400.0, 113898.0, 10820.0, 10853.945730271456, 10981.12151027916, 10997.285176463503, 11013.614523491638, 21505.462363441038, 21544.353669389944, 21636.35090947274, 21691.89154054251, 21699.674504882438, 7012.5974805039195, 7060.399866011447, 7204.639768011579, 7207.423406127497, 7461.1419686735635, 4185.689146652775, 4231.661467082626, 4424.225760491901, 4438.511763705989, 4445.977770111129, 3533.293341331744, 3678.393065144221, 3680.3375392429084, 3685.447182922583, 3699.741018128759, 625.4902254662436, 633.8985762278013, 655.1973832055694, 664.9534532582769, 669.2738378858895, 521.3665396543219, 590.4833270887973, 613.7729040255134, 622.4366947912147, 649.078308801503, 9377.437353758796, 9505.892658066577, 9603.0, 9849.261305402124, 9868.506574671237, 638.2118084166051, 654.1332734127301, 679.5817040287362, 681.8987335453207, 685.9862802743917, 4498.572635599613, 4712.481627021025, 4717.481077081518, 4732.810687572527, 4757.6193904488255, 102705.0, 135978.0, 154713.67929481066, 164522.1773891123, 169305.0, 130956.0, 139784.0, 140605.1878962415, 141454.0, 144863.0, 115786.42106789412, 116507.0, 116873.41563292129, 118360.0, 118842.0, 8648.82702345937, 9133.680321188727, 9170.403923744936, 9194.402363846328, 9211.677591284273, 59382.70308648429, 61416.69291653513, 61997.690011549654, 62611.0, 64261.0, 94778.05221947968, 95158.0, 97429.0, 97975.0, 102242.0, 11463.828042579535, 11725.941370293094, 11747.001504872182, 12042.096842736655, 12199.963003144832, 12339.197952133083, 12799.616011519669, 12945.158564693265, 13151.0, 13732.0, 11983.400829958642, 12088.697782555506, 12356.443960022001, 12374.75250494967, 12468.563600273947, 10665.786684266115, 11657.242279252161, 11844.348560828892, 12218.327991960528, 12296.569620063256, 11802.468888899848, 11975.281483110693, 12052.09609279325, 12183.878161218274, 12640.936795315965, 8480.61837217339, 9964.800703985735, 10247.538860751136, 10399.480025998519, 10763.031327180592, 10102.646407376, 10361.63734269297, 10529.473526323807, 10582.259241852997, 10625.787484250426], "value": 7709.492029672696, "unit": "score"}], "name": "dromaeo_css", "value": 7282.949266429673, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 116.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 108.0, 144.0, 110.0, 110.0, 117.0, 140.0, 174.0, 112.0], "value": 126.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 181.0, 185.0, 183.0, 183.0, 184.0, 185.0, 184.0, 183.0, 184.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 59.0, 89.0, 61.0, 59.0, 59.0, 58.0, 85.0, 81.0], "value": 69.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 93.0, 70.0, 67.0, 70.0, 91.0, 68.0, 68.0, 93.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 85.0, 87.0, 85.0, 89.0, 85.0, 89.0, 84.0], "value": 86.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 109.0, 152.0, 126.0, 94.0, 93.0, 94.0, 94.0], "value": 104.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 91.0, 85.0, 86.0, 86.0, 85.0, 86.0, 85.0, 86.0], "value": 86.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 53.0, 53.0, 55.0, 58.0, 58.0, 57.0, 57.0, 57.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 81.0, 105.0, 104.0, 114.0, 70.0, 69.0, 70.0, 69.0, 71.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 88.0, 83.0, 86.0, 86.0, 81.0, 85.0, 81.0, 89.0, 90.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 155.0, 149.0, 146.0, 135.0, 133.0, 148.0, 154.0, 188.0, 143.0], "value": 149.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 196.0, 223.0, 210.0, 168.0, 164.0, 164.0, 163.0, 162.0, 219.0], "value": 181.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 65.0, 67.0, 67.0, 66.0, 66.0, 72.0, 70.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1469.8, "alertThreshold": 2.0}]} 03:35:19 INFO - Return code: 0 03:35:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:35:19 INFO - # TBPL SUCCESS # 03:35:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:35:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:35:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:35:19 INFO - 2016-09-27 03:35:19.462 screenresolution[1685:9879] starting screenresolution argv=screenresolution get 03:35:19 INFO - 2016-09-27 03:35:19.467 screenresolution[1685:9879] Display 0: 1600x1200x32@60 03:35:19 INFO - 2016-09-27 03:35:19.473 screenresolution[1686:9882] starting screenresolution argv=screenresolution list 03:35:19 INFO - Available Modes on Display 0 03:35:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:35:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:35:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:35:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:35:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:35:19 INFO - Intel Iris: 03:35:19 INFO - Chipset Model: Intel Iris 03:35:19 INFO - Type: GPU 03:35:19 INFO - Bus: Built-In 03:35:19 INFO - VRAM (Dynamic, Max): 1536 MB 03:35:19 INFO - Vendor: Intel (0x8086) 03:35:19 INFO - Device ID: 0x0a2e 03:35:19 INFO - Revision ID: 0x0009 03:35:19 INFO - Displays: 03:35:19 INFO - Display: 03:35:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:35:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:35:19 INFO - Display Serial Number: 1600x1200 60 03:35:19 INFO - Main Display: Yes 03:35:19 INFO - Mirror: Off 03:35:19 INFO - Online: Yes 03:35:19 INFO - Rotation: Supported 03:35:19 INFO - Return code: 0 03:35:19 INFO - Running post-action listener: _resource_record_post_action 03:35:19 INFO - [mozharness: 2016-09-27 10:35:19.712990Z] Finished run-tests step (success) 03:35:19 INFO - Running post-run listener: _resource_record_post_run 03:35:19 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 31988736; Write bytes: 662271488; Read time: 199; Write time: 2156 03:35:19 INFO - TinderboxPrint: CPU usage
53.6% 03:35:19 INFO - TinderboxPrint: I/O read bytes / time
31,988,736 / 199 03:35:19 INFO - TinderboxPrint: I/O write bytes / time
662,271,488 / 2,156 03:35:19 INFO - TinderboxPrint: CPU idle
2,244.6 (46.4%) 03:35:19 INFO - TinderboxPrint: CPU system
969.3 (20.0%) 03:35:19 INFO - TinderboxPrint: CPU user
1,623.8 (33.6%) 03:35:19 INFO - TinderboxPrint: Swap in / out
390,762,496 / 0 03:35:19 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 360135168; Write bytes: 356206592; Read time: 27378; Write time: 742 03:35:19 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 29953024; Write bytes: 294764032; Read time: 181; Write time: 1376 03:35:20 INFO - Running post-run listener: _upload_blobber_files 03:35:20 INFO - Blob upload gear active. 03:35:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:35:20 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 03:35:20 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'] 03:35:20 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 03:35:20 INFO - (blobuploader) - INFO - Open directory for files ... 03:35:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:35:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:35:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:35:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:35:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:35:21 INFO - (blobuploader) - INFO - Done attempting. 03:35:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:35:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:35:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:35:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:35:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:35:22 INFO - (blobuploader) - INFO - Done attempting. 03:35:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:35:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:35:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:35:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:35:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:35:25 INFO - (blobuploader) - INFO - Done attempting. 03:35:25 INFO - (blobuploader) - INFO - Iteration through files over. 03:35:25 INFO - Return code: 0 03:35:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:35:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:35:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e40de6281fa6a4e58ff9eca86e0e1ab02bd86664e79951c855af112d9236b2ef62fb918dcb7d8f6c4b9bb0444f7be1080c463c182dd762f313dff3237e0e1ad7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ee840266edf1dad5347ae7a882c2457769be8c8945c298769ba72e7b576275bab0ccf819e3fcb2e540fc3d7c8add60dfcc31e3452f3222250df71cf5d11571", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bc52bb01a74c244df3e6f3bfd79732a50e8277cfef42c3eec5cc6a576efe57fb655deeef01dc8557c62c26ad389eec7f8f978e02d6bb582b116c1b20030c4d0"} 03:35:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:35:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:35:25 INFO - Contents: 03:35:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e40de6281fa6a4e58ff9eca86e0e1ab02bd86664e79951c855af112d9236b2ef62fb918dcb7d8f6c4b9bb0444f7be1080c463c182dd762f313dff3237e0e1ad7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ee840266edf1dad5347ae7a882c2457769be8c8945c298769ba72e7b576275bab0ccf819e3fcb2e540fc3d7c8add60dfcc31e3452f3222250df71cf5d11571", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bc52bb01a74c244df3e6f3bfd79732a50e8277cfef42c3eec5cc6a576efe57fb655deeef01dc8557c62c26ad389eec7f8f978e02d6bb582b116c1b20030c4d0"} 03:35:25 INFO - Running post-run listener: copy_logs_to_upload_dir 03:35:25 INFO - Copying logs to upload dir... 03:35:25 INFO - mkdir: /builds/slave/test/build/upload/logs 03:35:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.602505 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-09-27 03:35:25.099842) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 03:35:25.103450) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ipjnvpNQW3/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e40de6281fa6a4e58ff9eca86e0e1ab02bd86664e79951c855af112d9236b2ef62fb918dcb7d8f6c4b9bb0444f7be1080c463c182dd762f313dff3237e0e1ad7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ee840266edf1dad5347ae7a882c2457769be8c8945c298769ba72e7b576275bab0ccf819e3fcb2e540fc3d7c8add60dfcc31e3452f3222250df71cf5d11571", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bc52bb01a74c244df3e6f3bfd79732a50e8277cfef42c3eec5cc6a576efe57fb655deeef01dc8557c62c26ad389eec7f8f978e02d6bb582b116c1b20030c4d0"} build_url:https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010079 build_url: 'https://queue.taskcluster.net/v1/task/LCzqXV8SRZmvj32WTSouRw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e40de6281fa6a4e58ff9eca86e0e1ab02bd86664e79951c855af112d9236b2ef62fb918dcb7d8f6c4b9bb0444f7be1080c463c182dd762f313dff3237e0e1ad7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ee840266edf1dad5347ae7a882c2457769be8c8945c298769ba72e7b576275bab0ccf819e3fcb2e540fc3d7c8add60dfcc31e3452f3222250df71cf5d11571", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bc52bb01a74c244df3e6f3bfd79732a50e8277cfef42c3eec5cc6a576efe57fb655deeef01dc8557c62c26ad389eec7f8f978e02d6bb582b116c1b20030c4d0"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 03:35:25.139130) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:35:25.139889) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ipjnvpNQW3/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.TrN1SHkaDz/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005174 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:35:25.192482) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 03:35:25.193084) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 03:35:25.194002) ========= ========= Total master_lag: 0.20 =========