builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0305 starttime: 1484829729.02 results: success (0) buildid: 20170119030211 builduid: 570ec59667f4419faf80db45cfbb181b revision: 96cb95af530477edb66ae48d98c18533476e57bb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 04:42:09.024497) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 04:42:09.024926) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 04:42:09.025214) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 04:42:09.050654) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 04:42:09.050930) ========= 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.QFMWWkTRcg/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.SnakfDxIFx/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 --2017-01-19 04:42:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.0M=0.001s 2017-01-19 04:42:09 (19.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.367787 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 04:42:09.442230) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 04:42:09.445575) ========= 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.QFMWWkTRcg/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.SnakfDxIFx/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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.024910 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 04:42:09.494206) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-19 04:42:09.495643) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 96cb95af530477edb66ae48d98c18533476e57bb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 96cb95af530477edb66ae48d98c18533476e57bb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QFMWWkTRcg/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.SnakfDxIFx/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 2017-01-19 04:42:09,728 truncating revision to first 12 chars 2017-01-19 04:42:09,728 Setting DEBUG logging. 2017-01-19 04:42:09,728 attempt 1/10 2017-01-19 04:42:09,728 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/96cb95af5304?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-19 04:42:12,242 unpacking tar archive at: mozilla-central-96cb95af5304/testing/mozharness/ program finished with exit code 0 elapsedTime=2.801985 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-19 04:42:12.320630) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 04:42:12.320949) ========= script_repo_revision: 96cb95af530477edb66ae48d98c18533476e57bb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 04:42:12.321332) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 04:42:12.321610) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 04:42:12.341582) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-01-19 04:42:12.342134) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QFMWWkTRcg/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.SnakfDxIFx/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:42:12 INFO - MultiFileLogger online at 20170119 04:42:12 in /builds/slave/test 04:42:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:42:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:42:12 INFO - {'append_to_log': False, 04:42:12 INFO - 'base_work_dir': '/builds/slave/test', 04:42:12 INFO - 'blob_upload_branch': 'Firefox', 04:42:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:42:12 INFO - 'branch': 'Firefox', 04:42:12 INFO - 'buildbot_json_path': 'buildprops.json', 04:42:12 INFO - 'config_files': ('talos/mac_config.py',), 04:42:12 INFO - 'default_actions': ('clobber', 04:42:12 INFO - 'read-buildbot-config', 04:42:12 INFO - 'download-and-extract', 04:42:12 INFO - 'populate-webroot', 04:42:12 INFO - 'create-virtualenv', 04:42:12 INFO - 'install', 04:42:12 INFO - 'run-tests'), 04:42:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:42:12 INFO - 'download_minidump_stackwalk': True, 04:42:12 INFO - 'download_symbols': 'ondemand', 04:42:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:42:12 INFO - 'tooltool.py': '/tools/tooltool.py', 04:42:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:42:12 INFO - '/tools/misc-python/virtualenv.py')}, 04:42:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:42:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:42:12 INFO - 'installer_path': 'installer.exe', 04:42:12 INFO - 'log_level': 'info', 04:42:12 INFO - 'log_name': 'talos', 04:42:12 INFO - 'log_to_console': True, 04:42:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:42:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:42:12 INFO - 'opt_config_files': (), 04:42:12 INFO - 'pip_index': False, 04:42:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:42:12 INFO - 'cmd': ('bash', 04:42:12 INFO - '-c', 04:42:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:42:12 INFO - 'enabled': True, 04:42:12 INFO - 'halt_on_failure': False, 04:42:12 INFO - 'name': 'check_screen_resolution'},), 04:42:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:42:12 INFO - 'cmd': ('bash', 04:42:12 INFO - '-c', 04:42:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:42:12 INFO - 'enabled': True, 04:42:12 INFO - 'halt_on_failure': False, 04:42:12 INFO - 'name': 'check_screen_resolution'},), 04:42:12 INFO - 'run_cmd_checks_enabled': True, 04:42:12 INFO - 'sps_profile': False, 04:42:12 INFO - 'sps_profile_interval': 0, 04:42:12 INFO - 'suite': 'dromaeojs', 04:42:12 INFO - 'system_bits': '32', 04:42:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:42:12 INFO - 'title': 't-yosemite-r7-0305', 04:42:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:42:12 INFO - 'use_talos_json': True, 04:42:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:42:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:42:12 INFO - 'work_dir': 'build'} 04:42:12 INFO - [mozharness: 2017-01-19 12:42:12.682187Z] Running clobber step. 04:42:12 INFO - Running pre-action listener: _resource_record_pre_action 04:42:12 INFO - Running main action method: clobber 04:42:12 INFO - rmtree: /builds/slave/test/build 04:42:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:42:14 INFO - Running post-action listener: _resource_record_post_action 04:42:14 INFO - [mozharness: 2017-01-19 12:42:14.578280Z] Finished clobber step (success) 04:42:14 INFO - [mozharness: 2017-01-19 12:42:14.578449Z] Running read-buildbot-config step. 04:42:14 INFO - Running pre-action listener: _resource_record_pre_action 04:42:14 INFO - Running main action method: read_buildbot_config 04:42:14 INFO - Using buildbot properties: 04:42:14 INFO - { 04:42:14 INFO - "project": "", 04:42:14 INFO - "product": "firefox", 04:42:14 INFO - "script_repo_revision": "production", 04:42:14 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:42:14 INFO - "repository": "", 04:42:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:42:14 INFO - "buildid": "20170119030211", 04:42:14 INFO - "stage_platform": "macosx64", 04:42:14 INFO - "basedir": "/builds/slave/test", 04:42:14 INFO - "nightly_build": "True", 04:42:14 INFO - "buildnumber": 61, 04:42:14 INFO - "slavename": "t-yosemite-r7-0305", 04:42:14 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:42:14 INFO - "platform": "yosemite_r7", 04:42:14 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:42:14 INFO - "branch": "mozilla-central", 04:42:14 INFO - "repo_path": "mozilla-central", 04:42:14 INFO - "revision": "96cb95af530477edb66ae48d98c18533476e57bb", 04:42:14 INFO - "pgo_build": "False", 04:42:14 INFO - "builduid": "570ec59667f4419faf80db45cfbb181b", 04:42:14 INFO - "slavebuilddir": "test" 04:42:14 INFO - } 04:42:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:42:14 INFO - Running post-action listener: _resource_record_post_action 04:42:14 INFO - [mozharness: 2017-01-19 12:42:14.581891Z] Finished read-buildbot-config step (success) 04:42:14 INFO - [mozharness: 2017-01-19 12:42:14.582010Z] Running download-and-extract step. 04:42:14 INFO - Running pre-action listener: _resource_record_pre_action 04:42:14 INFO - Running main action method: download_and_extract 04:42:14 INFO - mkdir: /builds/slave/test/build/tests 04:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:14 INFO - trying https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:42:14 INFO - Downloading https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:42:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 04:42:17 INFO - Downloaded 1199 bytes. 04:42:17 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:42:17 INFO - Using the following test package requirements: 04:42:17 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:42:17 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:42:17 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:42:17 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:42:17 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:42:17 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:42:17 INFO - u'jsshell-mac.zip'], 04:42:17 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:42:17 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:42:17 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:42:17 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:42:17 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:42:17 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:42:17 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:42:17 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:42:17 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:42:17 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:42:17 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:42:17 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:42:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:42:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:42:17 INFO - Fetch https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:42:19 INFO - Expected file size: 16339325 04:42:19 INFO - Obtained file size: 16339325 04:42:26 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:42:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:42:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:42:26 INFO - Fetch https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:42:27 INFO - Expected file size: 16339325 04:42:27 INFO - Obtained file size: 16339325 04:42:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:42:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:42:34 INFO - Fetch https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:42:36 INFO - Expected file size: 14403463 04:42:36 INFO - Obtained file size: 14403463 04:42:36 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')]} 04:42:36 INFO - trying https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:42:36 INFO - Downloading https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:42:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 04:42:41 INFO - Downloaded 70029829 bytes. 04:42:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:42:41 INFO - mkdir: /builds/slave/test/properties 04:42:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:42:41 INFO - Writing to file /builds/slave/test/properties/build_url 04:42:41 INFO - Contents: 04:42:41 INFO - build_url:https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:42:42 INFO - Running post-action listener: _resource_record_post_action 04:42:42 INFO - Running post-action listener: set_extra_try_arguments 04:42:42 INFO - [mozharness: 2017-01-19 12:42:42.214539Z] Finished download-and-extract step (success) 04:42:42 INFO - [mozharness: 2017-01-19 12:42:42.214654Z] Running populate-webroot step. 04:42:42 INFO - Running pre-action listener: _resource_record_pre_action 04:42:42 INFO - Running main action method: populate_webroot 04:42:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:42:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:42:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:42:42 INFO - '--tppagecycles', 04:42:42 INFO - '7'], 04:42:42 INFO - 'tests': ['tsvgm']}}, 04:42:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:42:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:42:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:42:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:42:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:42:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:42:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:42:42 INFO - 'talos_options': ['--disable-e10s'], 04:42:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:42:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:42:42 INFO - 'talos_options': ['--disable-e10s'], 04:42:42 INFO - 'tests': ['damp', 'tps']}, 04:42:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:42:42 INFO - 'tests': ['damp', 'tps']}, 04:42:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:42:42 INFO - 'tests': ['dromaeo_dom']}, 04:42:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:42:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:42:42 INFO - 'tests': ['basic_compositor_video']}, 04:42:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:42:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:42:42 INFO - 'tests': ['a11yr', 04:42:42 INFO - 'ts_paint', 04:42:42 INFO - 'tpaint', 04:42:42 INFO - 'sessionrestore', 04:42:42 INFO - 'sessionrestore_no_auto_restore', 04:42:42 INFO - 'tabpaint']}, 04:42:42 INFO - 'other-e10s': {'tests': ['a11yr', 04:42:42 INFO - 'ts_paint', 04:42:42 INFO - 'tpaint', 04:42:42 INFO - 'sessionrestore', 04:42:42 INFO - 'sessionrestore_no_auto_restore', 04:42:42 INFO - 'tabpaint']}, 04:42:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:42:42 INFO - 'ts_paint', 04:42:42 INFO - 'tpaint', 04:42:42 INFO - 'sessionrestore', 04:42:42 INFO - 'sessionrestore_no_auto_restore', 04:42:42 INFO - 'tabpaint']}, 04:42:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:42:42 INFO - 'ts_paint', 04:42:42 INFO - 'tpaint', 04:42:42 INFO - 'sessionrestore', 04:42:42 INFO - 'sessionrestore_no_auto_restore', 04:42:42 INFO - 'tabpaint']}, 04:42:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:42:42 INFO - 'tests': ['a11yr', 04:42:42 INFO - 'ts_paint', 04:42:42 INFO - 'tpaint', 04:42:42 INFO - 'sessionrestore', 04:42:42 INFO - 'sessionrestore_no_auto_restore', 04:42:42 INFO - 'tabpaint']}, 04:42:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:42:42 INFO - 'tests': ['a11yr', 04:42:42 INFO - 'ts_paint', 04:42:42 INFO - 'tpaint', 04:42:42 INFO - 'sessionrestore', 04:42:42 INFO - 'sessionrestore_no_auto_restore', 04:42:42 INFO - 'tabpaint']}, 04:42:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:42:42 INFO - 'tests': ['tsvgx', 04:42:42 INFO - 'tsvgr_opacity', 04:42:42 INFO - 'tart', 04:42:42 INFO - 'tscrollx', 04:42:42 INFO - 'cart', 04:42:42 INFO - 'tsvg_static']}, 04:42:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:42:42 INFO - 'tsvgr_opacity', 04:42:42 INFO - 'tart', 04:42:42 INFO - 'tscrollx', 04:42:42 INFO - 'cart', 04:42:42 INFO - 'tsvg_static']}, 04:42:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:42:42 INFO - 'talos_options': ['--disable-e10s'], 04:42:42 INFO - 'tests': ['tp5o']}, 04:42:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:42:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:42:42 INFO - 'talos_options': ['--disable-e10s', 04:42:42 INFO - '--xperf_path', 04:42:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:42 INFO - 'tests': ['tp5n']}, 04:42:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:42:42 INFO - 'talos_options': ['--xperf_path', 04:42:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:42 INFO - 'tests': ['tp5n']}}, 04:42:42 INFO - 'talos.zip': {'path': '', 04:42:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:42:42 INFO - Running post-action listener: _resource_record_post_action 04:42:42 INFO - [mozharness: 2017-01-19 12:42:42.232960Z] Finished populate-webroot step (success) 04:42:42 INFO - [mozharness: 2017-01-19 12:42:42.233072Z] Running create-virtualenv step. 04:42:42 INFO - Running pre-action listener: _resource_record_pre_action 04:42:42 INFO - Running main action method: create_virtualenv 04:42:42 INFO - Creating virtualenv /builds/slave/test/build/venv 04:42:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:42:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:42:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:42:42 INFO - Using real prefix '/tools/python27' 04:42:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:42:43 INFO - Installing distribute.............................................................................................................................................................................................done. 04:42:46 INFO - Installing pip.................done. 04:42:46 INFO - Return code: 0 04:42:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:42:46 INFO - Reading from file tmpfile_stdout 04:42:46 INFO - Output received: 04:42:46 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:42:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c2eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c31768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff730d63ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a0cd30>, '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 0x106933db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a01be8>, '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.QFMWWkTRcg/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.SnakfDxIFx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:42: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', 'pip>=1.5'] in /builds/slave/test/build 04:42: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 pip>=1.5 04:42:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QFMWWkTRcg/Render', 04:42:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:47 INFO - 'HOME': '/Users/cltbld', 04:42:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:47 INFO - 'LOGNAME': 'cltbld', 04:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:47 INFO - 'MOZ_NO_REMOTE': '1', 04:42:47 INFO - 'NO_EM_RESTART': '1', 04:42:47 INFO - 'PAGER': '/bin/cat', 04:42:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:47 INFO - 'PWD': '/builds/slave/test', 04:42:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:47 INFO - 'SHELL': '/bin/bash', 04:42:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SnakfDxIFx/Listeners', 04:42:47 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:42:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:47 INFO - 'USER': 'cltbld', 04:42:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:47 INFO - 'XPC_FLAGS': '0x0', 04:42:47 INFO - 'XPC_SERVICE_NAME': '0', 04:42:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:42:47 INFO - Cleaning up... 04:42:47 INFO - Return code: 0 04:42:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:42: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')]} 04:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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')]} 04:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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', '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 0x106c2eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c31768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff730d63ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a0cd30>, '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 0x106933db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a01be8>, '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.QFMWWkTRcg/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.SnakfDxIFx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:42: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:42: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 psutil>=3.1.1 04:42:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QFMWWkTRcg/Render', 04:42:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:47 INFO - 'HOME': '/Users/cltbld', 04:42:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:47 INFO - 'LOGNAME': 'cltbld', 04:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:47 INFO - 'MOZ_NO_REMOTE': '1', 04:42:47 INFO - 'NO_EM_RESTART': '1', 04:42:47 INFO - 'PAGER': '/bin/cat', 04:42:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:47 INFO - 'PWD': '/builds/slave/test', 04:42:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:47 INFO - 'SHELL': '/bin/bash', 04:42:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SnakfDxIFx/Listeners', 04:42:47 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:42:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:47 INFO - 'USER': 'cltbld', 04:42:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:47 INFO - 'XPC_FLAGS': '0x0', 04:42:47 INFO - 'XPC_SERVICE_NAME': '0', 04:42:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:47 INFO - Downloading/unpacking psutil>=3.1.1 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:42:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:52 INFO - Installing collected packages: psutil 04:42:52 INFO - Running setup.py install for psutil 04:42:52 INFO - building 'psutil._psutil_osx' extension 04:42:52 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 04:42:52 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 04:42:52 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 04:42:52 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 04:42:52 INFO - building 'psutil._psutil_posix' extension 04:42:52 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 04:42:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:42:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:42:53 INFO - ^ 04:42:53 INFO - 1 warning generated. 04:42:53 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 04:42:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:53 INFO - Successfully installed psutil 04:42:53 INFO - Cleaning up... 04:42:53 INFO - Return code: 0 04:42:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:42: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')]} 04:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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')]} 04:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c2eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c31768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff730d63ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a0cd30>, '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 0x106933db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a01be8>, '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.QFMWWkTRcg/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.SnakfDxIFx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:42: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:42: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 mozsystemmonitor==0.3 04:42:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QFMWWkTRcg/Render', 04:42:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:54 INFO - 'HOME': '/Users/cltbld', 04:42:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:54 INFO - 'LOGNAME': 'cltbld', 04:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:54 INFO - 'MOZ_NO_REMOTE': '1', 04:42:54 INFO - 'NO_EM_RESTART': '1', 04:42:54 INFO - 'PAGER': '/bin/cat', 04:42:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:54 INFO - 'PWD': '/builds/slave/test', 04:42:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:54 INFO - 'SHELL': '/bin/bash', 04:42:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SnakfDxIFx/Listeners', 04:42:54 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:42:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:54 INFO - 'USER': 'cltbld', 04:42:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:54 INFO - 'XPC_FLAGS': '0x0', 04:42:54 INFO - 'XPC_SERVICE_NAME': '0', 04:42:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:43:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:43:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:43:01 INFO - Installing collected packages: mozsystemmonitor 04:43:01 INFO - Running setup.py install for mozsystemmonitor 04:43:01 INFO - Successfully installed mozsystemmonitor 04:43:01 INFO - Cleaning up... 04:43:01 INFO - Return code: 0 04:43:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:43:01 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')]} 04:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:01 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')]} 04:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:01 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 0x106c2eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c31768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff730d63ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a0cd30>, '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 0x106933db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a01be8>, '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.QFMWWkTRcg/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.SnakfDxIFx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:43:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QFMWWkTRcg/Render', 04:43:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:01 INFO - 'HOME': '/Users/cltbld', 04:43:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:01 INFO - 'LOGNAME': 'cltbld', 04:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:01 INFO - 'MOZ_NO_REMOTE': '1', 04:43:01 INFO - 'NO_EM_RESTART': '1', 04:43:01 INFO - 'PAGER': '/bin/cat', 04:43:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:01 INFO - 'PWD': '/builds/slave/test', 04:43:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:01 INFO - 'SHELL': '/bin/bash', 04:43:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SnakfDxIFx/Listeners', 04:43:01 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:43:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:01 INFO - 'USER': 'cltbld', 04:43:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:01 INFO - 'XPC_FLAGS': '0x0', 04:43:01 INFO - 'XPC_SERVICE_NAME': '0', 04:43:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:01 INFO - Downloading/unpacking jsonschema==2.5.1 04:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:43:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:43: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 04:43: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 04:43: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 04:43: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 04:43: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 04:43: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 04:43:05 INFO - Downloading functools32-3.2.3-2.tar.gz 04:43:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:43:05 INFO - warning: no files found matching '*.txt' 04:43:05 INFO - no previously-included directories found matching 'build' 04:43:05 INFO - no previously-included directories found matching 'dist' 04:43:05 INFO - no previously-included directories found matching '.git*' 04:43:05 INFO - Installing collected packages: jsonschema, functools32 04:43:05 INFO - Running setup.py install for functools32 04:43:05 INFO - warning: no files found matching '*.txt' 04:43:05 INFO - no previously-included directories found matching 'build' 04:43:05 INFO - no previously-included directories found matching 'dist' 04:43:05 INFO - no previously-included directories found matching '.git*' 04:43:05 INFO - Successfully installed jsonschema functools32 04:43:05 INFO - Cleaning up... 04:43:05 INFO - Return code: 0 04:43:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:43:05 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')]} 04:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:05 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')]} 04:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:05 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 0x106c2eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c31768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff730d63ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a0cd30>, '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 0x106933db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a01be8>, '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.QFMWWkTRcg/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.SnakfDxIFx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:43:05 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 04:43:05 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 04:43:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QFMWWkTRcg/Render', 04:43:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:05 INFO - 'HOME': '/Users/cltbld', 04:43:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:05 INFO - 'LOGNAME': 'cltbld', 04:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:05 INFO - 'MOZ_NO_REMOTE': '1', 04:43:05 INFO - 'NO_EM_RESTART': '1', 04:43:05 INFO - 'PAGER': '/bin/cat', 04:43:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:05 INFO - 'PWD': '/builds/slave/test', 04:43:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:05 INFO - 'SHELL': '/bin/bash', 04:43:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SnakfDxIFx/Listeners', 04:43:05 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:43:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:05 INFO - 'USER': 'cltbld', 04:43:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:05 INFO - 'XPC_FLAGS': '0x0', 04:43:05 INFO - 'XPC_SERVICE_NAME': '0', 04:43:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:43:06 INFO - Cleaning up... 04:43:06 INFO - Return code: 0 04:43:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106c2eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c31768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff730d63ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a0cd30>, '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 0x106933db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a01be8>, '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.QFMWWkTRcg/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.SnakfDxIFx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:43:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:43:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QFMWWkTRcg/Render', 04:43:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:06 INFO - 'HOME': '/Users/cltbld', 04:43:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:06 INFO - 'LOGNAME': 'cltbld', 04:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:06 INFO - 'MOZ_NO_REMOTE': '1', 04:43:06 INFO - 'NO_EM_RESTART': '1', 04:43:06 INFO - 'PAGER': '/bin/cat', 04:43:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:06 INFO - 'PWD': '/builds/slave/test', 04:43:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:06 INFO - 'SHELL': '/bin/bash', 04:43:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SnakfDxIFx/Listeners', 04:43:06 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:43:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:06 INFO - 'USER': 'cltbld', 04:43:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:06 INFO - 'XPC_FLAGS': '0x0', 04:43:06 INFO - 'XPC_SERVICE_NAME': '0', 04:43:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:06 INFO - Downloading/unpacking blobuploader==1.2.4 04:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:14 INFO - Downloading blobuploader-1.2.4.tar.gz 04:43:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:43:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:43:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:15 INFO - Downloading docopt-0.6.1.tar.gz 04:43:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:43:15 INFO - Installing collected packages: blobuploader, requests, docopt 04:43:15 INFO - Running setup.py install for blobuploader 04:43:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:43:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:43:15 INFO - Running setup.py install for requests 04:43:16 INFO - Running setup.py install for docopt 04:43:16 INFO - Successfully installed blobuploader requests docopt 04:43:16 INFO - Cleaning up... 04:43:16 INFO - Return code: 0 04:43:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43:16 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')]} 04:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:16 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')]} 04:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:16 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 0x106c2eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c31768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff730d63ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a0cd30>, '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 0x106933db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a01be8>, '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.QFMWWkTRcg/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.SnakfDxIFx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:43:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:43:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QFMWWkTRcg/Render', 04:43:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:16 INFO - 'HOME': '/Users/cltbld', 04:43:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:16 INFO - 'LOGNAME': 'cltbld', 04:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:16 INFO - 'MOZ_NO_REMOTE': '1', 04:43:16 INFO - 'NO_EM_RESTART': '1', 04:43:16 INFO - 'PAGER': '/bin/cat', 04:43:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:16 INFO - 'PWD': '/builds/slave/test', 04:43:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:16 INFO - 'SHELL': '/bin/bash', 04:43:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SnakfDxIFx/Listeners', 04:43:16 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:43:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:16 INFO - 'USER': 'cltbld', 04:43:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:16 INFO - 'XPC_FLAGS': '0x0', 04:43:16 INFO - 'XPC_SERVICE_NAME': '0', 04:43:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:43:16 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-WtFyH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:43:16 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-W7HgzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:43:16 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-XvyA48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:43:17 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-lzJRjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:43:17 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-bcdRW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:43:17 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-N7lr3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:43:17 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-XdjOu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:43:17 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-_D0jja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:43:17 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-KUQ9ZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:43:17 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-jZFBo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:43:17 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-6IZMte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:43:17 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-SQBV7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:43:17 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-OYedwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:43:18 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-oQ9GkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:18 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-65HRty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:43:18 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-k9BfkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:43:18 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-G6kNb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:43:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:43:18 INFO - Running setup.py install for manifestparser 04:43:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:43:18 INFO - Running setup.py install for mozcrash 04:43:18 INFO - Running setup.py install for mozdebug 04:43:18 INFO - Running setup.py install for mozdevice 04:43:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:43:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:43:19 INFO - Running setup.py install for mozfile 04:43:19 INFO - Running setup.py install for mozhttpd 04:43:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:43:19 INFO - Running setup.py install for mozinfo 04:43:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:43:19 INFO - Running setup.py install for mozInstall 04:43:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:43:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:43:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:43:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:43:19 INFO - Running setup.py install for mozleak 04:43:19 INFO - Running setup.py install for mozlog 04:43:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:43:19 INFO - Running setup.py install for moznetwork 04:43:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:43:20 INFO - Running setup.py install for mozprocess 04:43:20 INFO - Running setup.py install for mozprofile 04:43:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:43:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:43:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:43:20 INFO - Running setup.py install for mozrunner 04:43:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:43:20 INFO - Running setup.py install for mozscreenshot 04:43:20 INFO - Running setup.py install for moztest 04:43:20 INFO - Running setup.py install for mozversion 04:43:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:43:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:43:21 INFO - Cleaning up... 04:43:21 INFO - Return code: 0 04:43:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43:21 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')]} 04:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:21 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')]} 04:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:21 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 0x106c2eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c31768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff730d63ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a0cd30>, '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 0x106933db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a01be8>, '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.QFMWWkTRcg/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.SnakfDxIFx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:43:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:43:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QFMWWkTRcg/Render', 04:43:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:21 INFO - 'HOME': '/Users/cltbld', 04:43:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:21 INFO - 'LOGNAME': 'cltbld', 04:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:21 INFO - 'MOZ_NO_REMOTE': '1', 04:43:21 INFO - 'NO_EM_RESTART': '1', 04:43:21 INFO - 'PAGER': '/bin/cat', 04:43:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:21 INFO - 'PWD': '/builds/slave/test', 04:43:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:21 INFO - 'SHELL': '/bin/bash', 04:43:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SnakfDxIFx/Listeners', 04:43:21 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:43:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:21 INFO - 'USER': 'cltbld', 04:43:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:21 INFO - 'XPC_FLAGS': '0x0', 04:43:21 INFO - 'XPC_SERVICE_NAME': '0', 04:43:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:43:21 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-Tbl0s3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:43:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:43:21 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-4Ya2AE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:43:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:43:21 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-VQJdAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:43:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:43:21 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-ZdAQcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:43:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:43:21 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-Nm52z9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:43:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:43:21 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-SXvK6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:43:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:43:21 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-_pLqYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:43:22 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-hFjBg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:43:22 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-hQ30mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:43:22 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-iDPsNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:43:22 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)) 04:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:43:22 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-TSmbIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:43:22 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-Sl3azk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:43:22 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-7p2h5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:43:22 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-edWdoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:22 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-RJdwW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:43:22 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-0rAXzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:43:22 INFO - Running setup.py (path:/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/pip-y4Oubx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:43:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:43:23 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:43:23 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:43:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:26 INFO - Downloading blessings-1.6.tar.gz 04:43:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:43:26 INFO - Installing collected packages: blessings 04:43:26 INFO - Running setup.py install for blessings 04:43:26 INFO - Successfully installed blessings 04:43:26 INFO - Cleaning up... 04:43:26 INFO - Return code: 0 04:43:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:43:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:43:26 INFO - Reading from file tmpfile_stdout 04:43:26 INFO - Current package versions: 04:43:26 INFO - blessings == 1.6 04:43:26 INFO - blobuploader == 1.2.4 04:43:26 INFO - docopt == 0.6.1 04:43:26 INFO - functools32 == 3.2.3-2 04:43:26 INFO - jsonschema == 2.5.1 04:43:26 INFO - manifestparser == 1.1 04:43:26 INFO - mozInstall == 1.12 04:43:26 INFO - mozcrash == 1.0 04:43:26 INFO - mozdebug == 0.1 04:43:26 INFO - mozdevice == 0.49 04:43:26 INFO - mozfile == 1.2 04:43:26 INFO - mozhttpd == 0.7 04:43:26 INFO - mozinfo == 0.9 04:43:26 INFO - mozleak == 0.1 04:43:26 INFO - mozlog == 3.4 04:43:26 INFO - moznetwork == 0.27 04:43:26 INFO - mozprocess == 0.24 04:43:26 INFO - mozprofile == 0.28 04:43:26 INFO - mozrunner == 6.13 04:43:26 INFO - mozscreenshot == 0.1 04:43:26 INFO - mozsystemmonitor == 0.3 04:43:26 INFO - moztest == 0.8 04:43:26 INFO - mozversion == 1.4 04:43:26 INFO - psutil == 3.1.1 04:43:26 INFO - requests == 1.2.3 04:43:26 INFO - wsgiref == 0.1.2 04:43:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:26 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 0x106c2eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c31768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff730d63ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a0cd30>, '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 0x106933db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a01be8>, '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.QFMWWkTRcg/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.SnakfDxIFx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:43:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:43:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QFMWWkTRcg/Render', 04:43:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:26 INFO - 'HOME': '/Users/cltbld', 04:43:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:26 INFO - 'LOGNAME': 'cltbld', 04:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:26 INFO - 'MOZ_NO_REMOTE': '1', 04:43:26 INFO - 'NO_EM_RESTART': '1', 04:43:26 INFO - 'PAGER': '/bin/cat', 04:43:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:26 INFO - 'PWD': '/builds/slave/test', 04:43:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:26 INFO - 'SHELL': '/bin/bash', 04:43:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SnakfDxIFx/Listeners', 04:43:26 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:43:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:26 INFO - 'USER': 'cltbld', 04:43:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:26 INFO - 'XPC_FLAGS': '0x0', 04:43:26 INFO - 'XPC_SERVICE_NAME': '0', 04:43:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:43:26 INFO - Cleaning up... 04:43:26 INFO - Return code: 0 04:43:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:26 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 0x106c2eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c31768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff730d63ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a0cd30>, '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 0x106933db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a01be8>, '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.QFMWWkTRcg/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.SnakfDxIFx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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 04:43:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:43:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QFMWWkTRcg/Render', 04:43:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:26 INFO - 'HOME': '/Users/cltbld', 04:43:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:26 INFO - 'LOGNAME': 'cltbld', 04:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:26 INFO - 'MOZ_NO_REMOTE': '1', 04:43:26 INFO - 'NO_EM_RESTART': '1', 04:43:26 INFO - 'PAGER': '/bin/cat', 04:43:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:26 INFO - 'PWD': '/builds/slave/test', 04:43:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:26 INFO - 'SHELL': '/bin/bash', 04:43:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SnakfDxIFx/Listeners', 04:43:26 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:43:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:26 INFO - 'USER': 'cltbld', 04:43:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:26 INFO - 'XPC_FLAGS': '0x0', 04:43:26 INFO - 'XPC_SERVICE_NAME': '0', 04:43:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:43:27 INFO - Cleaning up... 04:43:27 INFO - Return code: 0 04:43:27 INFO - Running post-action listener: _resource_record_post_action 04:43:27 INFO - Running post-action listener: _start_resource_monitoring 04:43:27 INFO - Starting resource monitoring. 04:43:27 INFO - [mozharness: 2017-01-19 12:43:27.254672Z] Finished create-virtualenv step (success) 04:43:27 INFO - [mozharness: 2017-01-19 12:43:27.255656Z] Running install step. 04:43:27 INFO - Running pre-action listener: _resource_record_pre_action 04:43:27 INFO - Running main action method: install 04:43:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:43:27 INFO - Reading from file tmpfile_stdout 04:43:27 INFO - Detecting whether we're running mozinstall >=1.0... 04:43:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:43:27 INFO - Reading from file tmpfile_stdout 04:43:27 INFO - Output received: 04:43:27 INFO - Usage: mozinstall [options] installer 04:43:27 INFO - Options: 04:43:27 INFO - -h, --help show this help message and exit 04:43:27 INFO - -d DEST, --destination=DEST 04:43:27 INFO - Directory to install application into. [default: 04:43:27 INFO - "/builds/slave/test"] 04:43:27 INFO - --app=APP Application being installed. [default: firefox] 04:43:27 INFO - mkdir: /builds/slave/test/build/application 04:43:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:43:49 INFO - Reading from file tmpfile_stdout 04:43:49 INFO - Output received: 04:43:49 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:43:49 INFO - Running post-action listener: _resource_record_post_action 04:43:49 INFO - [mozharness: 2017-01-19 12:43:49.551624Z] Finished install step (success) 04:43:49 INFO - [mozharness: 2017-01-19 12:43:49.551737Z] Running run-tests step. 04:43:49 INFO - Running pre-action listener: _resource_record_pre_action 04:43:49 INFO - Running main action method: run_tests 04:43:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:43:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:43:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:43:49 INFO - 2017-01-19 04:43:49.566 screenresolution[1626:7547] starting screenresolution argv=screenresolution get 04:43:49 INFO - 2017-01-19 04:43:49.568 screenresolution[1626:7547] Display 0: 1600x1200x32@60 04:43:49 INFO - 2017-01-19 04:43:49.574 screenresolution[1627:7550] starting screenresolution argv=screenresolution list 04:43:49 INFO - Available Modes on Display 0 04:43:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:43:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:43:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:43:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:43:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:43:49 INFO - Intel Iris: 04:43:49 INFO - Chipset Model: Intel Iris 04:43:49 INFO - Type: GPU 04:43:49 INFO - Bus: Built-In 04:43:49 INFO - VRAM (Dynamic, Max): 1536 MB 04:43:49 INFO - Vendor: Intel (0x8086) 04:43:49 INFO - Device ID: 0x0a2e 04:43:49 INFO - Revision ID: 0x0009 04:43:49 INFO - Displays: 04:43:49 INFO - Display: 04:43:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:43:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:43:49 INFO - Display Serial Number: 1600x1200 60 04:43:49 INFO - Main Display: Yes 04:43:49 INFO - Mirror: Off 04:43:49 INFO - Online: Yes 04:43:49 INFO - Rotation: Supported 04:43:49 INFO - Return code: 0 04:43:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:43:49 INFO - Python 2.7.3 04:43:49 INFO - Return code: 0 04:43:49 INFO - grabbing minidump binary from tooltool 04:43:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:43:49 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 0x106a0cd30>, '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 0x106933db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a01be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:43:49 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 04:43:49 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 04:43:49 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 04:43:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:43:49 INFO - Return code: 0 04:43:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:43:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:43:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:43:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:43:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:43:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0305', '--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 04:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0305 --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 04:43:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QFMWWkTRcg/Render', 04:43:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:49 INFO - 'HOME': '/Users/cltbld', 04:43:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:49 INFO - 'LOGNAME': 'cltbld', 04:43:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:43:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:43:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:49 INFO - 'MOZ_NO_REMOTE': '1', 04:43:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:43:49 INFO - 'NO_EM_RESTART': '1', 04:43:49 INFO - 'PAGER': '/bin/cat', 04:43:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:49 INFO - 'PWD': '/builds/slave/test', 04:43:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:43:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:49 INFO - 'SHELL': '/bin/bash', 04:43:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SnakfDxIFx/Listeners', 04:43:49 INFO - 'TMPDIR': '/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/', 04:43:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:49 INFO - 'USER': 'cltbld', 04:43:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:49 INFO - 'XPC_FLAGS': '0x0', 04:43:49 INFO - 'XPC_SERVICE_NAME': '0', 04:43:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0305', '--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 04:43:50 INFO - mozversion application_buildid: 20170119030211 04:43:50 INFO - mozversion application_changeset: 96cb95af530477edb66ae48d98c18533476e57bb 04:43:50 INFO - mozversion application_display_name: Nightly 04:43:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:43:50 INFO - mozversion application_name: Firefox 04:43:50 INFO - mozversion application_remotingname: firefox 04:43:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:43:50 INFO - mozversion application_vendor: Mozilla 04:43:50 INFO - mozversion application_version: 53.0a1 04:43:50 INFO - mozversion platform_buildid: 20170119030211 04:43:50 INFO - mozversion platform_changeset: 96cb95af530477edb66ae48d98c18533476e57bb 04:43:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:43:50 INFO - mozversion platform_version: 53.0a1 04:43:50 INFO - using testdate: 1484829830 04:43:50 INFO - actual date: 1484829830 04:43:50 INFO - starting webserver on 'localhost:49241' 04:43:50 INFO - SUITE-START | Running 2 tests 04:43:50 INFO - TEST-START | dromaeo_css 04:43:50 INFO - operating with platform_type : mac_ 04:43:50 INFO - Initialising browser for dromaeo_css test... 04:43:50 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpQ8fXl4/profile http://localhost:49241/getInfo.html) 04:43:52 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 04:43:52 INFO - PROCESS | 1637 | colorDepth:24 04:43:52 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 04:43:52 INFO - PROCESS | 1637 | __metrics 04:43:52 INFO - PROCESS | 1637 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:43:52 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:43:53 INFO - TEST-INFO | 1637: exit 0 04:43:53 INFO - Browser initialized. 04:43:53 INFO - Running cycle 1/1 for dromaeo_css test... 04:43:53 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmpQ8fXl4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:44:05 INFO - PROCESS | 1640 | RSS: Main: 235413504 04:44:05 INFO - PROCESS | 1640 | 04:47:09 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 04:47:10 INFO - PROCESS | 1640 | RSS: Main: 342753280 04:47:10 INFO - PROCESS | 1640 | 04:48:55 INFO - PROCESS | 1640 | ************************* 04:48:55 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 04:48:55 INFO - PROCESS | 1640 | 04:48:55 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:48:55 INFO - PROCESS | 1640 | Full stack: 04:48:55 INFO - PROCESS | 1640 | ************************* 04:50:13 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 04:50:14 INFO - PROCESS | 1640 | RSS: Main: 369291264 04:50:14 INFO - PROCESS | 1640 | 04:53:16 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 04:53:17 INFO - PROCESS | 1640 | RSS: Main: 338403328 04:53:17 INFO - PROCESS | 1640 | 04:56:19 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 04:56:20 INFO - PROCESS | 1640 | RSS: Main: 348045312 04:56:20 INFO - PROCESS | 1640 | 04:59:23 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 04:59:24 INFO - PROCESS | 1640 | RSS: Main: 324947968 04:59:24 INFO - PROCESS | 1640 | 05:02:27 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 05:02:27 INFO - PROCESS | 1640 | RSS: Main: 495812608 05:02:27 INFO - PROCESS | 1640 | 05:02:27 INFO - PROCESS | 1640 | __start_tp_report 05:02:27 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 05:02:27 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 05:02:27 INFO - PROCESS | 1640 | |i|pagename|runs| 05:02:27 INFO - PROCESS | 1640 | |0;dojo.html;3371.1909141805963;3373.3927892979254;3384.5430866832985;3401.302732939748;3419.6238413774495;5659.292588426447;5722.628029178106;5728.026235539958;5768.480836724694;5790.131480277961;5681.630694004887;5686.346070201928;5730.484256416921;5751.913721294173;5779.797707080253;5165.586753059765;5171;5206.583473322125;5241.816536421226;5290.788368465257;5292.100342941709;5306.973465132669;5331.546818520411;5342.572594192475;5370.677759334433;5152.716600586966;5184.7407629618365;5239.921401178985;5252.264682944391;5269.76286067126;5155.381354237478;5219.399769026572;5231.686098834044;5246.606504512139;5313.57491400687;5186.948130518685;5197.974010129925;5204.29741984831;5209.921851172236;5211.088059589557;5741.885162296772;5764.798232061899;5769.798057068025;5770.740316685759;5786.47921687046;6133.867031338107;6187.412195841388;6208.87582248357;6239.220097487814;6247.562670613059;6164.660943648098;6251.624902505864;6268.78059267928;6281.246250449975;6288.9056664150075;5874.9118763218585;5893.764249429974;5895.086261629454;5909.084091965667;5931.199288096138;6136.856084434161;6226.221722284715;6236.6258024518675;6257.5932564383165;6268.529860260499;6169.198004259418;6214.844628884223;6223.626582405071;6226.346233645492;6236.126942228092;6136.7154341639325;6286;6294.905576416358;6295.905561416583;6305.558610897285;6112.837854638568;6134.77336474251;6182.196314479089;6222.222222222223;6240.781572644935;6281.811545653638;6287.182666253358;6297.685115744286;6297.811065668037;6321.55749097568;4946.703197808143;4988.426330971912;5000.874978125576;5009.674371165863;5022.171341728647;4415.205263052617;4426.933595996063;4453.109378124388;4466.173757854807;4515.232410490159;4782.689125206851;5722.914156287659;5745.9712701437065;5763.942360576424;5794.88410231793;6246.625202487865;6247.219097612799;6256.217972753406;6279.058141278845;6310.0850376695125;5598.944010559842;5635.070213414822;5661.46216109469;5720.256366672306;5745.798897038583;4754.833580824655;5382.650127741685;5439.102548079602;5469.835904922858;5518.586106042063;6240.843978900564;6296.087067375113;6303.810885673437;6327.4938004959495;6331.493480521639;6159.322474527888;6216.595921265103;6295.213098362705;6304.05439184126;6322.33615470369;6229.813105606839;6237.688115594293;6270.655113968775;6335.049742538656;6338.366163383625;6232.314445411092;6236.875262494816;6260.186175797117;6260.530460215411;6268.968655156695;6150.292716337678;6255.437010669061;6291.653959032297;6293.55945083858;6298.212723409574;5929.495992840657;6072.574919755752;6119.724612392542;6124.112003759519;6188.535859810442;6157.599756016024;6171.166892469639;6175.505959523138;6179.598326108789;6180.752769889334;5851.063829787384;5878.088896221093;6067.817965461043;6068.575199735976;6111.449969502766;6089.817305480843;6115.788007244377;6135.355787642412;6143.907841382294;6172.259328880563;5934.169216309807;5946.464818166386;5956.285245770535;5958.374370691188;5966.134910437875 05:02:27 INFO - PROCESS | 1640 | |1;ext.html;481.38142486904314;495.9702417854929;503.87655024519;510.0770096735308;555.0757987950063;36398.81800590997;40679.18641627166;40708.77873663791;44911.101777964424;45110.774446127725;43661.34507982383;44125.77937110318;44156.116877662425;44235;44236.55763442365;8688.56557172142;9260.768480787983;9460.716178514656;9463.905360946372;9503.857442138373;8600;11115.499802508906;11363.431828408546;11375.033122184625;11555.480003399867;11328.150388720878;11416.42917854104;11428.657140285804;11463.770724585504;11482.368469734161;8478.66085356585;8683.305335573139;11179.993800557948;11292.322460652387;11333.376664283462;11012.39431831249;11250.774984500264;11269.267497612711;11429.428528573539;11435.97076263132;41925.371119433235;42101;42171.73484795461;42258.78870605658;42386.788066059475;4094.508658960914;4104.897377565585;4110.301248787683;4133.173365326947;4133.4626498555;30583.847080764455;30908.690913090806;31111.37777244465;31388.861113888655;31618.36763264745;2690.6502154719956;3152.3852848694514;3175.364927014606;3175.42842288388;3202.247471844115;471798;476879;477548.9999999965;478008;481756;65659.0302290932;66152.00771988423;66162.66918665376;66194.66902665456;66218.66890665612;68042.89678274149;68093;68194.31805681979;68269;68400.63198735997;16061.518154455385;16581.83418165803;16585.25366358517;16619.41832035873;16895.915520422564;11552.480138393792;11801.645950621494;12090.939545302217;12381.62855114348;12661.177023493443;17957.191926363084;17991.820081799015;18547.907260463613;18605.348812791486;18622.720659190123;6734.797956061326;6781.966090169616;6798.320167983261;6862;6873.518853680194;874.6676263020012;883.1168831168832;892.2148509311764;911.1617312072909;934.8036912248368;29800;31077.912273070335;31220;31645.841770790998;31812.84093579517;1054.46222426563;1055.5619417941468;1077.498962982217;1108.3737688206138;1110.8722496912796;14190.858091418953;16039.759403608956;16086.75869861953;16108.436204732778;16554.42059527935;588331;591710;593746;594635;598814;57635.42364576385;57938.55153621109;57969.840603188546;58015;58033.419665803645;1425.6792221750022;1444.5970807100482;1458.8905832062637;1480.985190148128;1485.2944851195812;27778.583321249793;30148.24629384283;30555.2361190972;30870.53694194544;31404.842975784974;54204.72897635487;54458;54467.72766136144;54613;54738.45261547333;515905;517299;518099.40950296517;519838;519870;35356.64643353534;41481.79259103685;42089;42159.36760948527;42370.91549014138;39153.82538523849;48115;48930;49363.25955110748;52625.21062184147;39125.41311880267;40303.1939361217;40863.795681022595;41872.790636047845;42362.57637423586;39819.800900996466;40053.799731001156;40782.59217407788;41039.09005116003;42003;34723.4791478123;39168;39880.00299992524;39998.80003599897;40082.799586001885;32914.67085329212;33711.4943275856;35035.299294013465;35758.8212058938;35769.56921723206;22216.66674999844;25436.872815635805;25642.974281029296;25795;26188 05:02:27 INFO - PROCESS | 1640 | |2;jquery.html;373.6151763683406;383.5914750790408;392.4427313215234;398.22545149683856;422.69988308301106;13479.730405391887;19757;20359.491012724688;21169.894150529246;21170.364889053333;16319.510414687578;16722.832771672278;20304.593908121828;20863.26978555751;20922.849243291614;5707.99999999999;6040.1543783870075;6047.758089676429;6049.183360246377;6054.303755068179;5539.9169012464845;5783.334916484595;5883.47048765611;5921.230240068785;6067.605605635642;5826.21346118275;5915.674637894914;5930.644161350311;5940.732667029994;5952.523798096164;5868.882622347551;5921.111833225008;6487.18910136233;6574.441172500343;6707.228668703064;5763.077907534816;5798.1302804579655;5884.352721200665;5897.233359663259;5916.1421593868645;13399.933000335033;13593.98045146618;23278.883605582032;24944.750552494424;26100.477990440275;2634.1702363755358;2671.545837207679;2698.8920443182446;2705.066751970567;2707.2284398946404;10087.546060427298;10544.945505449394;10612.734681632945;12548.623541293775;14898;1782.6612943540686;1830.9450716478527;1839.0712690091552;1848.3253612431365;1865.1742609945943;94476.52761736147;142870;145561;146776.2661186698;148552;11270.21108522412;11785.410729463663;11795.115366347558;11813.704657383634;12006.51973921051;15127.848721512864;15463.226838658022;15483.922580387027;15643.843561564467;15644.921775391278;6574.769883054166;7557.35762460186;7822.765317040498;7944.483608565541;7955.641996110073;7872.252136047066;8288.21261980111;8299.626516806758;8370.958145209357;8583.227509524047;4756.6908150970075;4760.143913651781;4765.9046819064115;4766.666333356632;4889.975550122226;1807.8824876382994;1811.5380577952537;1877.2397179142197;1999.1303782854213;2001.9399418017483;847.2332539052168;870.5647176411794;880.7489865388334;884.566562384427;897.8608315711075;20662.793372066386;22192.334229973127;22292.331230063122;22292.88535573215;22323.107075717115;762.8779395296726;910.235402262103;912.2975309012023;919.2324409118328;958.3962103874514;5422.43064478232;6766.661666916634;6807.217170025411;7000.92999070013;7027.578345299298;713139;719981;741425;747339;757652;163941;165780;166594;168058;171143.14428427778;980.8234517786724;1051.6476980211714;1054.0776820282406;1076.838474228872;1078.013617539942;18432.907835460737;19240.4227873164;19288;19352.70970935409;19372.32196873159;39116;46490.76754616205;47093.82265443391;48492.75753621209;57768;70132;87059.56470217608;87183.56408217919;88544.11455885616;88631.89788357377;8230.794230144294;8238.794030149294;8550.871736924075;8567.614457349559;8743.650253989768;11498.94250528742;12945.870541294467;13079.215247085205;13604.455821767018;13768.311584420939;11225.887741122484;11501.769964600493;11753.236039657395;11794.225847728987;11816.054715622558;11414.657560273205;11518.005318617052;11626.593069242535;11741.41292935367;11905.107116966436;9750.561224744763;11353.772924541297;11757.235779674294;11758.706032348917;11887.346195959306;8419.83160336802;8478.57607119654;8497.447665901696;8591;8596.742097737078;9479.231710667467;11649.068074553847;11674.124440666814;11677.88322116768;11689.824652630388 05:02:27 INFO - PROCESS | 1640 | |3;mootools.html;1233.4819375862137;1487.2563718140932;1492.2613306413327;1509.5848641623552;1513;8020.197980201977;8394.328453723703;8404.907362042934;8415.20055594719;8415.663373465053;7465.514741541796;7687.961560192205;7700;7723.9613801931055;8088.555129467892;2244.921427750025;2285.7942785149335;2298.069281940817;2301.919432819852;2307.3885420363617;2276.9203077892275;2298.839081264312;2310.214527060799;2311.3181611424584;2324.035525257016;2014.1943222710886;2097.391756390645;2196.099599164343;2269.353234328217;2296.2651951375565;2145.678148277755;2149.50561370884;2153.3970488263235;2157.244964262511;2158.2769772126358;2175.8912054397374;2223.2440970070093;2238.104758096758;2298.6552017197387;2301.3096071178747;8338.83322333556;8402.537860417675;8405.663773449054;8419.747407577783;8423.83152336956;5016.49835016499;5165.302684137631;5177.948220517822;5183.714895680736;5186.7925282988635;3125.6092988376454;3431.296584200233;3431.7179075914487;3476.721862251014;3527.2945410917664;1162.6686394377562;1191.5174354386488;1241.3855141704914;1248.5630029489696;1252.4238850128952;10705.518251678694;10787.406692631903;10813;10818.72953176169;10830.945845270802;3918.6669133123432;4416.668749843775;4479.656103169036;4592;4639.814407423665;8181.918180818235;9389.061093890556;9424.151826335663;9440.527973601293;9455.338126331228;5213.296205012275;5214.348206474191;5214.713190774468;5217.295665085241;5225.843224703265;4617.468991066004;4715.81136754526;4732.763361831895;4816.916193856354;4844.442889067732;3751.437284407361;3797.0445220711354;3846.673032792188;3906.3945088511327;3907.238088572701;1256.6795467155816;1258.3771033338555;1258.797848055105;1274.6048724895313;1279.260206119695;889.3641046651675;908.7182973278304;921.9124183202586;940.2947789158131;956.2397893674546;5702.315722113373;5754.280714910637;5778.191053252548;5936.872381046872;6002;977.1938151025432;996.4220751963989;1003.6437064841876;1023.1456733627356;1059.7244716373798;3312.3375324934627;3596.6762991330907;3722.3299806035175;3847.3267178243696;3873.9418908716393;9760.511974401252;10112.595496180218;10117.342372745896;10126.696199114038;10152.933941936139;9784.608615655294;9982.550785214682;10053.59785608582;10087.142592879542;10107.69676909694;7541.132769731441;7915.9208407915185;7946.364290856717;7949.085855126735;7974.641141148546;5435.565154787529;5525;5531.115021596525;5532.1425179097305;5591.580631452739;8946.597403117006;9021.413608115452;9039.412438191497;9135.725928222164;9284.071592840663;7296.306850849161;9346.859797103185;9349.345545811728;9464.95267523658;9477;6594;6763.458923286224;6765.661716914233;6765.932340676531;6767.221769496571;7602.277783610548;7732.961335193288;7776.494527855672;7820.257075578039;7853.450258481851;6012.3386427493815;7059.470539709439;7207.387372073433;7214.603196824225;7323.6338183089565;7320.048393708784;7322.524035937647;7333.963330183315;7338.596377199092;7382.3724983377015;6297.653629050446;6336.936630633819;6387.265464471645;6428.8071357859335;6507.186601674791;4971.304017437489;5000.049990501793;5004.3994720633755;5042.117629414911;5093.770780314969;5032.748362581783;5092.898142037213;5102.387713474407;5146.845594632167;5219.817306394258 05:02:27 INFO - PROCESS | 1640 | |4;prototype.html;339.2367173858818;351.7133536168023;359.658324591638;361.6437808758373;363.4294158171671;5266.813577785438;5353.625246232766;5355.3305836770405;5390.487903649157;5400.29796126503;4417.5582441755805;4683.929741053887;5296.947030529694;5319.494648008433;5420.349558053039;3680.355937710903;4183.602557757008;4199.202151591203;4231.428757117796;4240.809163587631;3568.892933212008;3667.174885650734;4061.8578349757763;4167.208230436223;4178;3588.1567831559564;3853.691704663634;4114.794260286989;4129.6283334499885;4157.771322577272;3637.436197389409;4141.482314710646;4147.6474499667565;4150.27370210212;4164.416981622575;3235.1588586967323;3246.4156451838658;3459.930801383983;3482.7162590014423;3623.710103191738;4582.427196600425;4739.644526660514;5189.506996835295;5228.581713462914;5269.947300526984;4770.682532308232;4805.927911081337;4823.951760482385;4876.878078048042;4878.414590249157;5458.836234912959;5639.208591747111;5662.235598194274;5694.80749911283;5713.914291285634;4084.7549147051272;4088.4276201331836;4099.241640296555;4099.385092236159;4132.111596006843;5663.290544693233;5903.144044113579;5944.702764861826;6010.549208809357;6011.723610632216;4041.8480732990956;4132.090939993197;4138.482689663792;4143.461350024478;4160.375943608423;4186.853460128881;4193.643540299109;4198.853040143641;4228.344606585984;4230.534641189467;3991.16185601027;4150.771707556113;4544.840930567414;4756.762161891892;4803.567678908915;5196.908649183638;5658.688772117573;5685.147227915846;5739.741711622987;5774.39368866263;1194.6117511808698;1248.9313087780258;1250.6748245456247;1345.880238624171;1360.931953402326;911.4941207629829;915.665781989569;964.8504481805331;977.6264348590242;983.9360441571275;4322.502912165079;4482.8206871725415;4632.536746325341;4848.95151048485;4926.236433352836;4839.516048395203;5439.401665816757;5495.477045569178;5496.80761173357;5507.421720719347;4495.820167193276;4505.5269196734525;4795.400574928134;4953.281774142729;4963;2332.402304421477;2460.8400453970794;2561.743825617423;2825.675047369538;2835.532137197339;5667.8866422672145;5695.75342055033;5704.71476426177;5707.543396528268;5732.051102625044;4755.904881902412;5205.486296749679;5276.630635855453;5322.893542129135;5364.839054828361;5110.696772323034;5357.732113394392;5385.684155813038;5495.455431246904;5727.935554478334;4894.608431325557;4993.450720420823;5001.899962000813;5204.219367094966;5522.591739106502;4703.952960470351;5290.761915713725;5449;5529.668219906657;5778.8266352009505;4780.808767649255;5730.398308177748;5920.526357891445;5952.375000624872;6127.264728232641;3346.631870494195;3848.365019771706;3888.9694231029366;3891.1439483313625;3896.6687831533504;4347.869533935562;4922.704637721748;5148.4851514848215;5806.01297779387;5808.912866306924;4817;5392.379876314274;5668.943310566841;5669.744861481326;5679.716014199191;4696.600788932842;5376.919346209888;5684.232628595087;5694.943050569441;5712.828615141552;3970.682345412418;4523.954760452353;4959.13215187348;5340.51935325807;5644.096944488862;5409.214254658932;5642.322921249476;5648.85877853057;5677.403872593318;5719.484336650874;4659.394278743742;4793.520647935178;5041.823536176216;5591.748371323381;5638.407967163553 05:02:27 INFO - PROCESS | 1640 | |5;yui.html;707.6284950401039;713.9321764432378;723.9457040721948;782.7182214402814;852.8635418333068;14787.482438114655;15364.923175384136;15627.062376257432;15627.921860390683;15679.29443175057;14219.217943013131;14412;14417.207053612074;14439.20584367862;14447.205403702792;685.8696847598965;691.4537515362857;705.7988473285114;714.4570126703717;871.3029576338919;865.3207232322628;868.8609822428413;882.0517943211041;884.4118661090367;884.9690260840872;932.5943214701592;933.3653115881198;935.9157675809175;936.1621348892737;939.1219210038602;720.8017795106335;744.5086243079595;925.8842644669417;927.9907200928005;932.7248461703814;670.3665036540472;687.5599616245606;691.325957191734;692.1140939597324;694.6526736631685;14936;15004.174770387624;15027.248637568187;15038.473653422077;15116.017458865139;13182;13194.406251718696;13221.735565288736;13453.529126480624;13513.324333783272;13157.671058223525;13208.405621747044;13292.86707132926;13342.19946803195;13385.397657105355;4462.509123996358;4503.864884053451;4538.205813982573;4715.552022557851;4730.432348118248;88522.5573872133;107431;111707.06242076185;113387;114531.42734286358;10718.410487423267;10771.83842242367;10806.621768238074;10916;11248.212625116326;21172.788272117083;21471;21489.892550537148;21501.67747483789;21519.354419367442;7499.962500187573;7594.544327340377;7608.2011388804485;7668.463207575416;7818.100918394457;4228.154369126187;4237.322028475429;4277.593628605277;4284;4313.158934007838;3375.915602109967;3377.712894403954;3403.1662242750685;3477.2697733475748;3483.3555792178527;639.9552031357761;647.4302613699914;647.9028145778077;648.5751832549688;653.6111013946694;522.7673685210045;546.7894860478665;548.8929658716512;573.4917167848615;575.9280089988752;9349.859752103725;9745.805083898424;9956.452395118338;10005.04952029556;10026.047525485068;649.2371463530333;660.9339066093352;666.1629016862904;674.7672053141658;690.2648679156682;4482.8206871725415;4771.761411929389;4786.712797232177;4787.114383838932;4795.640326975491;77944;83198.58400708079;83254.58372708097;85404;108979;73309;73337;75078.24921750822;83365.91585210418;85001.57499212465;74473.25526744663;75979.62010189914;76289.61855190799;76584.23415765772;77632.61183694046;10806.945965270123;10852.294600850919;10961.616343427942;10995.505202265756;11113.333200008025;48290.75854620704;49321.753391232814;49695.25457118219;51486;51534.74232628813;65534.344656554735;65770.67114664588;66342.66828665826;67159.66420167868;68172.659136704;13003;13035.674108147372;13080.345982701017;13302.600921972356;13469.191848489121;14542.709145816812;14561.92719036398;14591.635209119857;14706;15350.462733804263;11644.2431241969;13441.773170078019;13597.116187447784;13927.791083133558;14008.719825603635;13689.315534223448;13715.862841371858;13888.513902013381;14050.946179036817;14388.424463021362;13150.21098734079;13498.73002539924;13649.931750341184;13777;13911.791323130363;9735.756606084622;11141.832872506757;11282;11305.095592352427;11545.307281563133;8256.83486330258;9274.860877086983;11062.944685276521;11075.612353567587;11088.889111109109 05:02:27 INFO - PROCESS | 1640 | __end_tp_report 05:02:27 INFO - PROCESS | 1640 | __start_cc_report 05:02:27 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,1643 05:02:27 INFO - PROCESS | 1640 | __end_cc_report 05:02:27 INFO - PROCESS | 1640 | __startTimestamp1484830947664__endTimestamp 05:02:27 INFO - PROCESS | 1640 | 05:02:27 INFO - PROCESS | 1640 | ------- Summary: start ------- 05:02:27 INFO - PROCESS | 1640 | Number of tests: 6 05:02:27 INFO - PROCESS | 1640 | 05:02:27 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5766.79 Median:5966.13 stddev:641.00 (10.7%) stddev-sans-first:614.80 05:02:27 INFO - PROCESS | 1640 | Values: 3371.2 3373.4 3384.5 3401.3 3419.6 5659.3 5722.6 5728.0 5768.5 5790.1 5681.6 5686.3 5730.5 5751.9 5779.8 5165.6 5171.0 5206.6 5241.8 5290.8 5292.1 5307.0 5331.5 5342.6 5370.7 5152.7 5184.7 5239.9 5252.3 5269.8 5155.4 5219.4 5231.7 5246.6 5313.6 5186.9 5198.0 5204.3 5209.9 5211.1 5741.9 5764.8 5769.8 5770.7 5786.5 6133.9 6187.4 6208.9 6239.2 6247.6 6164.7 6251.6 6268.8 6281.2 6288.9 5874.9 5893.8 5895.1 5909.1 5931.2 6136.9 6226.2 6236.6 6257.6 6268.5 6169.2 6214.8 6223.6 6226.3 6236.1 6136.7 6286.0 6294.9 6295.9 6305.6 6112.8 6134.8 6182.2 6222.2 6240.8 6281.8 6287.2 6297.7 6297.8 6321.6 4946.7 4988.4 5000.9 5009.7 5022.2 4415.2 4426.9 4453.1 4466.2 4515.2 4782.7 5722.9 5746.0 5763.9 5794.9 6246.6 6247.2 6256.2 6279.1 6310.1 5598.9 5635.1 5661.5 5720.3 5745.8 4754.8 5382.7 5439.1 5469.8 5518.6 6240.8 6296.1 6303.8 6327.5 6331.5 6159.3 6216.6 6295.2 6304.1 6322.3 6229.8 6237.7 6270.7 6335.0 6338.4 6232.3 6236.9 6260.2 6260.5 6269.0 6150.3 6255.4 6291.7 6293.6 6298.2 5929.5 6072.6 6119.7 6124.1 6188.5 6157.6 6171.2 6175.5 6179.6 6180.8 5851.1 5878.1 6067.8 6068.6 6111.4 6089.8 6115.8 6135.4 6143.9 6172.3 5934.2 5946.5 5956.3 5958.4 5966.1 05:02:27 INFO - PROCESS | 1640 | 05:02:27 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:68274.78 Median:40745.69 stddev:141477.68 (347.2%) stddev-sans-first:141783.00 05:02:27 INFO - PROCESS | 1640 | Values: 481.4 496.0 503.9 510.1 555.1 36398.8 40679.2 40708.8 44911.1 45110.8 43661.3 44125.8 44156.1 44235.0 44236.6 8688.6 9260.8 9460.7 9463.9 9503.9 8600.0 11115.5 11363.4 11375.0 11555.5 11328.2 11416.4 11428.7 11463.8 11482.4 8478.7 8683.3 11180.0 11292.3 11333.4 11012.4 11250.8 11269.3 11429.4 11436.0 41925.4 42101.0 42171.7 42258.8 42386.8 4094.5 4104.9 4110.3 4133.2 4133.5 30583.8 30908.7 31111.4 31388.9 31618.4 2690.7 3152.4 3175.4 3175.4 3202.2 471798.0 476879.0 477549.0 478008.0 481756.0 65659.0 66152.0 66162.7 66194.7 66218.7 68042.9 68093.0 68194.3 68269.0 68400.6 16061.5 16581.8 16585.3 16619.4 16895.9 11552.5 11801.6 12090.9 12381.6 12661.2 17957.2 17991.8 18547.9 18605.3 18622.7 6734.8 6782.0 6798.3 6862.0 6873.5 874.7 883.1 892.2 911.2 934.8 29800.0 31077.9 31220.0 31645.8 31812.8 1054.5 1055.6 1077.5 1108.4 1110.9 14190.9 16039.8 16086.8 16108.4 16554.4 588331.0 591710.0 593746.0 594635.0 598814.0 57635.4 57938.6 57969.8 58015.0 58033.4 1425.7 1444.6 1458.9 1481.0 1485.3 27778.6 30148.2 30555.2 30870.5 31404.8 54204.7 54458.0 54467.7 54613.0 54738.5 515905.0 517299.0 518099.4 519838.0 519870.0 35356.6 41481.8 42089.0 42159.4 42370.9 39153.8 48115.0 48930.0 49363.3 52625.2 39125.4 40303.2 40863.8 41872.8 42362.6 39819.8 40053.8 40782.6 41039.1 42003.0 34723.5 39168.0 39880.0 39998.8 40082.8 32914.7 33711.5 35035.3 35758.8 35769.6 22216.7 25436.9 25643.0 25795.0 26188.0 05:02:27 INFO - PROCESS | 1640 | 05:02:27 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:40327.78 Median:1540.42 stddev:123191.74 (7997.3%) stddev-sans-first:123500.79 05:02:27 INFO - PROCESS | 1640 | Values: 373.6 383.6 392.4 398.2 422.7 13479.7 19757.0 20359.5 21169.9 21170.4 16319.5 16722.8 20304.6 20863.3 20922.8 5708.0 6040.2 6047.8 6049.2 6054.3 5539.9 5783.3 5883.5 5921.2 6067.6 5826.2 5915.7 5930.6 5940.7 5952.5 5868.9 5921.1 6487.2 6574.4 6707.2 5763.1 5798.1 5884.4 5897.2 5916.1 13399.9 13594.0 23278.9 24944.8 26100.5 2634.2 2671.5 2698.9 2705.1 2707.2 10087.5 10544.9 10612.7 12548.6 14898.0 1782.7 1830.9 1839.1 1848.3 1865.2 94476.5 142870.0 145561.0 146776.3 148552.0 11270.2 11785.4 11795.1 11813.7 12006.5 15127.8 15463.2 15483.9 15643.8 15644.9 6574.8 7557.4 7822.8 7944.5 7955.6 7872.3 8288.2 8299.6 8371.0 8583.2 4756.7 4760.1 4765.9 4766.7 4890.0 1807.9 1811.5 1877.2 1999.1 2001.9 847.2 870.6 880.7 884.6 897.9 20662.8 22192.3 22292.3 22292.9 22323.1 762.9 910.2 912.3 919.2 958.4 5422.4 6766.7 6807.2 7000.9 7027.6 713139.0 719981.0 741425.0 747339.0 757652.0 163941.0 165780.0 166594.0 168058.0 171143.1 980.8 1051.6 1054.1 1076.8 1078.0 18432.9 19240.4 19288.0 19352.7 19372.3 39116.0 46490.8 47093.8 48492.8 57768.0 70132.0 87059.6 87183.6 88544.1 88631.9 8230.8 8238.8 8550.9 8567.6 8743.7 11498.9 12945.9 13079.2 13604.5 13768.3 11225.9 11501.8 11753.2 11794.2 11816.1 11414.7 11518.0 11626.6 11741.4 11905.1 9750.6 11353.8 11757.2 11758.7 11887.3 8419.8 8478.6 8497.4 8591.0 8596.7 9479.2 11649.1 11674.1 11677.9 11689.8 05:02:27 INFO - PROCESS | 1640 | 05:02:27 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5404.74 Median:5171.63 stddev:2936.99 (56.8%) stddev-sans-first:2928.50 05:02:27 INFO - PROCESS | 1640 | Values: 1233.5 1487.3 1492.3 1509.6 1513.0 8020.2 8394.3 8404.9 8415.2 8415.7 7465.5 7688.0 7700.0 7724.0 8088.6 2244.9 2285.8 2298.1 2301.9 2307.4 2276.9 2298.8 2310.2 2311.3 2324.0 2014.2 2097.4 2196.1 2269.4 2296.3 2145.7 2149.5 2153.4 2157.2 2158.3 2175.9 2223.2 2238.1 2298.7 2301.3 8338.8 8402.5 8405.7 8419.7 8423.8 5016.5 5165.3 5177.9 5183.7 5186.8 3125.6 3431.3 3431.7 3476.7 3527.3 1162.7 1191.5 1241.4 1248.6 1252.4 10705.5 10787.4 10813.0 10818.7 10830.9 3918.7 4416.7 4479.7 4592.0 4639.8 8181.9 9389.1 9424.2 9440.5 9455.3 5213.3 5214.3 5214.7 5217.3 5225.8 4617.5 4715.8 4732.8 4816.9 4844.4 3751.4 3797.0 3846.7 3906.4 3907.2 1256.7 1258.4 1258.8 1274.6 1279.3 889.4 908.7 921.9 940.3 956.2 5702.3 5754.3 5778.2 5936.9 6002.0 977.2 996.4 1003.6 1023.1 1059.7 3312.3 3596.7 3722.3 3847.3 3873.9 9760.5 10112.6 10117.3 10126.7 10152.9 9784.6 9982.6 10053.6 10087.1 10107.7 7541.1 7915.9 7946.4 7949.1 7974.6 5435.6 5525.0 5531.1 5532.1 5591.6 8946.6 9021.4 9039.4 9135.7 9284.1 7296.3 9346.9 9349.3 9465.0 9477.0 6594.0 6763.5 6765.7 6765.9 6767.2 7602.3 7733.0 7776.5 7820.3 7853.5 6012.3 7059.5 7207.4 7214.6 7323.6 7320.0 7322.5 7334.0 7338.6 7382.4 6297.7 6336.9 6387.3 6428.8 6507.2 4971.3 5000.0 5004.4 5042.1 5093.8 5032.7 5092.9 5102.4 5146.8 5219.8 05:02:27 INFO - PROCESS | 1640 | 05:02:27 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4489.71 Median:4877.65 stddev:1351.31 (27.7%) stddev-sans-first:1318.71 05:02:27 INFO - PROCESS | 1640 | Values: 339.2 351.7 359.7 361.6 363.4 5266.8 5353.6 5355.3 5390.5 5400.3 4417.6 4683.9 5296.9 5319.5 5420.3 3680.4 4183.6 4199.2 4231.4 4240.8 3568.9 3667.2 4061.9 4167.2 4178.0 3588.2 3853.7 4114.8 4129.6 4157.8 3637.4 4141.5 4147.6 4150.3 4164.4 3235.2 3246.4 3459.9 3482.7 3623.7 4582.4 4739.6 5189.5 5228.6 5269.9 4770.7 4805.9 4824.0 4876.9 4878.4 5458.8 5639.2 5662.2 5694.8 5713.9 4084.8 4088.4 4099.2 4099.4 4132.1 5663.3 5903.1 5944.7 6010.5 6011.7 4041.8 4132.1 4138.5 4143.5 4160.4 4186.9 4193.6 4198.9 4228.3 4230.5 3991.2 4150.8 4544.8 4756.8 4803.6 5196.9 5658.7 5685.1 5739.7 5774.4 1194.6 1248.9 1250.7 1345.9 1360.9 911.5 915.7 964.9 977.6 983.9 4322.5 4482.8 4632.5 4849.0 4926.2 4839.5 5439.4 5495.5 5496.8 5507.4 4495.8 4505.5 4795.4 4953.3 4963.0 2332.4 2460.8 2561.7 2825.7 2835.5 5667.9 5695.8 5704.7 5707.5 5732.1 4755.9 5205.5 5276.6 5322.9 5364.8 5110.7 5357.7 5385.7 5495.5 5727.9 4894.6 4993.5 5001.9 5204.2 5522.6 4704.0 5290.8 5449.0 5529.7 5778.8 4780.8 5730.4 5920.5 5952.4 6127.3 3346.6 3848.4 3889.0 3891.1 3896.7 4347.9 4922.7 5148.5 5806.0 5808.9 4817.0 5392.4 5668.9 5669.7 5679.7 4696.6 5376.9 5684.2 5694.9 5712.8 3970.7 4524.0 4959.1 5340.5 5644.1 5409.2 5642.3 5648.9 5677.4 5719.5 4659.4 4793.5 5041.8 5591.7 5638.4 05:02:27 INFO - PROCESS | 1640 | 05:02:27 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:19765.36 Median:4493.34 stddev:27622.37 (614.7%) stddev-sans-first:27662.79 05:02:27 INFO - PROCESS | 1640 | Values: 707.6 713.9 723.9 782.7 852.9 14787.5 15364.9 15627.1 15627.9 15679.3 14219.2 14412.0 14417.2 14439.2 14447.2 685.9 691.5 705.8 714.5 871.3 865.3 868.9 882.1 884.4 885.0 932.6 933.4 935.9 936.2 939.1 720.8 744.5 925.9 928.0 932.7 670.4 687.6 691.3 692.1 694.7 14936.0 15004.2 15027.2 15038.5 15116.0 13182.0 13194.4 13221.7 13453.5 13513.3 13157.7 13208.4 13292.9 13342.2 13385.4 4462.5 4503.9 4538.2 4715.6 4730.4 88522.6 107431.0 111707.1 113387.0 114531.4 10718.4 10771.8 10806.6 10916.0 11248.2 21172.8 21471.0 21489.9 21501.7 21519.4 7500.0 7594.5 7608.2 7668.5 7818.1 4228.2 4237.3 4277.6 4284.0 4313.2 3375.9 3377.7 3403.2 3477.3 3483.4 640.0 647.4 647.9 648.6 653.6 522.8 546.8 548.9 573.5 575.9 9349.9 9745.8 9956.5 10005.0 10026.0 649.2 660.9 666.2 674.8 690.3 4482.8 4771.8 4786.7 4787.1 4795.6 77944.0 83198.6 83254.6 85404.0 108979.0 73309.0 73337.0 75078.2 83365.9 85001.6 74473.3 75979.6 76289.6 76584.2 77632.6 10806.9 10852.3 10961.6 10995.5 11113.3 48290.8 49321.8 49695.3 51486.0 51534.7 65534.3 65770.7 66342.7 67159.7 68172.7 13003.0 13035.7 13080.3 13302.6 13469.2 14542.7 14561.9 14591.6 14706.0 15350.5 11644.2 13441.8 13597.1 13927.8 14008.7 13689.3 13715.9 13888.5 14050.9 14388.4 13150.2 13498.7 13649.9 13777.0 13911.8 9735.8 11141.8 11282.0 11305.1 11545.3 8256.8 9274.9 11062.9 11075.6 11088.9 05:02:27 INFO - PROCESS | 1640 | -------- Summary: end -------- 05:02:27 INFO - PROCESS | 1640 | 05:02:28 INFO - TEST-INFO | 1640: exit 0 05:02:28 INFO - TEST-OK | dromaeo_css | took 1118168ms 05:02:28 INFO - TEST-START | kraken 05:02:28 INFO - operating with platform_type : mac_ 05:02:28 INFO - Initialising browser for kraken test... 05:02:28 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmplSGZTT/profile http://localhost:49241/getInfo.html) 05:02:30 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 05:02:30 INFO - PROCESS | 1646 | colorDepth:24 05:02:30 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 05:02:30 INFO - PROCESS | 1646 | __metrics 05:02:30 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:02:30 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:02:31 INFO - TEST-INFO | 1646: exit 0 05:02:31 INFO - Browser initialized. 05:02:31 INFO - Running cycle 1/1 for kraken test... 05:02:31 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/T/tmplSGZTT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:43 INFO - PROCESS | 1648 | RSS: Main: 235139072 05:02:43 INFO - PROCESS | 1648 | 05:02:46 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 05:02:47 INFO - PROCESS | 1648 | RSS: Main: 286973952 05:02:47 INFO - PROCESS | 1648 | 05:02:49 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 05:02:50 INFO - PROCESS | 1648 | RSS: Main: 287301632 05:02:50 INFO - PROCESS | 1648 | 05:02:53 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 05:02:54 INFO - PROCESS | 1648 | RSS: Main: 378789888 05:02:54 INFO - PROCESS | 1648 | 05:02:56 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 05:02:56 INFO - PROCESS | 1648 | RSS: Main: 281722880 05:02:56 INFO - PROCESS | 1648 | 05:02:58 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:02:59 INFO - PROCESS | 1648 | RSS: Main: 285405184 05:02:59 INFO - PROCESS | 1648 | 05:03:02 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 05:03:02 INFO - PROCESS | 1648 | RSS: Main: 327725056 05:03:02 INFO - PROCESS | 1648 | 05:03:05 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 05:03:06 INFO - PROCESS | 1648 | RSS: Main: 328638464 05:03:06 INFO - PROCESS | 1648 | 05:03:09 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 05:03:09 INFO - PROCESS | 1648 | RSS: Main: 326959104 05:03:09 INFO - PROCESS | 1648 | 05:03:11 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:03:12 INFO - PROCESS | 1648 | RSS: Main: 303341568 05:03:12 INFO - PROCESS | 1648 | 05:03:13 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:03:14 INFO - PROCESS | 1648 | RSS: Main: 305692672 05:03:14 INFO - PROCESS | 1648 | 05:03:16 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:03:17 INFO - PROCESS | 1648 | RSS: Main: 307281920 05:03:17 INFO - PROCESS | 1648 | 05:03:20 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:03:21 INFO - PROCESS | 1648 | RSS: Main: 324177920 05:03:21 INFO - PROCESS | 1648 | 05:03:24 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:03:24 INFO - PROCESS | 1648 | RSS: Main: 317562880 05:03:24 INFO - PROCESS | 1648 | 05:03:26 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 05:03:26 INFO - PROCESS | 1648 | RSS: Main: 361865216 05:03:26 INFO - PROCESS | 1648 | 05:03:26 INFO - PROCESS | 1648 | __start_tp_report 05:03:26 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 05:03:26 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 05:03:26 INFO - PROCESS | 1648 | |i|pagename|runs| 05:03:26 INFO - PROCESS | 1648 | |0;ai-astar;112;112;113;112;111;112;112;112;112;113 05:03:26 INFO - PROCESS | 1648 | |1;audio-beat-detection;146;110;111;146;113;138;138;109;129;108 05:03:26 INFO - PROCESS | 1648 | |2;audio-dft;185;183;184;185;182;182;180;182;181;182 05:03:26 INFO - PROCESS | 1648 | |3;audio-fft;78;58;60;86;61;58;59;60;74;58 05:03:26 INFO - PROCESS | 1648 | |4;audio-oscillator;89;69;82;68;67;68;80;68;68;82 05:03:26 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;87;84;86;84;86;83;87;84;87;83 05:03:26 INFO - PROCESS | 1648 | |6;imaging-darkroom;98;110;157;158;97;97;98;97;98;96 05:03:26 INFO - PROCESS | 1648 | |7;imaging-desaturate;86;85;86;84;88;84;85;86;85;85 05:03:26 INFO - PROCESS | 1648 | |8;json-parse-financial;56;54;55;54;55;57;55;56;55;55 05:03:26 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;64;80;73;70;72;68;69;68;70;70 05:03:26 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;90;85;87;87;87;85;87;89;99;107 05:03:26 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;144;150;145;144;139;140;142;142;197;157 05:03:26 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;173;170;173;179;189;232;170;172;172;171 05:03:26 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;68;67;65;67;67;67;65;69;67;66 05:03:26 INFO - PROCESS | 1648 | __end_tp_report 05:03:26 INFO - PROCESS | 1648 | __start_cc_report 05:03:26 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1966 05:03:26 INFO - PROCESS | 1648 | __end_cc_report 05:03:26 INFO - PROCESS | 1648 | __startTimestamp1484831006770__endTimestamp 05:03:26 INFO - PROCESS | 1648 | 05:03:26 INFO - PROCESS | 1648 | ------- Summary: start ------- 05:03:26 INFO - PROCESS | 1648 | Number of tests: 14 05:03:26 INFO - PROCESS | 1648 | 05:03:26 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:03:26 INFO - PROCESS | 1648 | Values: 112.0 112.0 113.0 112.0 111.0 112.0 112.0 112.0 112.0 113.0 05:03:26 INFO - PROCESS | 1648 | 05:03:26 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:124.80 Median:133.50 stddev:16.14 (12.1%) stddev-sans-first:15.19 05:03:26 INFO - PROCESS | 1648 | Values: 146.0 110.0 111.0 146.0 113.0 138.0 138.0 109.0 129.0 108.0 05:03:26 INFO - PROCESS | 1648 | 05:03:26 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:182.60 Median:182.50 stddev:1.65 (0.9%) stddev-sans-first:1.50 05:03:26 INFO - PROCESS | 1648 | Values: 185.0 183.0 184.0 185.0 182.0 182.0 180.0 182.0 181.0 182.0 05:03:26 INFO - PROCESS | 1648 | 05:03:26 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:65.20 Median:60.50 stddev:10.22 (16.9%) stddev-sans-first:9.73 05:03:26 INFO - PROCESS | 1648 | Values: 78.0 58.0 60.0 86.0 61.0 58.0 59.0 60.0 74.0 58.0 05:03:26 INFO - PROCESS | 1648 | 05:03:26 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:74.10 Median:74.50 stddev:8.21 (11.0%) stddev-sans-first:6.71 05:03:26 INFO - PROCESS | 1648 | Values: 89.0 69.0 82.0 68.0 67.0 68.0 80.0 68.0 68.0 82.0 05:03:26 INFO - PROCESS | 1648 | 05:03:26 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:85.10 Median:86.00 stddev:1.66 (1.9%) stddev-sans-first:1.62 05:03:26 INFO - PROCESS | 1648 | Values: 87.0 84.0 86.0 84.0 86.0 83.0 87.0 84.0 87.0 83.0 05:03:26 INFO - PROCESS | 1648 | 05:03:26 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:110.60 Median:97.00 stddev:25.04 (25.8%) stddev-sans-first:26.14 05:03:26 INFO - PROCESS | 1648 | Values: 98.0 110.0 157.0 158.0 97.0 97.0 98.0 97.0 98.0 96.0 05:03:26 INFO - PROCESS | 1648 | 05:03:26 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:1.17 (1.4%) stddev-sans-first:1.22 05:03:26 INFO - PROCESS | 1648 | Values: 86.0 85.0 86.0 84.0 88.0 84.0 85.0 86.0 85.0 85.0 05:03:26 INFO - PROCESS | 1648 | 05:03:26 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:0.92 (1.7%) stddev-sans-first:0.93 05:03:26 INFO - PROCESS | 1648 | Values: 56.0 54.0 55.0 54.0 55.0 57.0 55.0 56.0 55.0 55.0 05:03:26 INFO - PROCESS | 1648 | 05:03:26 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.00 stddev:4.17 (6.0%) stddev-sans-first:3.72 05:03:26 INFO - PROCESS | 1648 | Values: 64.0 80.0 73.0 70.0 72.0 68.0 69.0 68.0 70.0 70.0 05:03:26 INFO - PROCESS | 1648 | 05:03:26 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:87.00 stddev:7.12 (8.2%) stddev-sans-first:7.55 05:03:26 INFO - PROCESS | 1648 | Values: 90.0 85.0 87.0 87.0 87.0 85.0 87.0 89.0 99.0 107.0 05:03:26 INFO - PROCESS | 1648 | 05:03:26 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:150.00 Median:144.50 stddev:17.33 (12.0%) stddev-sans-first:18.25 05:03:26 INFO - PROCESS | 1648 | Values: 144.0 150.0 145.0 144.0 139.0 140.0 142.0 142.0 197.0 157.0 05:03:26 INFO - PROCESS | 1648 | 05:03:26 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.10 Median:173.00 stddev:19.13 (11.1%) stddev-sans-first:20.11 05:03:26 INFO - PROCESS | 1648 | Values: 173.0 170.0 173.0 179.0 189.0 232.0 170.0 172.0 172.0 171.0 05:03:26 INFO - PROCESS | 1648 | 05:03:26 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.23 (1.8%) stddev-sans-first:1.22 05:03:26 INFO - PROCESS | 1648 | Values: 68.0 67.0 65.0 67.0 67.0 67.0 65.0 69.0 67.0 66.0 05:03:26 INFO - PROCESS | 1648 | -------- Summary: end -------- 05:03:26 INFO - PROCESS | 1648 | 05:03:27 INFO - TEST-INFO | 1648: exit 0 05:03:27 INFO - TEST-OK | kraken | took 59365ms 05:03:27 INFO - SUITE-END | took 1177s 05:03:27 INFO - Completed test suite (00:19:37) 05:03:27 INFO - javascript benchmark 05:03:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3371.1909141805963, 3373.3927892979254, 3384.5430866832985, 3401.302732939748, 3419.6238413774495, 5659.292588426447, 5722.628029178106, 5728.026235539958, 5768.480836724694, 5790.131480277961, 5681.630694004887, 5686.346070201928, 5730.484256416921, 5751.913721294173, 5779.797707080253, 5165.586753059765, 5171.0, 5206.583473322125, 5241.816536421226, 5290.788368465257, 5292.100342941709, 5306.973465132669, 5331.546818520411, 5342.572594192475, 5370.677759334433, 5152.716600586966, 5184.7407629618365, 5239.921401178985, 5252.264682944391, 5269.76286067126, 5155.381354237478, 5219.399769026572, 5231.686098834044, 5246.606504512139, 5313.57491400687, 5186.948130518685, 5197.974010129925, 5204.29741984831, 5209.921851172236, 5211.088059589557, 5741.885162296772, 5764.798232061899, 5769.798057068025, 5770.740316685759, 5786.47921687046, 6133.867031338107, 6187.412195841388, 6208.87582248357, 6239.220097487814, 6247.562670613059, 6164.660943648098, 6251.624902505864, 6268.78059267928, 6281.246250449975, 6288.9056664150075, 5874.9118763218585, 5893.764249429974, 5895.086261629454, 5909.084091965667, 5931.199288096138, 6136.856084434161, 6226.221722284715, 6236.6258024518675, 6257.5932564383165, 6268.529860260499, 6169.198004259418, 6214.844628884223, 6223.626582405071, 6226.346233645492, 6236.126942228092, 6136.7154341639325, 6286.0, 6294.905576416358, 6295.905561416583, 6305.558610897285, 6112.837854638568, 6134.77336474251, 6182.196314479089, 6222.222222222223, 6240.781572644935, 6281.811545653638, 6287.182666253358, 6297.685115744286, 6297.811065668037, 6321.55749097568, 4946.703197808143, 4988.426330971912, 5000.874978125576, 5009.674371165863, 5022.171341728647, 4415.205263052617, 4426.933595996063, 4453.109378124388, 4466.173757854807, 4515.232410490159, 4782.689125206851, 5722.914156287659, 5745.9712701437065, 5763.942360576424, 5794.88410231793, 6246.625202487865, 6247.219097612799, 6256.217972753406, 6279.058141278845, 6310.0850376695125, 5598.944010559842, 5635.070213414822, 5661.46216109469, 5720.256366672306, 5745.798897038583, 4754.833580824655, 5382.650127741685, 5439.102548079602, 5469.835904922858, 5518.586106042063, 6240.843978900564, 6296.087067375113, 6303.810885673437, 6327.4938004959495, 6331.493480521639, 6159.322474527888, 6216.595921265103, 6295.213098362705, 6304.05439184126, 6322.33615470369, 6229.813105606839, 6237.688115594293, 6270.655113968775, 6335.049742538656, 6338.366163383625, 6232.314445411092, 6236.875262494816, 6260.186175797117, 6260.530460215411, 6268.968655156695, 6150.292716337678, 6255.437010669061, 6291.653959032297, 6293.55945083858, 6298.212723409574, 5929.495992840657, 6072.574919755752, 6119.724612392542, 6124.112003759519, 6188.535859810442, 6157.599756016024, 6171.166892469639, 6175.505959523138, 6179.598326108789, 6180.752769889334, 5851.063829787384, 5878.088896221093, 6067.817965461043, 6068.575199735976, 6111.449969502766, 6089.817305480843, 6115.788007244377, 6135.355787642412, 6143.907841382294, 6172.259328880563, 5934.169216309807, 5946.464818166386, 5956.285245770535, 5958.374370691188, 5966.134910437875], "value": 5725.547527759113, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.38142486904314, 495.9702417854929, 503.87655024519, 510.0770096735308, 555.0757987950063, 36398.81800590997, 40679.18641627166, 40708.77873663791, 44911.101777964424, 45110.774446127725, 43661.34507982383, 44125.77937110318, 44156.116877662425, 44235.0, 44236.55763442365, 8688.56557172142, 9260.768480787983, 9460.716178514656, 9463.905360946372, 9503.857442138373, 8600.0, 11115.499802508906, 11363.431828408546, 11375.033122184625, 11555.480003399867, 11328.150388720878, 11416.42917854104, 11428.657140285804, 11463.770724585504, 11482.368469734161, 8478.66085356585, 8683.305335573139, 11179.993800557948, 11292.322460652387, 11333.376664283462, 11012.39431831249, 11250.774984500264, 11269.267497612711, 11429.428528573539, 11435.97076263132, 41925.371119433235, 42101.0, 42171.73484795461, 42258.78870605658, 42386.788066059475, 4094.508658960914, 4104.897377565585, 4110.301248787683, 4133.173365326947, 4133.4626498555, 30583.847080764455, 30908.690913090806, 31111.37777244465, 31388.861113888655, 31618.36763264745, 2690.6502154719956, 3152.3852848694514, 3175.364927014606, 3175.42842288388, 3202.247471844115, 471798.0, 476879.0, 477548.9999999965, 478008.0, 481756.0, 65659.0302290932, 66152.00771988423, 66162.66918665376, 66194.66902665456, 66218.66890665612, 68042.89678274149, 68093.0, 68194.31805681979, 68269.0, 68400.63198735997, 16061.518154455385, 16581.83418165803, 16585.25366358517, 16619.41832035873, 16895.915520422564, 11552.480138393792, 11801.645950621494, 12090.939545302217, 12381.62855114348, 12661.177023493443, 17957.191926363084, 17991.820081799015, 18547.907260463613, 18605.348812791486, 18622.720659190123, 6734.797956061326, 6781.966090169616, 6798.320167983261, 6862.0, 6873.518853680194, 874.6676263020012, 883.1168831168832, 892.2148509311764, 911.1617312072909, 934.8036912248368, 29800.0, 31077.912273070335, 31220.0, 31645.841770790998, 31812.84093579517, 1054.46222426563, 1055.5619417941468, 1077.498962982217, 1108.3737688206138, 1110.8722496912796, 14190.858091418953, 16039.759403608956, 16086.75869861953, 16108.436204732778, 16554.42059527935, 588331.0, 591710.0, 593746.0, 594635.0, 598814.0, 57635.42364576385, 57938.55153621109, 57969.840603188546, 58015.0, 58033.419665803645, 1425.6792221750022, 1444.5970807100482, 1458.8905832062637, 1480.985190148128, 1485.2944851195812, 27778.583321249793, 30148.24629384283, 30555.2361190972, 30870.53694194544, 31404.842975784974, 54204.72897635487, 54458.0, 54467.72766136144, 54613.0, 54738.45261547333, 515905.0, 517299.0, 518099.40950296517, 519838.0, 519870.0, 35356.64643353534, 41481.79259103685, 42089.0, 42159.36760948527, 42370.91549014138, 39153.82538523849, 48115.0, 48930.0, 49363.25955110748, 52625.21062184147, 39125.41311880267, 40303.1939361217, 40863.795681022595, 41872.790636047845, 42362.57637423586, 39819.800900996466, 40053.799731001156, 40782.59217407788, 41039.09005116003, 42003.0, 34723.4791478123, 39168.0, 39880.00299992524, 39998.80003599897, 40082.799586001885, 32914.67085329212, 33711.4943275856, 35035.299294013465, 35758.8212058938, 35769.56921723206, 22216.66674999844, 25436.872815635805, 25642.974281029296, 25795.0, 26188.0], "value": 20718.391252573074, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.6151763683406, 383.5914750790408, 392.4427313215234, 398.22545149683856, 422.69988308301106, 13479.730405391887, 19757.0, 20359.491012724688, 21169.894150529246, 21170.364889053333, 16319.510414687578, 16722.832771672278, 20304.593908121828, 20863.26978555751, 20922.849243291614, 5707.99999999999, 6040.1543783870075, 6047.758089676429, 6049.183360246377, 6054.303755068179, 5539.9169012464845, 5783.334916484595, 5883.47048765611, 5921.230240068785, 6067.605605635642, 5826.21346118275, 5915.674637894914, 5930.644161350311, 5940.732667029994, 5952.523798096164, 5868.882622347551, 5921.111833225008, 6487.18910136233, 6574.441172500343, 6707.228668703064, 5763.077907534816, 5798.1302804579655, 5884.352721200665, 5897.233359663259, 5916.1421593868645, 13399.933000335033, 13593.98045146618, 23278.883605582032, 24944.750552494424, 26100.477990440275, 2634.1702363755358, 2671.545837207679, 2698.8920443182446, 2705.066751970567, 2707.2284398946404, 10087.546060427298, 10544.945505449394, 10612.734681632945, 12548.623541293775, 14898.0, 1782.6612943540686, 1830.9450716478527, 1839.0712690091552, 1848.3253612431365, 1865.1742609945943, 94476.52761736147, 142870.0, 145561.0, 146776.2661186698, 148552.0, 11270.21108522412, 11785.410729463663, 11795.115366347558, 11813.704657383634, 12006.51973921051, 15127.848721512864, 15463.226838658022, 15483.922580387027, 15643.843561564467, 15644.921775391278, 6574.769883054166, 7557.35762460186, 7822.765317040498, 7944.483608565541, 7955.641996110073, 7872.252136047066, 8288.21261980111, 8299.626516806758, 8370.958145209357, 8583.227509524047, 4756.6908150970075, 4760.143913651781, 4765.9046819064115, 4766.666333356632, 4889.975550122226, 1807.8824876382994, 1811.5380577952537, 1877.2397179142197, 1999.1303782854213, 2001.9399418017483, 847.2332539052168, 870.5647176411794, 880.7489865388334, 884.566562384427, 897.8608315711075, 20662.793372066386, 22192.334229973127, 22292.331230063122, 22292.88535573215, 22323.107075717115, 762.8779395296726, 910.235402262103, 912.2975309012023, 919.2324409118328, 958.3962103874514, 5422.43064478232, 6766.661666916634, 6807.217170025411, 7000.92999070013, 7027.578345299298, 713139.0, 719981.0, 741425.0, 747339.0, 757652.0, 163941.0, 165780.0, 166594.0, 168058.0, 171143.14428427778, 980.8234517786724, 1051.6476980211714, 1054.0776820282406, 1076.838474228872, 1078.013617539942, 18432.907835460737, 19240.4227873164, 19288.0, 19352.70970935409, 19372.32196873159, 39116.0, 46490.76754616205, 47093.82265443391, 48492.75753621209, 57768.0, 70132.0, 87059.56470217608, 87183.56408217919, 88544.11455885616, 88631.89788357377, 8230.794230144294, 8238.794030149294, 8550.871736924075, 8567.614457349559, 8743.650253989768, 11498.94250528742, 12945.870541294467, 13079.215247085205, 13604.455821767018, 13768.311584420939, 11225.887741122484, 11501.769964600493, 11753.236039657395, 11794.225847728987, 11816.054715622558, 11414.657560273205, 11518.005318617052, 11626.593069242535, 11741.41292935367, 11905.107116966436, 9750.561224744763, 11353.772924541297, 11757.235779674294, 11758.706032348917, 11887.346195959306, 8419.83160336802, 8478.57607119654, 8497.447665901696, 8591.0, 8596.742097737078, 9479.231710667467, 11649.068074553847, 11674.124440666814, 11677.88322116768, 11689.824652630388], "value": 9695.664475093638, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1233.4819375862137, 1487.2563718140932, 1492.2613306413327, 1509.5848641623552, 1513.0, 8020.197980201977, 8394.328453723703, 8404.907362042934, 8415.20055594719, 8415.663373465053, 7465.514741541796, 7687.961560192205, 7700.0, 7723.9613801931055, 8088.555129467892, 2244.921427750025, 2285.7942785149335, 2298.069281940817, 2301.919432819852, 2307.3885420363617, 2276.9203077892275, 2298.839081264312, 2310.214527060799, 2311.3181611424584, 2324.035525257016, 2014.1943222710886, 2097.391756390645, 2196.099599164343, 2269.353234328217, 2296.2651951375565, 2145.678148277755, 2149.50561370884, 2153.3970488263235, 2157.244964262511, 2158.2769772126358, 2175.8912054397374, 2223.2440970070093, 2238.104758096758, 2298.6552017197387, 2301.3096071178747, 8338.83322333556, 8402.537860417675, 8405.663773449054, 8419.747407577783, 8423.83152336956, 5016.49835016499, 5165.302684137631, 5177.948220517822, 5183.714895680736, 5186.7925282988635, 3125.6092988376454, 3431.296584200233, 3431.7179075914487, 3476.721862251014, 3527.2945410917664, 1162.6686394377562, 1191.5174354386488, 1241.3855141704914, 1248.5630029489696, 1252.4238850128952, 10705.518251678694, 10787.406692631903, 10813.0, 10818.72953176169, 10830.945845270802, 3918.6669133123432, 4416.668749843775, 4479.656103169036, 4592.0, 4639.814407423665, 8181.918180818235, 9389.061093890556, 9424.151826335663, 9440.527973601293, 9455.338126331228, 5213.296205012275, 5214.348206474191, 5214.713190774468, 5217.295665085241, 5225.843224703265, 4617.468991066004, 4715.81136754526, 4732.763361831895, 4816.916193856354, 4844.442889067732, 3751.437284407361, 3797.0445220711354, 3846.673032792188, 3906.3945088511327, 3907.238088572701, 1256.6795467155816, 1258.3771033338555, 1258.797848055105, 1274.6048724895313, 1279.260206119695, 889.3641046651675, 908.7182973278304, 921.9124183202586, 940.2947789158131, 956.2397893674546, 5702.315722113373, 5754.280714910637, 5778.191053252548, 5936.872381046872, 6002.0, 977.1938151025432, 996.4220751963989, 1003.6437064841876, 1023.1456733627356, 1059.7244716373798, 3312.3375324934627, 3596.6762991330907, 3722.3299806035175, 3847.3267178243696, 3873.9418908716393, 9760.511974401252, 10112.595496180218, 10117.342372745896, 10126.696199114038, 10152.933941936139, 9784.608615655294, 9982.550785214682, 10053.59785608582, 10087.142592879542, 10107.69676909694, 7541.132769731441, 7915.9208407915185, 7946.364290856717, 7949.085855126735, 7974.641141148546, 5435.565154787529, 5525.0, 5531.115021596525, 5532.1425179097305, 5591.580631452739, 8946.597403117006, 9021.413608115452, 9039.412438191497, 9135.725928222164, 9284.071592840663, 7296.306850849161, 9346.859797103185, 9349.345545811728, 9464.95267523658, 9477.0, 6594.0, 6763.458923286224, 6765.661716914233, 6765.932340676531, 6767.221769496571, 7602.277783610548, 7732.961335193288, 7776.494527855672, 7820.257075578039, 7853.450258481851, 6012.3386427493815, 7059.470539709439, 7207.387372073433, 7214.603196824225, 7323.6338183089565, 7320.048393708784, 7322.524035937647, 7333.963330183315, 7338.596377199092, 7382.3724983377015, 6297.653629050446, 6336.936630633819, 6387.265464471645, 6428.8071357859335, 6507.186601674791, 4971.304017437489, 5000.049990501793, 5004.3994720633755, 5042.117629414911, 5093.770780314969, 5032.748362581783, 5092.898142037213, 5102.387713474407, 5146.845594632167, 5219.817306394258], "value": 4405.563586350427, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.2367173858818, 351.7133536168023, 359.658324591638, 361.6437808758373, 363.4294158171671, 5266.813577785438, 5353.625246232766, 5355.3305836770405, 5390.487903649157, 5400.29796126503, 4417.5582441755805, 4683.929741053887, 5296.947030529694, 5319.494648008433, 5420.349558053039, 3680.355937710903, 4183.602557757008, 4199.202151591203, 4231.428757117796, 4240.809163587631, 3568.892933212008, 3667.174885650734, 4061.8578349757763, 4167.208230436223, 4178.0, 3588.1567831559564, 3853.691704663634, 4114.794260286989, 4129.6283334499885, 4157.771322577272, 3637.436197389409, 4141.482314710646, 4147.6474499667565, 4150.27370210212, 4164.416981622575, 3235.1588586967323, 3246.4156451838658, 3459.930801383983, 3482.7162590014423, 3623.710103191738, 4582.427196600425, 4739.644526660514, 5189.506996835295, 5228.581713462914, 5269.947300526984, 4770.682532308232, 4805.927911081337, 4823.951760482385, 4876.878078048042, 4878.414590249157, 5458.836234912959, 5639.208591747111, 5662.235598194274, 5694.80749911283, 5713.914291285634, 4084.7549147051272, 4088.4276201331836, 4099.241640296555, 4099.385092236159, 4132.111596006843, 5663.290544693233, 5903.144044113579, 5944.702764861826, 6010.549208809357, 6011.723610632216, 4041.8480732990956, 4132.090939993197, 4138.482689663792, 4143.461350024478, 4160.375943608423, 4186.853460128881, 4193.643540299109, 4198.853040143641, 4228.344606585984, 4230.534641189467, 3991.16185601027, 4150.771707556113, 4544.840930567414, 4756.762161891892, 4803.567678908915, 5196.908649183638, 5658.688772117573, 5685.147227915846, 5739.741711622987, 5774.39368866263, 1194.6117511808698, 1248.9313087780258, 1250.6748245456247, 1345.880238624171, 1360.931953402326, 911.4941207629829, 915.665781989569, 964.8504481805331, 977.6264348590242, 983.9360441571275, 4322.502912165079, 4482.8206871725415, 4632.536746325341, 4848.95151048485, 4926.236433352836, 4839.516048395203, 5439.401665816757, 5495.477045569178, 5496.80761173357, 5507.421720719347, 4495.820167193276, 4505.5269196734525, 4795.400574928134, 4953.281774142729, 4963.0, 2332.402304421477, 2460.8400453970794, 2561.743825617423, 2825.675047369538, 2835.532137197339, 5667.8866422672145, 5695.75342055033, 5704.71476426177, 5707.543396528268, 5732.051102625044, 4755.904881902412, 5205.486296749679, 5276.630635855453, 5322.893542129135, 5364.839054828361, 5110.696772323034, 5357.732113394392, 5385.684155813038, 5495.455431246904, 5727.935554478334, 4894.608431325557, 4993.450720420823, 5001.899962000813, 5204.219367094966, 5522.591739106502, 4703.952960470351, 5290.761915713725, 5449.0, 5529.668219906657, 5778.8266352009505, 4780.808767649255, 5730.398308177748, 5920.526357891445, 5952.375000624872, 6127.264728232641, 3346.631870494195, 3848.365019771706, 3888.9694231029366, 3891.1439483313625, 3896.6687831533504, 4347.869533935562, 4922.704637721748, 5148.4851514848215, 5806.01297779387, 5808.912866306924, 4817.0, 5392.379876314274, 5668.943310566841, 5669.744861481326, 5679.716014199191, 4696.600788932842, 5376.919346209888, 5684.232628595087, 5694.943050569441, 5712.828615141552, 3970.682345412418, 4523.954760452353, 4959.13215187348, 5340.51935325807, 5644.096944488862, 5409.214254658932, 5642.322921249476, 5648.85877853057, 5677.403872593318, 5719.484336650874, 4659.394278743742, 4793.520647935178, 5041.823536176216, 5591.748371323381, 5638.407967163553], "value": 4075.9871294264613, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.6284950401039, 713.9321764432378, 723.9457040721948, 782.7182214402814, 852.8635418333068, 14787.482438114655, 15364.923175384136, 15627.062376257432, 15627.921860390683, 15679.29443175057, 14219.217943013131, 14412.0, 14417.207053612074, 14439.20584367862, 14447.205403702792, 685.8696847598965, 691.4537515362857, 705.7988473285114, 714.4570126703717, 871.3029576338919, 865.3207232322628, 868.8609822428413, 882.0517943211041, 884.4118661090367, 884.9690260840872, 932.5943214701592, 933.3653115881198, 935.9157675809175, 936.1621348892737, 939.1219210038602, 720.8017795106335, 744.5086243079595, 925.8842644669417, 927.9907200928005, 932.7248461703814, 670.3665036540472, 687.5599616245606, 691.325957191734, 692.1140939597324, 694.6526736631685, 14936.0, 15004.174770387624, 15027.248637568187, 15038.473653422077, 15116.017458865139, 13182.0, 13194.406251718696, 13221.735565288736, 13453.529126480624, 13513.324333783272, 13157.671058223525, 13208.405621747044, 13292.86707132926, 13342.19946803195, 13385.397657105355, 4462.509123996358, 4503.864884053451, 4538.205813982573, 4715.552022557851, 4730.432348118248, 88522.5573872133, 107431.0, 111707.06242076185, 113387.0, 114531.42734286358, 10718.410487423267, 10771.83842242367, 10806.621768238074, 10916.0, 11248.212625116326, 21172.788272117083, 21471.0, 21489.892550537148, 21501.67747483789, 21519.354419367442, 7499.962500187573, 7594.544327340377, 7608.2011388804485, 7668.463207575416, 7818.100918394457, 4228.154369126187, 4237.322028475429, 4277.593628605277, 4284.0, 4313.158934007838, 3375.915602109967, 3377.712894403954, 3403.1662242750685, 3477.2697733475748, 3483.3555792178527, 639.9552031357761, 647.4302613699914, 647.9028145778077, 648.5751832549688, 653.6111013946694, 522.7673685210045, 546.7894860478665, 548.8929658716512, 573.4917167848615, 575.9280089988752, 9349.859752103725, 9745.805083898424, 9956.452395118338, 10005.04952029556, 10026.047525485068, 649.2371463530333, 660.9339066093352, 666.1629016862904, 674.7672053141658, 690.2648679156682, 4482.8206871725415, 4771.761411929389, 4786.712797232177, 4787.114383838932, 4795.640326975491, 77944.0, 83198.58400708079, 83254.58372708097, 85404.0, 108979.0, 73309.0, 73337.0, 75078.24921750822, 83365.91585210418, 85001.57499212465, 74473.25526744663, 75979.62010189914, 76289.61855190799, 76584.23415765772, 77632.61183694046, 10806.945965270123, 10852.294600850919, 10961.616343427942, 10995.505202265756, 11113.333200008025, 48290.75854620704, 49321.753391232814, 49695.25457118219, 51486.0, 51534.74232628813, 65534.344656554735, 65770.67114664588, 66342.66828665826, 67159.66420167868, 68172.659136704, 13003.0, 13035.674108147372, 13080.345982701017, 13302.600921972356, 13469.191848489121, 14542.709145816812, 14561.92719036398, 14591.635209119857, 14706.0, 15350.462733804263, 11644.2431241969, 13441.773170078019, 13597.116187447784, 13927.791083133558, 14008.719825603635, 13689.315534223448, 13715.862841371858, 13888.513902013381, 14050.946179036817, 14388.424463021362, 13150.21098734079, 13498.73002539924, 13649.931750341184, 13777.0, 13911.791323130363, 9735.756606084622, 11141.832872506757, 11282.0, 11305.095592352427, 11545.307281563133, 8256.83486330258, 9274.860877086983, 11062.944685276521, 11075.612353567587, 11088.889111109109], "value": 7437.578591998907, "unit": "score"}], "name": "dromaeo_css", "value": 7318.312016201137, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 113.0, 112.0, 111.0, 112.0, 112.0, 112.0, 112.0, 113.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 110.0, 111.0, 146.0, 113.0, 138.0, 138.0, 109.0, 129.0, 108.0], "value": 124.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 184.0, 185.0, 182.0, 182.0, 180.0, 182.0, 181.0, 182.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 60.0, 86.0, 61.0, 58.0, 59.0, 60.0, 74.0, 58.0], "value": 65.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 82.0, 68.0, 67.0, 68.0, 80.0, 68.0, 68.0, 82.0], "value": 74.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 84.0, 86.0, 83.0, 87.0, 84.0, 87.0, 83.0], "value": 85.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 110.0, 157.0, 158.0, 97.0, 97.0, 98.0, 97.0, 98.0, 96.0], "value": 110.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 84.0, 88.0, 84.0, 85.0, 86.0, 85.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 54.0, 55.0, 57.0, 55.0, 56.0, 55.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 80.0, 73.0, 70.0, 72.0, 68.0, 69.0, 68.0, 70.0, 70.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 85.0, 87.0, 87.0, 87.0, 85.0, 87.0, 89.0, 99.0, 107.0], "value": 90.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 150.0, 145.0, 144.0, 139.0, 140.0, 142.0, 142.0, 197.0, 157.0], "value": 150.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 173.0, 179.0, 189.0, 232.0, 170.0, 172.0, 172.0, 171.0], "value": 180.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 65.0, 67.0, 67.0, 67.0, 65.0, 69.0, 67.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1452.6999999999998, "alertThreshold": 2.0}]} 05:03:28 INFO - Return code: 0 05:03:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:03:28 ERROR - # TBPL SUCCESS # 05:03:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:03:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:03:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:03:28 INFO - 2017-01-19 05:03:28.100 screenresolution[1652:10062] starting screenresolution argv=screenresolution get 05:03:28 INFO - 2017-01-19 05:03:28.103 screenresolution[1652:10062] Display 0: 1600x1200x32@60 05:03:28 INFO - 2017-01-19 05:03:28.110 screenresolution[1653:10066] starting screenresolution argv=screenresolution list 05:03:28 INFO - Available Modes on Display 0 05:03:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:03:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:03:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:03:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:03:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:03:28 INFO - Intel Iris: 05:03:28 INFO - Chipset Model: Intel Iris 05:03:28 INFO - Type: GPU 05:03:28 INFO - Bus: Built-In 05:03:28 INFO - VRAM (Dynamic, Max): 1536 MB 05:03:28 INFO - Vendor: Intel (0x8086) 05:03:28 INFO - Device ID: 0x0a2e 05:03:28 INFO - Revision ID: 0x0009 05:03:28 INFO - Displays: 05:03:28 INFO - Display: 05:03:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:03:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:03:28 INFO - Display Serial Number: 1600x1200 60 05:03:28 INFO - Main Display: Yes 05:03:28 INFO - Mirror: Off 05:03:28 INFO - Online: Yes 05:03:28 INFO - Rotation: Supported 05:03:28 INFO - Return code: 0 05:03:28 INFO - Running post-action listener: _resource_record_post_action 05:03:28 INFO - [mozharness: 2017-01-19 13:03:28.345499Z] Finished run-tests step (success) 05:03:28 INFO - Running post-run listener: _resource_record_post_run 05:03:28 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 37991424; Write bytes: 555071488; Read time: 249; Write time: 1652 05:03:28 INFO - TinderboxPrint: CPU usage
53.6% 05:03:28 INFO - TinderboxPrint: I/O read bytes / time
37,991,424 / 249 05:03:28 INFO - TinderboxPrint: I/O write bytes / time
555,071,488 / 1,652 05:03:28 INFO - TinderboxPrint: CPU idle
2,227.3 (46.4%) 05:03:28 INFO - TinderboxPrint: CPU system
957.3 (19.9%) 05:03:28 INFO - TinderboxPrint: CPU user
1,617.2 (33.7%) 05:03:28 INFO - TinderboxPrint: Swap in / out
288,501,760 / 0 05:03:28 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 252670464; Write bytes: 242779648; Read time: 17854; Write time: 519 05:03:28 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 30403584; Write bytes: 298582528; Read time: 178; Write time: 1100 05:03:28 INFO - Running post-run listener: _upload_blobber_files 05:03:28 INFO - Blob upload gear active. 05:03:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:03:28 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 05:03:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:03:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:03:29 INFO - (blobuploader) - INFO - Open directory for files ... 05:03:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:03:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:03:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:30 INFO - (blobuploader) - INFO - Done attempting. 05:03:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:03:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:03:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:31 INFO - (blobuploader) - INFO - Done attempting. 05:03:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:03:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:03:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:32 INFO - (blobuploader) - INFO - Done attempting. 05:03:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:03:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:03:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:34 INFO - (blobuploader) - INFO - Done attempting. 05:03:34 INFO - (blobuploader) - INFO - Iteration through files over. 05:03:34 INFO - Return code: 0 05:03:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:03:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:03:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a347fd1e04aa203e25ecc2f4d114361a530995a583e7421271076da4a9f5a724cde02f65878a42453df86ba79be92317703af27788bebc68b5be6faa720ceaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2816101a576f42a3ed232da4f42fd20bbaddb6900c55b430a0e2121113775e0d83c3cce932d7fd969d6b04a0bfb3fb459cbc2a01526d5c21396fc1ad5c7a1b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97b7ffbb8386053bd80ed3f89cfa5dbff9feefc74135f805a84bca507ecdd56c09eb8791e469a6d8cecdb2d106a337b1e8b051501f86f1f21100b6bb8790e1fd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93578436272451b3bc6f63e76084077f741baeea5c976f41a2127be09c1212bea6ae9316c966ca3f7e76b82bd2eca151f4b0a9e71b3bee06480240deb2beff5d"} 05:03:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:03:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:03:34 INFO - Contents: 05:03:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a347fd1e04aa203e25ecc2f4d114361a530995a583e7421271076da4a9f5a724cde02f65878a42453df86ba79be92317703af27788bebc68b5be6faa720ceaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2816101a576f42a3ed232da4f42fd20bbaddb6900c55b430a0e2121113775e0d83c3cce932d7fd969d6b04a0bfb3fb459cbc2a01526d5c21396fc1ad5c7a1b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97b7ffbb8386053bd80ed3f89cfa5dbff9feefc74135f805a84bca507ecdd56c09eb8791e469a6d8cecdb2d106a337b1e8b051501f86f1f21100b6bb8790e1fd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93578436272451b3bc6f63e76084077f741baeea5c976f41a2127be09c1212bea6ae9316c966ca3f7e76b82bd2eca151f4b0a9e71b3bee06480240deb2beff5d"} 05:03:34 INFO - Running post-run listener: copy_logs_to_upload_dir 05:03:34 INFO - Copying logs to upload dir... 05:03:34 INFO - mkdir: /builds/slave/test/build/upload/logs 05:03:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.387612 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-01-19 05:03:34.856526) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 05:03:34.859974) ========= 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.QFMWWkTRcg/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.SnakfDxIFx/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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/Firefox/sha512/8a347fd1e04aa203e25ecc2f4d114361a530995a583e7421271076da4a9f5a724cde02f65878a42453df86ba79be92317703af27788bebc68b5be6faa720ceaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2816101a576f42a3ed232da4f42fd20bbaddb6900c55b430a0e2121113775e0d83c3cce932d7fd969d6b04a0bfb3fb459cbc2a01526d5c21396fc1ad5c7a1b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97b7ffbb8386053bd80ed3f89cfa5dbff9feefc74135f805a84bca507ecdd56c09eb8791e469a6d8cecdb2d106a337b1e8b051501f86f1f21100b6bb8790e1fd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93578436272451b3bc6f63e76084077f741baeea5c976f41a2127be09c1212bea6ae9316c966ca3f7e76b82bd2eca151f4b0a9e71b3bee06480240deb2beff5d"} build_url:https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010424 build_url: 'https://queue.taskcluster.net/v1/task/JbWLHm7rR_-5EaWVBKZelQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a347fd1e04aa203e25ecc2f4d114361a530995a583e7421271076da4a9f5a724cde02f65878a42453df86ba79be92317703af27788bebc68b5be6faa720ceaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2816101a576f42a3ed232da4f42fd20bbaddb6900c55b430a0e2121113775e0d83c3cce932d7fd969d6b04a0bfb3fb459cbc2a01526d5c21396fc1ad5c7a1b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97b7ffbb8386053bd80ed3f89cfa5dbff9feefc74135f805a84bca507ecdd56c09eb8791e469a6d8cecdb2d106a337b1e8b051501f86f1f21100b6bb8790e1fd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93578436272451b3bc6f63e76084077f741baeea5c976f41a2127be09c1212bea6ae9316c966ca3f7e76b82bd2eca151f4b0a9e71b3bee06480240deb2beff5d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 05:03:34.897731) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 05:03:34.898065) ========= 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.QFMWWkTRcg/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.SnakfDxIFx/Listeners TMPDIR=/var/folders/64/m7jhlc3x3b32lz348yvd80pc00000w/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.004992 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 05:03:34.949090) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 05:03:34.949871) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 05:03:34.950572) ========= ========= Total master_lag: 0.27 =========