builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0017 starttime: 1488495024.41 results: success (0) buildid: 20170302130952 builduid: 6adc6ae18d3d420e98fc6618fb07e0d5 revision: c54c652af04c5a918610bc3d419250177a68b9f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 14:50:24.413053) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 14:50:24.413593) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 14:50:24.413901) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 14:50:24.441104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 14:50:24.441669) ========= 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.zWjH27EB8u/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.UY2SndPSIh/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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-03-02 14:50:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 155M=0s 2017-03-02 14:50:24 (155 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093743 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 14:50:24.560505) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 14:50:24.560810) ========= 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.zWjH27EB8u/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.UY2SndPSIh/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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.027060 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 14:50:24.610364) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 14:50:24.610700) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c54c652af04c5a918610bc3d419250177a68b9f7 --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 c54c652af04c5a918610bc3d419250177a68b9f7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zWjH27EB8u/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.UY2SndPSIh/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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-03-02 14:50:24,915 truncating revision to first 12 chars 2017-03-02 14:50:24,915 Setting DEBUG logging. 2017-03-02 14:50:24,915 attempt 1/10 2017-03-02 14:50:24,915 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c54c652af04c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-02 14:50:25,334 unpacking tar archive at: mozilla-central-c54c652af04c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.708939 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 14:50:25.343157) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 14:50:25.343460) ========= script_repo_revision: c54c652af04c5a918610bc3d419250177a68b9f7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 14:50:25.343842) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 14:50:25.344153) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 14:50:25.364373) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-03-02 14:50:25.364766) ========= /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.zWjH27EB8u/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.UY2SndPSIh/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 14:50:25 INFO - MultiFileLogger online at 20170302 14:50:25 in /builds/slave/test 14:50:25 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 14:50:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:50:25 INFO - {'append_to_log': False, 14:50:25 INFO - 'base_work_dir': '/builds/slave/test', 14:50:25 INFO - 'blob_upload_branch': 'Firefox', 14:50:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:50:25 INFO - 'branch': 'Firefox', 14:50:25 INFO - 'buildbot_json_path': 'buildprops.json', 14:50:25 INFO - 'config_files': ('talos/mac_config.py',), 14:50:25 INFO - 'default_actions': ('clobber', 14:50:25 INFO - 'read-buildbot-config', 14:50:25 INFO - 'download-and-extract', 14:50:25 INFO - 'populate-webroot', 14:50:25 INFO - 'create-virtualenv', 14:50:25 INFO - 'install', 14:50:25 INFO - 'run-tests'), 14:50:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:50:25 INFO - 'download_minidump_stackwalk': True, 14:50:25 INFO - 'download_symbols': 'ondemand', 14:50:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:50:25 INFO - 'tooltool.py': '/tools/tooltool.py', 14:50:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:50:25 INFO - '/tools/misc-python/virtualenv.py')}, 14:50:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:50:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:50:25 INFO - 'gecko_profile': False, 14:50:25 INFO - 'gecko_profile_interval': 0, 14:50:25 INFO - 'installer_path': 'installer.exe', 14:50:25 INFO - 'log_level': 'info', 14:50:25 INFO - 'log_name': 'talos', 14:50:25 INFO - 'log_to_console': True, 14:50:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:50:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:50:25 INFO - 'opt_config_files': (), 14:50:25 INFO - 'pip_index': False, 14:50:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:50:25 INFO - 'cmd': ('bash', 14:50:25 INFO - '-c', 14:50:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:50:25 INFO - 'enabled': True, 14:50:25 INFO - 'halt_on_failure': False, 14:50:25 INFO - 'name': 'check_screen_resolution'},), 14:50:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:50:25 INFO - 'cmd': ('bash', 14:50:25 INFO - '-c', 14:50:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:50:25 INFO - 'enabled': True, 14:50:25 INFO - 'halt_on_failure': False, 14:50:25 INFO - 'name': 'check_screen_resolution'},), 14:50:25 INFO - 'run_cmd_checks_enabled': True, 14:50:25 INFO - 'suite': 'dromaeojs', 14:50:25 INFO - 'system_bits': '32', 14:50:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:50:25 INFO - 'title': 't-yosemite-r7-0017', 14:50:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:50:25 INFO - 'use_talos_json': True, 14:50:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:50:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:50:25 INFO - 'work_dir': 'build'} 14:50:25 INFO - [mozharness: 2017-03-02 22:50:25.784848Z] Running clobber step. 14:50:25 INFO - Running pre-action listener: _resource_record_pre_action 14:50:25 INFO - Running main action method: clobber 14:50:25 INFO - rmtree: /builds/slave/test/build 14:50:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:50:28 INFO - Running post-action listener: _resource_record_post_action 14:50:28 INFO - [mozharness: 2017-03-02 22:50:28.335132Z] Finished clobber step (success) 14:50:28 INFO - [mozharness: 2017-03-02 22:50:28.335301Z] Running read-buildbot-config step. 14:50:28 INFO - Running pre-action listener: _resource_record_pre_action 14:50:28 INFO - Running main action method: read_buildbot_config 14:50:28 INFO - Using buildbot properties: 14:50:28 INFO - { 14:50:28 INFO - "project": "", 14:50:28 INFO - "product": "firefox", 14:50:28 INFO - "script_repo_revision": "production", 14:50:28 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 14:50:28 INFO - "repository": "", 14:50:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 14:50:28 INFO - "buildid": "20170302130952", 14:50:28 INFO - "pgo_build": "False", 14:50:28 INFO - "basedir": "/builds/slave/test", 14:50:28 INFO - "buildnumber": 13, 14:50:28 INFO - "slavename": "t-yosemite-r7-0017", 14:50:28 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:50:28 INFO - "platform": "yosemite_r7", 14:50:28 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:50:28 INFO - "branch": "mozilla-central", 14:50:28 INFO - "repo_path": "mozilla-central", 14:50:28 INFO - "revision": "c54c652af04c5a918610bc3d419250177a68b9f7", 14:50:28 INFO - "stage_platform": "macosx64", 14:50:28 INFO - "builduid": "6adc6ae18d3d420e98fc6618fb07e0d5", 14:50:28 INFO - "slavebuilddir": "test" 14:50:28 INFO - } 14:50:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 14:50:28 INFO - Running post-action listener: _resource_record_post_action 14:50:28 INFO - [mozharness: 2017-03-02 22:50:28.338827Z] Finished read-buildbot-config step (success) 14:50:28 INFO - [mozharness: 2017-03-02 22:50:28.338966Z] Running download-and-extract step. 14:50:28 INFO - Running pre-action listener: _resource_record_pre_action 14:50:28 INFO - Running main action method: download_and_extract 14:50:28 INFO - mkdir: /builds/slave/test/build/tests 14:50:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:28 INFO - trying https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 14:50:28 INFO - Downloading https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 14:50:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 14:50:29 INFO - Downloaded 1199 bytes. 14:50:29 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 14:50:29 INFO - Using the following test package requirements: 14:50:29 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 14:50:29 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:50:29 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 14:50:29 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:50:29 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 14:50:29 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:50:29 INFO - u'jsshell-mac.zip'], 14:50:29 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:50:29 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 14:50:29 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 14:50:29 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:50:29 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 14:50:29 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:50:29 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 14:50:29 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:50:29 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 14:50:29 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 14:50:29 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 14:50:29 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:50:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 14:50:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:50:29 INFO - Fetch https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 14:50:30 INFO - Expected file size: 51766754 14:50:30 INFO - Obtained file size: 51766754 14:50:46 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:50:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 14:50:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:50:46 INFO - Fetch https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 14:50:49 INFO - Expected file size: 51766754 14:50:49 INFO - Obtained file size: 51766754 14:51:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 14:51:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:51:04 INFO - Fetch https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 14:51:06 INFO - Expected file size: 14404424 14:51:06 INFO - Obtained file size: 14404424 14:51: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')]} 14:51:06 INFO - trying https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 14:51:06 INFO - Downloading https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 14:51:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 14:51:08 INFO - Downloaded 75019973 bytes. 14:51:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 14:51:08 INFO - mkdir: /builds/slave/test/properties 14:51:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:51:08 INFO - Writing to file /builds/slave/test/properties/build_url 14:51:08 INFO - Contents: 14:51:08 INFO - build_url:https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 14:51:09 INFO - Running post-action listener: _resource_record_post_action 14:51:09 INFO - Running post-action listener: set_extra_try_arguments 14:51:09 INFO - [mozharness: 2017-03-02 22:51:09.507337Z] Finished download-and-extract step (success) 14:51:09 INFO - [mozharness: 2017-03-02 22:51:09.507479Z] Running populate-webroot step. 14:51:09 INFO - Running pre-action listener: _resource_record_pre_action 14:51:09 INFO - Running main action method: populate_webroot 14:51:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:51:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:51:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:51:09 INFO - '--tppagecycles', 14:51:09 INFO - '7'], 14:51:09 INFO - 'tests': ['tsvgm']}}, 14:51:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:51:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:51:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:51:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:51:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:51:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:51:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:51:09 INFO - 'talos_options': ['--disable-e10s'], 14:51:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:51:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:51:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:51:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:51:09 INFO - 'talos_options': ['--disable-e10s'], 14:51:09 INFO - 'tests': ['damp', 'tps']}, 14:51:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:51:09 INFO - 'tests': ['damp', 'tps']}, 14:51:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:51:09 INFO - 'tests': ['dromaeo_dom']}, 14:51:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:51:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:51:09 INFO - 'tests': ['basic_compositor_video']}, 14:51:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:51:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:51:09 INFO - 'tests': ['a11yr', 14:51:09 INFO - 'ts_paint', 14:51:09 INFO - 'tpaint', 14:51:09 INFO - 'sessionrestore', 14:51:09 INFO - 'sessionrestore_no_auto_restore', 14:51:09 INFO - 'tabpaint']}, 14:51:09 INFO - 'other-e10s': {'tests': ['a11yr', 14:51:09 INFO - 'ts_paint', 14:51:09 INFO - 'tpaint', 14:51:09 INFO - 'sessionrestore', 14:51:09 INFO - 'sessionrestore_no_auto_restore', 14:51:09 INFO - 'tabpaint']}, 14:51:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:51:09 INFO - 'ts_paint', 14:51:09 INFO - 'tpaint', 14:51:09 INFO - 'sessionrestore', 14:51:09 INFO - 'sessionrestore_no_auto_restore', 14:51:09 INFO - 'tabpaint']}, 14:51:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:51:09 INFO - 'ts_paint', 14:51:09 INFO - 'tpaint', 14:51:09 INFO - 'sessionrestore', 14:51:09 INFO - 'sessionrestore_no_auto_restore', 14:51:09 INFO - 'tabpaint']}, 14:51:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:51:09 INFO - 'tests': ['a11yr', 14:51:09 INFO - 'ts_paint', 14:51:09 INFO - 'tpaint', 14:51:09 INFO - 'sessionrestore', 14:51:09 INFO - 'sessionrestore_no_auto_restore', 14:51:09 INFO - 'tabpaint']}, 14:51:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:51:09 INFO - 'tests': ['a11yr', 14:51:09 INFO - 'ts_paint', 14:51:09 INFO - 'tpaint', 14:51:09 INFO - 'sessionrestore', 14:51:09 INFO - 'sessionrestore_no_auto_restore', 14:51:09 INFO - 'tabpaint']}, 14:51:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:51:09 INFO - 'tests': ['tsvgx', 14:51:09 INFO - 'tsvgr_opacity', 14:51:09 INFO - 'tart', 14:51:09 INFO - 'tscrollx', 14:51:09 INFO - 'cart', 14:51:09 INFO - 'tsvg_static']}, 14:51:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:51:09 INFO - 'tsvgr_opacity', 14:51:09 INFO - 'tart', 14:51:09 INFO - 'tscrollx', 14:51:09 INFO - 'cart', 14:51:09 INFO - 'tsvg_static']}, 14:51:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:51:09 INFO - 'talos_options': ['--disable-e10s'], 14:51:09 INFO - 'tests': ['tp5o']}, 14:51:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:51:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:51:09 INFO - 'talos_options': ['--disable-e10s', 14:51:09 INFO - '--xperf_path', 14:51:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:51:09 INFO - 'tests': ['tp5n']}, 14:51:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:51:09 INFO - 'talos_options': ['--xperf_path', 14:51:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:51:09 INFO - 'tests': ['tp5n']}}, 14:51:09 INFO - 'talos.zip': {'path': '', 14:51:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:51:09 INFO - Running post-action listener: _resource_record_post_action 14:51:09 INFO - [mozharness: 2017-03-02 22:51:09.525993Z] Finished populate-webroot step (success) 14:51:09 INFO - [mozharness: 2017-03-02 22:51:09.526140Z] Running create-virtualenv step. 14:51:09 INFO - Running pre-action listener: _resource_record_pre_action 14:51:09 INFO - Running main action method: create_virtualenv 14:51:09 INFO - Creating virtualenv /builds/slave/test/build/venv 14:51:09 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 14:51:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:51:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:51:09 INFO - Using real prefix '/tools/python27' 14:51:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:51:10 INFO - Installing distribute.............................................................................................................................................................................................done. 14:51:13 INFO - Installing pip.................done. 14:51:13 INFO - Return code: 0 14:51:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:51:13 INFO - Reading from file tmpfile_stdout 14:51:13 INFO - Output received: 14:51:13 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) 14:51:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:51:13 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')]} 14:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:13 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')]} 14:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:13 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 0x10b361b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b364768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5ad67680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b13fd30>, '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 0x10b066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b134be8>, '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.zWjH27EB8u/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.UY2SndPSIh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 14:51:13 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 14:51:13 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 14:51:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWjH27EB8u/Render', 14:51:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:13 INFO - 'HOME': '/Users/cltbld', 14:51:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:13 INFO - 'LOGNAME': 'cltbld', 14:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:13 INFO - 'MOZ_NO_REMOTE': '1', 14:51:13 INFO - 'NO_EM_RESTART': '1', 14:51:13 INFO - 'PAGER': '/bin/cat', 14:51:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:13 INFO - 'PWD': '/builds/slave/test', 14:51:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:13 INFO - 'SHELL': '/bin/bash', 14:51:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UY2SndPSIh/Listeners', 14:51:13 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 14:51:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:13 INFO - 'USER': 'cltbld', 14:51:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:13 INFO - 'XPC_FLAGS': '0x0', 14:51:13 INFO - 'XPC_SERVICE_NAME': '0', 14:51:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:13 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 14:51:13 INFO - Cleaning up... 14:51:13 INFO - Return code: 0 14:51:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:51:13 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')]} 14:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:13 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')]} 14:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:13 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 0x10b361b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b364768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5ad67680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b13fd30>, '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 0x10b066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b134be8>, '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.zWjH27EB8u/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.UY2SndPSIh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 14:51:13 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 14:51:13 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 14:51:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWjH27EB8u/Render', 14:51:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:13 INFO - 'HOME': '/Users/cltbld', 14:51:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:13 INFO - 'LOGNAME': 'cltbld', 14:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:13 INFO - 'MOZ_NO_REMOTE': '1', 14:51:13 INFO - 'NO_EM_RESTART': '1', 14:51:13 INFO - 'PAGER': '/bin/cat', 14:51:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:13 INFO - 'PWD': '/builds/slave/test', 14:51:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:13 INFO - 'SHELL': '/bin/bash', 14:51:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UY2SndPSIh/Listeners', 14:51:13 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 14:51:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:13 INFO - 'USER': 'cltbld', 14:51:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:13 INFO - 'XPC_FLAGS': '0x0', 14:51:13 INFO - 'XPC_SERVICE_NAME': '0', 14:51:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:14 INFO - Downloading/unpacking psutil>=3.1.1 14:51: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 14:51: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 14:51: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 14:51: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 14:51: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 14:51: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 14:51:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:51:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:51:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:51:17 INFO - Installing collected packages: psutil 14:51:17 INFO - Running setup.py install for psutil 14:51:17 INFO - building 'psutil._psutil_osx' extension 14:51:17 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 14:51:18 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 14:51:18 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 14:51:18 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 14:51:18 INFO - building 'psutil._psutil_posix' extension 14:51:18 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 14:51:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:51:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:51:18 INFO - ^ 14:51:18 INFO - 1 warning generated. 14:51:18 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 14:51:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:51:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:51:18 INFO - Successfully installed psutil 14:51:18 INFO - Cleaning up... 14:51:18 INFO - Return code: 0 14:51:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:51:18 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')]} 14:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:18 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')]} 14:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:18 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 0x10b361b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b364768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5ad67680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b13fd30>, '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 0x10b066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b134be8>, '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.zWjH27EB8u/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.UY2SndPSIh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 14:51:18 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 14:51:18 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 14:51:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWjH27EB8u/Render', 14:51:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:18 INFO - 'HOME': '/Users/cltbld', 14:51:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:18 INFO - 'LOGNAME': 'cltbld', 14:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:18 INFO - 'MOZ_NO_REMOTE': '1', 14:51:18 INFO - 'NO_EM_RESTART': '1', 14:51:18 INFO - 'PAGER': '/bin/cat', 14:51:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:18 INFO - 'PWD': '/builds/slave/test', 14:51:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:18 INFO - 'SHELL': '/bin/bash', 14:51:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UY2SndPSIh/Listeners', 14:51:18 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 14:51:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:18 INFO - 'USER': 'cltbld', 14:51:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:18 INFO - 'XPC_FLAGS': '0x0', 14:51:18 INFO - 'XPC_SERVICE_NAME': '0', 14:51:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:51:19 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 14:51:19 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 14:51:19 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 14:51:19 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 14:51:19 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 14:51:19 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 14:51:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:51:21 INFO - Installing collected packages: mozsystemmonitor 14:51:21 INFO - Running setup.py install for mozsystemmonitor 14:51:21 INFO - Successfully installed mozsystemmonitor 14:51:21 INFO - Cleaning up... 14:51:22 INFO - Return code: 0 14:51:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:22 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 0x10b361b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b364768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5ad67680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b13fd30>, '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 0x10b066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b134be8>, '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.zWjH27EB8u/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.UY2SndPSIh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 14:51:22 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 14:51:22 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 14:51:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWjH27EB8u/Render', 14:51:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:22 INFO - 'HOME': '/Users/cltbld', 14:51:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:22 INFO - 'LOGNAME': 'cltbld', 14:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:22 INFO - 'MOZ_NO_REMOTE': '1', 14:51:22 INFO - 'NO_EM_RESTART': '1', 14:51:22 INFO - 'PAGER': '/bin/cat', 14:51:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:22 INFO - 'PWD': '/builds/slave/test', 14:51:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:22 INFO - 'SHELL': '/bin/bash', 14:51:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UY2SndPSIh/Listeners', 14:51:22 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 14:51:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:22 INFO - 'USER': 'cltbld', 14:51:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:22 INFO - 'XPC_FLAGS': '0x0', 14:51:22 INFO - 'XPC_SERVICE_NAME': '0', 14:51:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:22 INFO - Downloading/unpacking jsonschema==2.5.1 14:51:22 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 14:51:22 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 14:51:22 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 14:51:22 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 14:51:22 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 14:51:22 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 14:51:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:51:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:51:26 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 14:51:26 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 14:51:26 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 14:51:26 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 14:51:26 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 14:51:26 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 14:51:26 INFO - Downloading functools32-3.2.3-2.tar.gz 14:51:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:51:26 INFO - warning: no files found matching '*.txt' 14:51:26 INFO - no previously-included directories found matching 'build' 14:51:26 INFO - no previously-included directories found matching 'dist' 14:51:26 INFO - no previously-included directories found matching '.git*' 14:51:26 INFO - Installing collected packages: jsonschema, functools32 14:51:26 INFO - Running setup.py install for functools32 14:51:26 INFO - warning: no files found matching '*.txt' 14:51:26 INFO - no previously-included directories found matching 'build' 14:51:26 INFO - no previously-included directories found matching 'dist' 14:51:26 INFO - no previously-included directories found matching '.git*' 14:51:26 INFO - Successfully installed jsonschema functools32 14:51:26 INFO - Cleaning up... 14:51:26 INFO - Return code: 0 14:51:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:51: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')]} 14:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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')]} 14:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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', '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 0x10b361b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b364768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5ad67680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b13fd30>, '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 0x10b066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b134be8>, '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.zWjH27EB8u/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.UY2SndPSIh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 14:51: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:51: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 functools32==3.2.3-2 14:51:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWjH27EB8u/Render', 14:51:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:26 INFO - 'HOME': '/Users/cltbld', 14:51:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:26 INFO - 'LOGNAME': 'cltbld', 14:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:26 INFO - 'MOZ_NO_REMOTE': '1', 14:51:26 INFO - 'NO_EM_RESTART': '1', 14:51:26 INFO - 'PAGER': '/bin/cat', 14:51:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:26 INFO - 'PWD': '/builds/slave/test', 14:51:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:26 INFO - 'SHELL': '/bin/bash', 14:51:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UY2SndPSIh/Listeners', 14:51:26 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 14:51:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:26 INFO - 'USER': 'cltbld', 14:51:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:26 INFO - 'XPC_FLAGS': '0x0', 14:51:26 INFO - 'XPC_SERVICE_NAME': '0', 14:51:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:51:27 INFO - Cleaning up... 14:51:27 INFO - Return code: 0 14:51:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:27 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 0x10b361b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b364768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5ad67680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b13fd30>, '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 0x10b066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b134be8>, '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.zWjH27EB8u/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.UY2SndPSIh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 14:51:27 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 14:51:27 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 14:51:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWjH27EB8u/Render', 14:51:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:27 INFO - 'HOME': '/Users/cltbld', 14:51:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:27 INFO - 'LOGNAME': 'cltbld', 14:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:27 INFO - 'MOZ_NO_REMOTE': '1', 14:51:27 INFO - 'NO_EM_RESTART': '1', 14:51:27 INFO - 'PAGER': '/bin/cat', 14:51:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:27 INFO - 'PWD': '/builds/slave/test', 14:51:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:27 INFO - 'SHELL': '/bin/bash', 14:51:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UY2SndPSIh/Listeners', 14:51:27 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 14:51:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:27 INFO - 'USER': 'cltbld', 14:51:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:27 INFO - 'XPC_FLAGS': '0x0', 14:51:27 INFO - 'XPC_SERVICE_NAME': '0', 14:51:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:27 INFO - Downloading/unpacking blobuploader==1.2.4 14:51:27 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 14:51:27 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 14:51:27 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 14:51:27 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 14:51:27 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 14:51:27 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 14:51:29 INFO - Downloading blobuploader-1.2.4.tar.gz 14:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:51:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:51:30 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 14:51:30 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 14:51:30 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 14:51:30 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 14:51:30 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 14:51:30 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 14:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:51:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:51:30 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 14:51:30 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 14:51:30 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 14:51:30 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 14:51:30 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 14:51:30 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 14:51:31 INFO - Downloading docopt-0.6.1.tar.gz 14:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:51:31 INFO - Installing collected packages: blobuploader, requests, docopt 14:51:31 INFO - Running setup.py install for blobuploader 14:51:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:51:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:51:31 INFO - Running setup.py install for requests 14:51:31 INFO - Running setup.py install for docopt 14:51:32 INFO - Successfully installed blobuploader requests docopt 14:51:32 INFO - Cleaning up... 14:51:32 INFO - Return code: 0 14:51:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:32 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 0x10b361b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b364768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5ad67680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b13fd30>, '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 0x10b066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b134be8>, '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.zWjH27EB8u/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.UY2SndPSIh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 14:51:32 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 14:51:32 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 14:51:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWjH27EB8u/Render', 14:51:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:32 INFO - 'HOME': '/Users/cltbld', 14:51:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:32 INFO - 'LOGNAME': 'cltbld', 14:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:32 INFO - 'MOZ_NO_REMOTE': '1', 14:51:32 INFO - 'NO_EM_RESTART': '1', 14:51:32 INFO - 'PAGER': '/bin/cat', 14:51:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:32 INFO - 'PWD': '/builds/slave/test', 14:51:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:32 INFO - 'SHELL': '/bin/bash', 14:51:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UY2SndPSIh/Listeners', 14:51:32 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 14:51:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:32 INFO - 'USER': 'cltbld', 14:51:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:32 INFO - 'XPC_FLAGS': '0x0', 14:51:32 INFO - 'XPC_SERVICE_NAME': '0', 14:51:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:51:32 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-ug0lum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:51:32 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-CExtMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:51:32 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-JbkwZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:51:32 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-IIhFvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:51:32 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-cSVG_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:51:32 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-fxLW_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:51:33 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-C6CQQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:51:33 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-rNJwX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:51:33 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-uhT87Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:51:33 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-5mUiPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:51:33 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-J2FRHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:51:33 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-Qa_Lc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:51:33 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-lXMC1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:51:33 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-s4I4bG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:33 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-0RWdSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:51:33 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-mksVjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:51:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:51:34 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-HMrOwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:51:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:51:34 INFO - Running setup.py install for manifestparser 14:51:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:51:34 INFO - Running setup.py install for mozcrash 14:51:34 INFO - Running setup.py install for mozdebug 14:51:34 INFO - Running setup.py install for mozdevice 14:51:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:51:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:51:34 INFO - Running setup.py install for mozfile 14:51:34 INFO - Running setup.py install for mozhttpd 14:51:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:51:35 INFO - Running setup.py install for mozinfo 14:51:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:51:35 INFO - Running setup.py install for mozInstall 14:51:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:51:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:51:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:51:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:51:35 INFO - Running setup.py install for mozleak 14:51:35 INFO - Running setup.py install for mozlog 14:51:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:51:35 INFO - Running setup.py install for moznetwork 14:51:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:51:35 INFO - Running setup.py install for mozprocess 14:51:35 INFO - Running setup.py install for mozprofile 14:51:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Running setup.py install for mozrunner 14:51:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Running setup.py install for mozscreenshot 14:51:36 INFO - Running setup.py install for moztest 14:51:36 INFO - Running setup.py install for mozversion 14:51:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:51:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:51:36 INFO - Cleaning up... 14:51:36 INFO - Return code: 0 14:51:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:51: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')]} 14:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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')]} 14:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:36 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 0x10b361b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b364768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5ad67680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b13fd30>, '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 0x10b066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b134be8>, '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.zWjH27EB8u/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.UY2SndPSIh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 14:51:36 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 14:51:36 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 14:51:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWjH27EB8u/Render', 14:51:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:36 INFO - 'HOME': '/Users/cltbld', 14:51:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:36 INFO - 'LOGNAME': 'cltbld', 14:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:36 INFO - 'MOZ_NO_REMOTE': '1', 14:51:36 INFO - 'NO_EM_RESTART': '1', 14:51:36 INFO - 'PAGER': '/bin/cat', 14:51:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:36 INFO - 'PWD': '/builds/slave/test', 14:51:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:36 INFO - 'SHELL': '/bin/bash', 14:51:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UY2SndPSIh/Listeners', 14:51:36 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 14:51:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:36 INFO - 'USER': 'cltbld', 14:51:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:36 INFO - 'XPC_FLAGS': '0x0', 14:51:36 INFO - 'XPC_SERVICE_NAME': '0', 14:51:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:51:37 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-feFXc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:51:37 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)) 14:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:51:37 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-n0aUoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:51:37 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)) 14:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:51:37 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-Ggepsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:51:37 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)) 14:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:51:37 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-YcgFR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:51:37 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)) 14:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:51:37 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-Iy0_xX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:51:37 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)) 14:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:51:37 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-591l1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:51:37 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)) 14:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:51:37 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-6DTlRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:51:37 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)) 14:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:51:37 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-2mHhBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:51:37 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)) 14:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:51:37 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-W1vhzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:51:37 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)) 14:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:51:37 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-IQsJU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:51:38 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)) 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:51:38 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-xvkfII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:51:38 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)) 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:51:38 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-Xr8tyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:51:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:51:38 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-OKG5ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:51:38 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)) 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:51:38 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-Wqh6jT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:51:38 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)) 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:38 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-7AFkEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:51:38 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)) 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:51:38 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-MU6kpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:51:38 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)) 14:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:51:38 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-D0PFaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:51:38 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)) 14:51:38 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)) 14:51:38 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)) 14:51:38 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)) 14:51:38 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)) 14:51:38 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)) 14:51:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:51:38 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 14:51:38 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 14:51:38 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 14:51:38 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 14:51:38 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 14:51:38 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 14:51:41 INFO - Downloading blessings-1.6.tar.gz 14:51:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:51:41 INFO - Installing collected packages: blessings 14:51:41 INFO - Running setup.py install for blessings 14:51:41 INFO - Successfully installed blessings 14:51:41 INFO - Cleaning up... 14:51:41 INFO - Return code: 0 14:51:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:51:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:51:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:51:42 INFO - Reading from file tmpfile_stdout 14:51:42 INFO - Current package versions: 14:51:42 INFO - blessings == 1.6 14:51:42 INFO - blobuploader == 1.2.4 14:51:42 INFO - docopt == 0.6.1 14:51:42 INFO - functools32 == 3.2.3-2 14:51:42 INFO - jsonschema == 2.5.1 14:51:42 INFO - manifestparser == 1.1 14:51:42 INFO - mozInstall == 1.12 14:51:42 INFO - mozcrash == 1.0 14:51:42 INFO - mozdebug == 0.1 14:51:42 INFO - mozdevice == 0.49 14:51:42 INFO - mozfile == 1.2 14:51:42 INFO - mozhttpd == 0.7 14:51:42 INFO - mozinfo == 0.9 14:51:42 INFO - mozleak == 0.1 14:51:42 INFO - mozlog == 3.4 14:51:42 INFO - moznetwork == 0.27 14:51:42 INFO - mozprocess == 0.25 14:51:42 INFO - mozprofile == 0.28 14:51:42 INFO - mozrunner == 6.13 14:51:42 INFO - mozscreenshot == 0.1 14:51:42 INFO - mozsystemmonitor == 0.3 14:51:42 INFO - moztest == 0.8 14:51:42 INFO - mozversion == 1.4 14:51:42 INFO - psutil == 3.1.1 14:51:42 INFO - requests == 1.2.3 14:51:42 INFO - wsgiref == 0.1.2 14:51:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:42 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 0x10b361b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b364768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5ad67680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b13fd30>, '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 0x10b066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b134be8>, '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.zWjH27EB8u/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.UY2SndPSIh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 14:51:42 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 14:51:42 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 14:51:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWjH27EB8u/Render', 14:51:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:42 INFO - 'HOME': '/Users/cltbld', 14:51:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:42 INFO - 'LOGNAME': 'cltbld', 14:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:42 INFO - 'MOZ_NO_REMOTE': '1', 14:51:42 INFO - 'NO_EM_RESTART': '1', 14:51:42 INFO - 'PAGER': '/bin/cat', 14:51:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:42 INFO - 'PWD': '/builds/slave/test', 14:51:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:42 INFO - 'SHELL': '/bin/bash', 14:51:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UY2SndPSIh/Listeners', 14:51:42 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 14:51:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:42 INFO - 'USER': 'cltbld', 14:51:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:42 INFO - 'XPC_FLAGS': '0x0', 14:51:42 INFO - 'XPC_SERVICE_NAME': '0', 14:51:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:42 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)) 14:51:42 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)) 14:51:42 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)) 14:51:42 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)) 14:51:42 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)) 14:51:42 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)) 14:51:42 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)) 14:51:42 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)) 14:51:42 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)) 14:51:42 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)) 14:51:42 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)) 14:51:42 INFO - Cleaning up... 14:51:42 INFO - Return code: 0 14:51:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b361b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b364768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca5ad67680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b13fd30>, '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 0x10b066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b134be8>, '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.zWjH27EB8u/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.UY2SndPSIh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 14:51:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:51:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWjH27EB8u/Render', 14:51:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:51:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:51:42 INFO - 'HOME': '/Users/cltbld', 14:51:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:51:42 INFO - 'LOGNAME': 'cltbld', 14:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:42 INFO - 'MOZ_NO_REMOTE': '1', 14:51:42 INFO - 'NO_EM_RESTART': '1', 14:51:42 INFO - 'PAGER': '/bin/cat', 14:51:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:42 INFO - 'PWD': '/builds/slave/test', 14:51:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:51:42 INFO - 'SHELL': '/bin/bash', 14:51:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UY2SndPSIh/Listeners', 14:51:42 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 14:51:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:51:42 INFO - 'USER': 'cltbld', 14:51:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:51:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:42 INFO - 'XPC_FLAGS': '0x0', 14:51:42 INFO - 'XPC_SERVICE_NAME': '0', 14:51:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:51:42 INFO - Cleaning up... 14:51:42 INFO - Return code: 0 14:51:42 INFO - Running post-action listener: _resource_record_post_action 14:51:42 INFO - Running post-action listener: _start_resource_monitoring 14:51:42 INFO - Starting resource monitoring. 14:51:42 INFO - [mozharness: 2017-03-02 22:51:42.691302Z] Finished create-virtualenv step (success) 14:51:42 INFO - [mozharness: 2017-03-02 22:51:42.692237Z] Running install step. 14:51:42 INFO - Running pre-action listener: _resource_record_pre_action 14:51:42 INFO - Running main action method: install 14:51:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:51:42 INFO - Reading from file tmpfile_stdout 14:51:42 INFO - Detecting whether we're running mozinstall >=1.0... 14:51:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:51:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:51:43 INFO - Reading from file tmpfile_stdout 14:51:43 INFO - Output received: 14:51:43 INFO - Usage: mozinstall [options] installer 14:51:43 INFO - Options: 14:51:43 INFO - -h, --help show this help message and exit 14:51:43 INFO - -d DEST, --destination=DEST 14:51:43 INFO - Directory to install application into. [default: 14:51:43 INFO - "/builds/slave/test"] 14:51:43 INFO - --app=APP Application being installed. [default: firefox] 14:51:43 INFO - mkdir: /builds/slave/test/build/application 14:51:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:51:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:52:03 INFO - Reading from file tmpfile_stdout 14:52:03 INFO - Output received: 14:52:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:52:03 INFO - Running post-action listener: _resource_record_post_action 14:52:03 INFO - [mozharness: 2017-03-02 22:52:03.540459Z] Finished install step (success) 14:52:03 INFO - [mozharness: 2017-03-02 22:52:03.540597Z] Running run-tests step. 14:52:03 INFO - Running pre-action listener: _resource_record_pre_action 14:52:03 INFO - Running main action method: run_tests 14:52:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:52:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:52:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:52:03 INFO - 2017-03-02 14:52:03.554 screenresolution[1626:7586] starting screenresolution argv=screenresolution get 14:52:03 INFO - 2017-03-02 14:52:03.556 screenresolution[1626:7586] Display 0: 1600x1200x32@50 14:52:03 INFO - 2017-03-02 14:52:03.562 screenresolution[1627:7588] starting screenresolution argv=screenresolution list 14:52:03 INFO - Available Modes on Display 0 14:52:03 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 14:52:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:52:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:52:03 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 14:52:03 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 14:52:03 INFO - Graphics/Displays: 14:52:03 INFO - Intel Iris: 14:52:03 INFO - Chipset Model: Intel Iris 14:52:03 INFO - Type: GPU 14:52:03 INFO - Bus: Built-In 14:52:03 INFO - VRAM (Dynamic, Max): 1536 MB 14:52:03 INFO - Vendor: Intel (0x8086) 14:52:03 INFO - Device ID: 0x0a2e 14:52:03 INFO - Revision ID: 0x0009 14:52:03 INFO - Displays: 14:52:03 INFO - Display: 14:52:03 INFO - Resolution: 1600 x 1200 @ 50 Hz 14:52:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:52:03 INFO - Display Serial Number: 1600x1200 50 14:52:03 INFO - Main Display: Yes 14:52:03 INFO - Mirror: Off 14:52:03 INFO - Online: Yes 14:52:03 INFO - Rotation: Supported 14:52:03 INFO - Return code: 0 14:52:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:52:03 INFO - Python 2.7.3 14:52:03 INFO - Return code: 0 14:52:03 INFO - grabbing minidump binary from tooltool 14:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:52:03 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 0x10b13fd30>, '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 0x10b066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b134be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:52:03 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 14:52:03 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 14:52:03 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 14:52:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:52:03 INFO - Return code: 0 14:52:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:52:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:52:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:52:03 INFO - ENV: RUST_BACKTRACE is now 1 14:52:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:52:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:52:03 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0017', '--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 14:52:03 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0017 --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 14:52:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWjH27EB8u/Render', 14:52:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:52:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:52:03 INFO - 'HOME': '/Users/cltbld', 14:52:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:52:03 INFO - 'LOGNAME': 'cltbld', 14:52:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:52:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:03 INFO - 'MOZ_NO_REMOTE': '1', 14:52:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:52:03 INFO - 'NO_EM_RESTART': '1', 14:52:03 INFO - 'PAGER': '/bin/cat', 14:52:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:03 INFO - 'PWD': '/builds/slave/test', 14:52:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:52:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:52:03 INFO - 'RUST_BACKTRACE': '1', 14:52:03 INFO - 'SHELL': '/bin/bash', 14:52:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UY2SndPSIh/Listeners', 14:52:03 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 14:52:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:52:03 INFO - 'USER': 'cltbld', 14:52:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:52:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:03 INFO - 'XPC_FLAGS': '0x0', 14:52:03 INFO - 'XPC_SERVICE_NAME': '0', 14:52:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:52:03 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0017', '--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 14:52:04 INFO - mozversion application_buildid: 20170302130952 14:52:04 INFO - mozversion application_changeset: c54c652af04c5a918610bc3d419250177a68b9f7 14:52:04 INFO - mozversion application_display_name: Nightly 14:52:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:52:04 INFO - mozversion application_name: Firefox 14:52:04 INFO - mozversion application_remotingname: firefox 14:52:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:52:04 INFO - mozversion application_vendor: Mozilla 14:52:04 INFO - mozversion application_version: 54.0a1 14:52:04 INFO - mozversion platform_buildid: 20170302130952 14:52:04 INFO - mozversion platform_changeset: c54c652af04c5a918610bc3d419250177a68b9f7 14:52:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:52:04 INFO - mozversion platform_version: 54.0a1 14:52:04 INFO - using testdate: 1488495124 14:52:04 INFO - actual date: 1488495124 14:52:04 INFO - starting webserver on 'localhost:49240' 14:52:04 INFO - SUITE-START | Running 2 tests 14:52:04 INFO - TEST-START | dromaeo_css 14:52:04 INFO - operating with platform_type : mac_ 14:52:04 INFO - Initialising browser for dromaeo_css test... 14:52:04 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmp96uhxP/profile http://localhost:49240/getInfo.html) 14:52:06 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 14:52:06 INFO - PROCESS | 1637 | colorDepth:24 14:52:06 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 14:52:06 INFO - PROCESS | 1637 | __metrics 14:52:07 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" 14:52:07 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] 14:52:07 INFO - TEST-INFO | 1637: exit 0 14:52:07 INFO - Browser initialized. 14:52:07 INFO - Running cycle 1/1 for dromaeo_css test... 14:52:07 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmp96uhxP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:52:19 INFO - PROCESS | 1639 | RSS: Main: 233033728 14:52:19 INFO - PROCESS | 1639 | 14:55:23 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 14:55:26 INFO - PROCESS | 1639 | RSS: Main: 484900864 14:55:26 INFO - PROCESS | 1639 | 14:57:11 INFO - PROCESS | 1639 | ************************* 14:57:11 INFO - PROCESS | 1639 | A coding exception was thrown and uncaught in a Task. 14:57:11 INFO - PROCESS | 1639 | 14:57:11 ERROR - PROCESS | 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:57:11 INFO - PROCESS | 1639 | Full stack: 14:57:11 INFO - PROCESS | 1639 | ************************* 14:58:30 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 14:58:30 INFO - PROCESS | 1639 | RSS: Main: 364515328 14:58:30 INFO - PROCESS | 1639 | 15:01:33 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 15:01:33 INFO - PROCESS | 1639 | RSS: Main: 347226112 15:01:33 INFO - PROCESS | 1639 | 15:04:36 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 15:04:37 INFO - PROCESS | 1639 | RSS: Main: 336015360 15:04:37 INFO - PROCESS | 1639 | 15:07:40 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 15:07:41 INFO - PROCESS | 1639 | RSS: Main: 336695296 15:07:41 INFO - PROCESS | 1639 | 15:10:44 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 15:10:45 INFO - PROCESS | 1639 | RSS: Main: 528314368 15:10:45 INFO - PROCESS | 1639 | 15:10:45 INFO - PROCESS | 1639 | __start_tp_report 15:10:45 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 15:10:45 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 15:10:45 INFO - PROCESS | 1639 | |i|pagename|runs| 15:10:45 INFO - PROCESS | 1639 | |0;dojo.html;2705.310145912792;3150.9054728358146;3289.2105894585306;3315.9502607460877;3350.5309256704068;5519.668819870811;5626.2967129108865;5627.352854421742;5719.313682358123;5740.425957404263;5533.667979921198;5608.130739735338;5649.830505084844;5660.9716951415285;5662.348829884564;5075.467075957008;5079.492050794928;5152.407473140581;5162.0192163489;5187.455317191697;4383.846565370212;5232.6075544334135;5245.711485868275;5275.314209152804;5302.045631786277;5085.160948443502;5102.719350435725;5124.8206312778875;5137.2807806906685;5230.843074707765;5124.769385377667;5141.537261646432;5149.150390185615;5164.535191832753;5168.741562921877;5082.822101226439;5112.335396398445;5123.513266239701;5130.769115389817;5149.6910185389;5576.972115139439;5584.664920104807;5595.468430499096;5607.355154157283;5616.831495055155;6105.217149441772;6128.319797384534;6128.667102172704;6136.807362171507;6147.784827531015;6114.306182961508;6144.064619644798;6195.783147589857;6204.47261982732;6207.968960155215;5416.83749487516;5713.143028545752;5729.541636669056;5741.483266506035;5759.222504961818;6291.433770960544;6304.653244071528;6312.5581209314905;6316;6319.905201421982;5921.14143449206;5958.940410595926;6131.846703832351;6140.815775526741;6157.415045570664;6126.120738204555;6140.324564297924;6175.289841668266;6205.100260462298;6249.937510623205;6214.130021796952;6227.719752611143;6233;6241.375862413813;6256.6871656417;6016.1878146450545;6109.969450152809;6229.283632382243;6237.563370564017;6255.6872156392;4865.513448655106;4904.337914381585;4905.9264111038365;4907.460179380265;4918.754062296943;4354.042110735633;4375.343698445258;4424.889377765581;4457.754823484739;4484.215262329145;5573.749181286771;5586.301712285965;5593.692346920959;5618.6628802272;5625;6111.166351794787;6153.969230153821;6155.199824022849;6163.506919446433;6169.2288463942;5541.141123125922;5561.082421400504;5589.301337332833;5605;5622.606417550732;5345.1982202669915;5463.9180412293845;5466;5476.2333273341765;5482.890342193134;6292.182016337847;6313.43179113882;6343.460805831556;6344.460720838781;6365.52258580599;6280.309165991828;6289.811305660837;6299.08663243818;6313.936860631335;6321.652309123042;6192.81421557354;6271.498280137669;6280.811575652738;6302;6303.747850085945;6150.7847225346895;6204.503639708722;6224.253089629274;6230.6884655767935;6236.095766113797;5215.269862219368;6053.273607166992;6264.874702505833;6287.905681414874;6291.402316779899;5781.653100813965;5861.35525092231;5877.089051197071;6059.939400606114;6062.181605483203;5806;5897.233359663216;5903.645781253139;5904.3800400959;5925.733341999534;5782.335031471266;5784.21913041734;5784.363719990882;5785.739641716049;5789.8263052108505;5883.2057672213705;5919.437653422918;5922.881542369215;5924.200232968494;5926.318473375617;5693.370481284465;5705.828825135252;5740.6268592541355;5752.1659359391815;5756.510696590669 15:10:45 INFO - PROCESS | 1639 | |1;ext.html;766.8351304469538;788.6963519045166;843.1105184030849;860.9913900860994;861.3755027604991;27380;38456;39065.804670976606;39442;41104.58895411045;39682.8095157145;39792.40311395324;39920.80039599805;39961.00097497564;39968.00079997994;8985.775355616097;9153.130452606993;9159.771005724877;9163.679271225508;9171.816563668723;7226.349628533431;7419.406447484188;7424.183339832614;7465.0295461590185;7493.625318734069;10651.78696426071;10905;10907.236493445462;11087.944560277228;11126.109911207084;10814.243002989793;10860.565577376896;10879.347239165676;10890.455477226107;10894.509747061402;7180.389666878322;10656.467176641137;10700.090492308163;10720.51757670899;10729.624463143831;27203.183904482896;27406.862965685243;27443.86278068617;39207.21585568273;39732.40401393981;3821.197548514815;3824.445455408978;3843.0584506796013;3863.517060367454;3938.310795610785;22348.99429525675;26360;27661.031863884666;27739.722602773916;27764.30589235265;3093.613298337708;3161.351922855809;3162.509810979302;3180.284436001881;3187.2987942652812;310823;316341;316377.9999999977;316556;318244;40778.79610601987;41977.580224197976;50018.999620007395;50138.74930625324;50223.744406390135;38708.61291387107;41104.79447602803;52115.21827172596;52382;55185.72407137939;13549.458021679022;13642.522511712043;13650.795238071438;13655.931720341334;13656.180629162282;11684.415779211005;11696.70758231051;11729.4135293235;11733.237339572901;11733.706657333465;12053.819192712117;12122.333271669966;12129.575464858688;12143.635690929286;12165.574204902787;5028.371453568304;5328.307320048369;5336.4129945705945;5338.172583249525;5350.17072353778;996.5814357969671;1033.1682995188794;1055.335138862527;1062.1290541755686;1067.1782727299935;15069.849301507064;15114.924425377803;15172.317245723969;15211;15450.99568528042;985.8866230383597;1028.3932479836933;1113.1651261553834;1154.0536759857005;1156.9652910412701;7803.9609801951765;7809.960950195326;7881.684732610632;7906.486078404885;8078.757637270891;431081;443712;444026;444247;444721;53290.20064699033;53302.46697533053;53315.933681326154;53372;53420.46579534155;1409.4996276321963;1443.4514884343882;1445.3784872504923;1446.378057435313;1449.340550049725;14776.778348324999;14809.92595037061;15297.46458873934;15414.99802512833;15432.614184645474;43255.13489730125;43266;43308.78345608378;43363;43387.9153021177;393322;393817;395485;395728;396264;32056.67943320537;32165.517517236793;32228;32525.837370812995;32674.50988235226;41445.1710965785;41457.58542414537;41505.58494415138;42063;42085.57914420939;28421.57367639446;32201.677983219866;32980.50529242015;34056.318873621894;34914.30171396609;30539.54190687097;30944.847078926774;32033.359332813678;32322.83838580792;32348.83825580951;32095.839520802245;32695.836520817244;33044;33176.33647326992;33307.83346083254;27248.591271131347;28098.578521322605;28949.065441584848;29188.854055729586;29508.852455738444;21229.363119106452;21342.89328553347;22066.44833879166;22298.21956231524;22397.77602223957 15:10:45 INFO - PROCESS | 1639 | |2;jquery.html;378.8711837975088;393.9980300098499;403.1111399364401;415.5325259083531;431.9676024298178;12089.237262586668;19272.710909336354;21280.255191068296;22059.33821985339;22359.441013974658;21542;21849.453763655918;22412;22605;22724.318270451913;6418.646974416405;6522.576032557892;6618.801435956929;6698.1292431983775;6758.324167583251;6518.120053792748;6664.500162487809;6666.600003999752;6678.232003319607;6693.163354580677;6357.68211589421;6500.837479063014;6576.276609572943;6592.077109204715;6666.100076489684;6455.580387274812;6482.513811464112;6526.28210896801;6607.405333519982;6610.272869984346;6410.134631824691;6422.100905873182;6427.8393040173905;6428.228612566522;6433.131527243809;22602.660960085614;26216.344591385176;26224.475510489683;26283.60574591383;26601.866990664923;2853.571964205386;2877.9712202877913;2878.481873262812;2878.7553057990094;2880.423915216944;14964.401423943029;15209.61975950599;15314.540563783105;15616.063036217864;16398.754018689728;1920.3662791278844;1924.3553409607657;1937.806219378065;1941.805819418061;1966.803319668036;136885.3155734225;161455.66171213717;177434;178891;179810.30284545742;14580.95398885711;18790.812091878906;19027.429177124708;19451.70822437636;19468.478059849826;27956;29128.563071553945;29183;29211.83152673912;29211.85394073016;7933.365330773524;8154.551499667576;8590.656373745105;9661.951690241503;9686.854697179548;7920.24785128918;8021.959890200512;8104.878426823602;8128.187181281824;8180.345572354197;7970.442069055226;8519.616617252239;9029.23251523628;9152.954235228914;9190.910045029897;3663.058578953159;3755.9013813603888;3756.6896358739723;3791.431285307226;3794.9640287769676;804.8792681097765;999.6251405722854;1006.9949650251701;1030.2324768047702;1034.3018462537757;18917.337893173673;20099.39701808948;20382;20532.58934821295;20763.58472830565;930.3716999476505;975.512243878061;1006.954687039085;1007.445904752398;1014.8071866345371;9171.77070573241;10082.647107351208;10444.425556594308;10515.789684206426;10599.62901298451;699275;706940;713243;726290;735798;122785;147973.82745917363;152255.23872380788;154282;155474.44525554826;774.7327172125721;823.279630323467;947.4694171263976;999.9050090241416;1026.4918865161792;13994.580162595139;17055.403060893306;17745.378911738542;17808.46574602764;18162.545936351697;46835.53164468312;59075;59163.40836591579;60015.09977350256;60514.107460657506;52207;75027.62486187535;80931.19068809236;83600;84626.57686711528;11019.393933333744;11076.723081923017;11385.462962499956;11492.827607585725;11584.94207528957;12335.136540442441;12341;12372.443240054039;12745.936270318589;12766.978641708827;10639.361638301727;10875.401852898167;11036.5033573491;11100.500477478372;11182.552697892319;10384.480775961323;10559.419231942009;10564.788704226026;10910.2362834604;10919.181061420266;10828;11054.557817687202;11057.778844422906;11113.777724445628;11137.721556961142;10897.166736648687;11161;11229.75404919003;11282.574246537033;11407.946569617548;10558.947205264232;10624.096951758878;10849.240553161202;10920.78158436811;11003.009729124416 15:10:45 INFO - PROCESS | 1639 | |3;mootools.html;1557.1824791984207;1559.0489801221247;1570.050119677595;1588.7616857471378;1591.7771511988324;10214.693559193218;10725.517351719182;10735.463226838656;10740.03339699427;10744.033037026686;10333.483325833717;10470.16238700904;10666.360018398882;10690.893091069087;10820.621278255263;2292.6561015847633;2313.8611683299055;2328.813694904412;2331.8484298520625;2333.8366314358;2332.8716920569364;2351.271105957159;2362.1850461590725;2362.9291121266306;2367.3016460144213;2045.5090778213196;2292.4727312718087;2301.309607117866;2305.2738387408;2333.148400833692;2311;2312.456572705413;2330.7436182019965;2332.54515369503;2339.2865176121277;2281.4296425893526;2358.2689366296504;2363.220137354686;2365.6806331145417;2365.7989070928993;9091;10879.673609791718;10885.673429797118;10888;10893;5344.625876188668;5532.474414930615;5544.695041772741;5555.194496797942;5558.110702287615;3319.2365755876285;3399.2351720862607;3622.2212224371624;3628.9274214515563;3637.781733095996;1127.644791890552;1156.7859945910034;1196.8503937007874;1230.2864338683542;1244.265883128949;13438.19370837743;13786.103903246358;13801.171929684251;14752.926235368754;14777.187254700988;3739.495168152319;4651.162790697639;4654.650901182425;4664.720116793003;4671.929921051187;11179.888201118047;11199.384033878216;11205.719857003478;11214;11217.15871309655;4820.180569303227;5016.949830501721;5017;5601.243832082617;5623.775048998076;4226.218149642326;4959.380077490314;5213.504717051874;5235.319408476874;5241.528262456397;3837.0407398150464;3979.4826672532386;4010.47863777707;4014.2573623879093;4033.092554175346;1095.3044816541394;1125.2123513540555;1126.6056880091903;1135.8977692007759;1151.1711567671264;888.6312180445043;916.1159481100636;918.0865039285819;933.2487347685178;944.8252073366449;5092.28707980883;6044.002739548013;6368.172137622079;6407.167068281186;6507.609543427409;927.8376284150381;955.5795450001976;956.784723437221;964.6479035152119;976.9364991275544;3928.2143571285856;3951.920961580752;3973.940390894139;4040.5353384360587;4069.4302797608357;13000.739985200244;13398.263095529644;13403.128796628189;13403.597892063253;13413.597592072254;11178.552857885756;12901;13155.013373996797;13324.933375333256;13344.399502022432;9692.951535242279;9910.65312714066;9918.80162396748;9925.702228933143;9930.652427165014;6426.164598602152;6433.228012638513;6471.838204044937;6660.034295027291;6688.933110668831;11542.365169915734;12110.031197504355;12147.149699520949;12148.967337776388;12155.939220303842;10968.451577421256;11050.778984420427;12092.455839487067;12255.938720306342;12262.325572093621;7859.764207073797;8827.16141966512;8868.689595864114;9044.14080662336;9058.320625953213;8450.619722112397;10215.693529194135;10224.795504090025;10230.335028223142;10295.897041029793;8451.873221901553;8642.524661143698;8735.825283494167;8805.339599530189;8810.427322224292;8237.423380363318;8649.8702519461;8650.870236946577;8715.52064636451;8776.429532080394;7372.557646541225;7544.735934242275;7550.66022029021;7556.622168891643;7597.848043039219;5016.573591244785;5055.974720126376;5191.273221749034;5211.0359583477175;5366.221897824716;5741.8564535886935;5795.3625101237985;5807.448292412214;5852.619579727304;5855.121731740102 15:10:45 INFO - PROCESS | 1639 | |4;prototype.html;354.25075964335423;368.6608320345282;371.97706307653954;373.52748772802425;377.56014243406435;4808.350872632193;4842.612590992721;5240.580753539717;5360.954613850301;5368.91946620801;4049.4128351389104;4735.71585704858;5110.936805239834;5146.768395422206;5251.291075704778;3626.5104210931518;4282.528921818597;4295.055087880677;4332.740035597859;4360.280553708634;4357.172137293904;4375.846845360413;4386.978065109686;4388.517263101056;4455.086707225011;4068.172620029081;4073.063195465045;4274.551172126929;4327.848525301615;4371.650267978554;3749.4938183345307;4022.839086436539;4031.677465802758;4069.47096877407;4296.613304802551;3510.473428985647;3941.9159731073896;4006.419069234974;4018.8144497373346;4041.5150181978056;4410.558944105596;4836.709797412166;4918.631102667314;4998.250262460624;5078.771455284521;5174.353205849269;5239.345081864767;5253.658512196695;5270.4729527047375;5313.814016509442;5557.305336832896;5579.414161513023;5601.9469389183;5618.971905140489;5639.6334238274385;4013.3545246448816;4537.2059889519205;4811.879703007417;4832.840118371566;4902.7058376497525;4707.5057119002695;4960.2559616057515;5101.566366858784;5280.471952804689;5822.767089316422;3821.8662346817728;3969.503812023497;4308.298222202213;4805;4838.661293709407;4828.686135401188;4852.514748525119;4909.189983652729;5043.595572988218;5053.343065401475;4535.9773201133785;4964.553190212898;5243.68537887728;5250.687328167958;5266.8419947401635;5055.620828437808;5481.24534693736;5528.474794894479;5541;5548.059528449928;1551.5112739487251;1591.427245833089;1602.5833283346415;1633.4890226540404;1695.5422036050197;1342.89256859451;1348.9797653035212;1369.431685850361;1369.7535242928886;1389.9583012509438;4494;4706.505816889177;4880.632363669057;4889.193283108248;4913.287573301851;4726.557036385855;5120.745417372767;5281.9207711884355;5429.4027656957705;5450.563954883679;4117.341225403921;4453.910921781611;4695.614793635886;4739.289106634033;4912.9508704913205;2483.478469521385;2846.2599724071893;2848.5869548915707;2849.33040735427;2853.3009412694023;4854.393200849894;4911.7544122793715;5248.317718696545;5304.628675992643;5678.432156784371;5363.2759577456545;5567.749451274703;5573.442655734475;5598;5674.389780700923;4839.951600484021;5595.076812326002;5677.316214123365;5712.25740653729;5714.428557144335;4571.657125715651;4752.596029337545;5047.596192304681;5221.947780522298;5576.079946808731;4804.279358096313;4992.750362481934;5359.14253719403;5398.5951053671915;5406.567474602101;4799.448063472606;5766.394528574439;5853.507355624289;5876.853078673067;5892.499137573182;4653.837115700934;4924.507549245047;4926;4982.078315511642;4985.601151907911;4994.725290108933;5416.4563099516445;5482.835514934558;5555.833325000256;5744.741486633196;4896.853094407174;5109.20807274873;5475.698836564027;5524.33707955048;5549.833504994856;4419.779011049499;4900.558949694545;5531.640443371168;5557.249771280987;5632.81710840728;4565.931511027404;4744.430668319824;5059.747012649426;5357.517823395913;5479.274028680953;4992.926520798046;5066.5693416058575;5418.133098704188;5469.972650136724;5490.231367608618;4588.678792484494;4774.259989701602;5076;5391.7059905623155;5398.2442458056685 15:10:45 INFO - PROCESS | 1639 | |5;yui.html;709.6026225313822;721.1958666087311;755.4560716284277;775.4843029385461;825.0717942314895;14427;15240.6951860963;15271.770923436143;15274.312655930482;15286.84713152868;13595.864041359584;13793.862061379383;13895.096818706803;14026.509072182476;14211.360488778004;935.9251259899208;948.369334392628;948.8576713492962;949.6533765175731;950.1543626172712;894.5661354243219;925.7222833150028;940.3793496292449;944.117250370902;944.8629948657475;981.5975450065474;985.8915519292872;987.2496902354227;987.6148302162162;987.7333120057616;980.0395612299986;981.1709105805583;981.4994352880011;982.5971351745785;985.2462865907586;731.2833423245249;732.318943382654;732.8424388756443;733.1385621894253;734.0090877315635;15024.399024039025;15154.545363639108;15193.848061519464;15215.771763423558;15472.5358239253;13431.3955871986;13682.179069255777;13803.17180969145;13804.378802953892;13945.790813137812;11391.202615816896;11508;11664.416779161009;11935.761284774257;12227.938860305641;3132.7023932726356;3637.1634524059614;3660.652238037382;3660.8535658573624;3661.761985470936;92974;93981.53009234979;104358.95641043568;104729.47635261776;105717.8856422875;8894.822103557892;10604.416757078434;10615.628453004108;10750.301230419998;10853.348799071922;20877.85171815565;21225.78774212269;22116.557668846533;22162.224322148646;22179.889100554396;7378.446616503784;7475.36459400957;7500.924990750132;7503.812404689817;7546.320831125116;4066.2274167908004;4143.6685065194715;4143.6892233082035;4151.584841515824;4195.30777421722;3442.846646373443;3531.6644918732677;3539.2567560812004;3551.982240088783;3560.1633616100194;607.3956413368638;614.0267675733922;617.0990354083089;617.7220250887119;618.5144661440837;609.2871340531589;620.2494981072953;632.8196464007735;668.9799306020827;670.9530332876652;9646.794150731159;9743.171830394354;9791.755206119904;9869.605215791287;10167.949160254298;516.2514354186445;550.2626480516128;571.5856004396862;588.3939542271468;591.819495054004;4295.248331541968;4389.934150987674;4673.789679464432;4785.234362501983;4792.616590672737;95431;96133.0386696124;98447;102131;103005.48497257466;52131.43067065497;60013;66093.00860487096;66195.66902165458;81688.59155704302;53724.46275537195;61937.76124477576;68099.65950170218;69199;70807.9378809308;8359.95820020896;9720.708378748648;10694.572217111228;10705.571777128827;10829.837552436877;37849.62150378461;46216.768916155204;46999;48015.279770802765;48059.75970120127;56864.43135568591;57038;58462.7076864613;58567.70716146392;58714;12105.788423153692;12282.815757763461;12438.626841194779;12519.436625352064;13001.15492492985;13944.860551394357;13967;14073.648158796112;14099.365528551034;14202;13182.73634527285;13254.206700974582;13264.137831041338;13314.400851961878;13363.599092027254;12938.676533086747;13088.607341779762;13405.262710551013;13609.319534023458;13813.930930345285;13095.67260818449;13105.737885242432;13149.60551183466;13164.355252346917;13282.468701252228;10503.212259080447;10864.96948042262;10990.505427255634;11291.604793832177;11567.710807229887;9057.954844116464;9625.951870240604;10574.577016919236;10640.201984851012;10828.24202305831 15:10:45 INFO - PROCESS | 1639 | __end_tp_report 15:10:45 INFO - PROCESS | 1639 | __start_cc_report 15:10:45 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,3287 15:10:45 INFO - PROCESS | 1639 | __end_cc_report 15:10:45 INFO - PROCESS | 1639 | __startTimestamp1488496245042__endTimestamp 15:10:45 INFO - PROCESS | 1639 | 15:10:45 INFO - PROCESS | 1639 | ------- Summary: start ------- 15:10:45 INFO - PROCESS | 1639 | Number of tests: 6 15:10:45 INFO - PROCESS | 1639 | 15:10:45 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5668.60 Median:5782.34 stddev:660.78 (11.4%) stddev-sans-first:620.57 15:10:45 INFO - PROCESS | 1639 | Values: 2705.3 3150.9 3289.2 3316.0 3350.5 5519.7 5626.3 5627.4 5719.3 5740.4 5533.7 5608.1 5649.8 5661.0 5662.3 5075.5 5079.5 5152.4 5162.0 5187.5 4383.8 5232.6 5245.7 5275.3 5302.0 5085.2 5102.7 5124.8 5137.3 5230.8 5124.8 5141.5 5149.2 5164.5 5168.7 5082.8 5112.3 5123.5 5130.8 5149.7 5577.0 5584.7 5595.5 5607.4 5616.8 6105.2 6128.3 6128.7 6136.8 6147.8 6114.3 6144.1 6195.8 6204.5 6208.0 5416.8 5713.1 5729.5 5741.5 5759.2 6291.4 6304.7 6312.6 6316.0 6319.9 5921.1 5958.9 6131.8 6140.8 6157.4 6126.1 6140.3 6175.3 6205.1 6249.9 6214.1 6227.7 6233.0 6241.4 6256.7 6016.2 6110.0 6229.3 6237.6 6255.7 4865.5 4904.3 4905.9 4907.5 4918.8 4354.0 4375.3 4424.9 4457.8 4484.2 5573.7 5586.3 5593.7 5618.7 5625.0 6111.2 6154.0 6155.2 6163.5 6169.2 5541.1 5561.1 5589.3 5605.0 5622.6 5345.2 5463.9 5466.0 5476.2 5482.9 6292.2 6313.4 6343.5 6344.5 6365.5 6280.3 6289.8 6299.1 6313.9 6321.7 6192.8 6271.5 6280.8 6302.0 6303.7 6150.8 6204.5 6224.3 6230.7 6236.1 5215.3 6053.3 6264.9 6287.9 6291.4 5781.7 5861.4 5877.1 6059.9 6062.2 5806.0 5897.2 5903.6 5904.4 5925.7 5782.3 5784.2 5784.4 5785.7 5789.8 5883.2 5919.4 5922.9 5924.2 5926.3 5693.4 5705.8 5740.6 5752.2 5756.5 15:10:45 INFO - PROCESS | 1639 | 15:10:45 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:51142.18 Median:32335.84 stddev:102922.25 (318.3%) stddev-sans-first:103141.48 15:10:45 INFO - PROCESS | 1639 | Values: 766.8 788.7 843.1 861.0 861.4 27380.0 38456.0 39065.8 39442.0 41104.6 39682.8 39792.4 39920.8 39961.0 39968.0 8985.8 9153.1 9159.8 9163.7 9171.8 7226.3 7419.4 7424.2 7465.0 7493.6 10651.8 10905.0 10907.2 11087.9 11126.1 10814.2 10860.6 10879.3 10890.5 10894.5 7180.4 10656.5 10700.1 10720.5 10729.6 27203.2 27406.9 27443.9 39207.2 39732.4 3821.2 3824.4 3843.1 3863.5 3938.3 22349.0 26360.0 27661.0 27739.7 27764.3 3093.6 3161.4 3162.5 3180.3 3187.3 310823.0 316341.0 316378.0 316556.0 318244.0 40778.8 41977.6 50019.0 50138.7 50223.7 38708.6 41104.8 52115.2 52382.0 55185.7 13549.5 13642.5 13650.8 13655.9 13656.2 11684.4 11696.7 11729.4 11733.2 11733.7 12053.8 12122.3 12129.6 12143.6 12165.6 5028.4 5328.3 5336.4 5338.2 5350.2 996.6 1033.2 1055.3 1062.1 1067.2 15069.8 15114.9 15172.3 15211.0 15451.0 985.9 1028.4 1113.2 1154.1 1157.0 7804.0 7810.0 7881.7 7906.5 8078.8 431081.0 443712.0 444026.0 444247.0 444721.0 53290.2 53302.5 53315.9 53372.0 53420.5 1409.5 1443.5 1445.4 1446.4 1449.3 14776.8 14809.9 15297.5 15415.0 15432.6 43255.1 43266.0 43308.8 43363.0 43387.9 393322.0 393817.0 395485.0 395728.0 396264.0 32056.7 32165.5 32228.0 32525.8 32674.5 41445.2 41457.6 41505.6 42063.0 42085.6 28421.6 32201.7 32980.5 34056.3 34914.3 30539.5 30944.8 32033.4 32322.8 32348.8 32095.8 32695.8 33044.0 33176.3 33307.8 27248.6 28098.6 28949.1 29188.9 29508.9 21229.4 21342.9 22066.4 22298.2 22397.8 15:10:45 INFO - PROCESS | 1639 | 15:10:45 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:41335.16 Median:22664.66 stddev:120022.93 (529.6%) stddev-sans-first:120320.23 15:10:45 INFO - PROCESS | 1639 | Values: 378.9 394.0 403.1 415.5 432.0 12089.2 19272.7 21280.3 22059.3 22359.4 21542.0 21849.5 22412.0 22605.0 22724.3 6418.6 6522.6 6618.8 6698.1 6758.3 6518.1 6664.5 6666.6 6678.2 6693.2 6357.7 6500.8 6576.3 6592.1 6666.1 6455.6 6482.5 6526.3 6607.4 6610.3 6410.1 6422.1 6427.8 6428.2 6433.1 22602.7 26216.3 26224.5 26283.6 26601.9 2853.6 2878.0 2878.5 2878.8 2880.4 14964.4 15209.6 15314.5 15616.1 16398.8 1920.4 1924.4 1937.8 1941.8 1966.8 136885.3 161455.7 177434.0 178891.0 179810.3 14581.0 18790.8 19027.4 19451.7 19468.5 27956.0 29128.6 29183.0 29211.8 29211.9 7933.4 8154.6 8590.7 9662.0 9686.9 7920.2 8022.0 8104.9 8128.2 8180.3 7970.4 8519.6 9029.2 9153.0 9190.9 3663.1 3755.9 3756.7 3791.4 3795.0 804.9 999.6 1007.0 1030.2 1034.3 18917.3 20099.4 20382.0 20532.6 20763.6 930.4 975.5 1007.0 1007.4 1014.8 9171.8 10082.6 10444.4 10515.8 10599.6 699275.0 706940.0 713243.0 726290.0 735798.0 122785.0 147973.8 152255.2 154282.0 155474.4 774.7 823.3 947.5 999.9 1026.5 13994.6 17055.4 17745.4 17808.5 18162.5 46835.5 59075.0 59163.4 60015.1 60514.1 52207.0 75027.6 80931.2 83600.0 84626.6 11019.4 11076.7 11385.5 11492.8 11584.9 12335.1 12341.0 12372.4 12745.9 12767.0 10639.4 10875.4 11036.5 11100.5 11182.6 10384.5 10559.4 10564.8 10910.2 10919.2 10828.0 11054.6 11057.8 11113.8 11137.7 10897.2 11161.0 11229.8 11282.6 11407.9 10558.9 10624.1 10849.2 10920.8 11003.0 15:10:45 INFO - PROCESS | 1639 | 15:10:45 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:6468.48 Median:3625.57 stddev:4021.78 (110.9%) stddev-sans-first:4016.13 15:10:45 INFO - PROCESS | 1639 | Values: 1557.2 1559.0 1570.1 1588.8 1591.8 10214.7 10725.5 10735.5 10740.0 10744.0 10333.5 10470.2 10666.4 10690.9 10820.6 2292.7 2313.9 2328.8 2331.8 2333.8 2332.9 2351.3 2362.2 2362.9 2367.3 2045.5 2292.5 2301.3 2305.3 2333.1 2311.0 2312.5 2330.7 2332.5 2339.3 2281.4 2358.3 2363.2 2365.7 2365.8 9091.0 10879.7 10885.7 10888.0 10893.0 5344.6 5532.5 5544.7 5555.2 5558.1 3319.2 3399.2 3622.2 3628.9 3637.8 1127.6 1156.8 1196.9 1230.3 1244.3 13438.2 13786.1 13801.2 14752.9 14777.2 3739.5 4651.2 4654.7 4664.7 4671.9 11179.9 11199.4 11205.7 11214.0 11217.2 4820.2 5016.9 5017.0 5601.2 5623.8 4226.2 4959.4 5213.5 5235.3 5241.5 3837.0 3979.5 4010.5 4014.3 4033.1 1095.3 1125.2 1126.6 1135.9 1151.2 888.6 916.1 918.1 933.2 944.8 5092.3 6044.0 6368.2 6407.2 6507.6 927.8 955.6 956.8 964.6 976.9 3928.2 3951.9 3973.9 4040.5 4069.4 13000.7 13398.3 13403.1 13403.6 13413.6 11178.6 12901.0 13155.0 13324.9 13344.4 9693.0 9910.7 9918.8 9925.7 9930.7 6426.2 6433.2 6471.8 6660.0 6688.9 11542.4 12110.0 12147.1 12149.0 12155.9 10968.5 11050.8 12092.5 12255.9 12262.3 7859.8 8827.2 8868.7 9044.1 9058.3 8450.6 10215.7 10224.8 10230.3 10295.9 8451.9 8642.5 8735.8 8805.3 8810.4 8237.4 8649.9 8650.9 8715.5 8776.4 7372.6 7544.7 7550.7 7556.6 7597.8 5016.6 5056.0 5191.3 5211.0 5366.2 5741.9 5795.4 5807.4 5852.6 5855.1 15:10:45 INFO - PROCESS | 1639 | 15:10:45 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4583.87 Median:4913.12 stddev:1228.95 (25.0%) stddev-sans-first:1190.68 15:10:45 INFO - PROCESS | 1639 | Values: 354.3 368.7 372.0 373.5 377.6 4808.4 4842.6 5240.6 5361.0 5368.9 4049.4 4735.7 5110.9 5146.8 5251.3 3626.5 4282.5 4295.1 4332.7 4360.3 4357.2 4375.8 4387.0 4388.5 4455.1 4068.2 4073.1 4274.6 4327.8 4371.7 3749.5 4022.8 4031.7 4069.5 4296.6 3510.5 3941.9 4006.4 4018.8 4041.5 4410.6 4836.7 4918.6 4998.3 5078.8 5174.4 5239.3 5253.7 5270.5 5313.8 5557.3 5579.4 5601.9 5619.0 5639.6 4013.4 4537.2 4811.9 4832.8 4902.7 4707.5 4960.3 5101.6 5280.5 5822.8 3821.9 3969.5 4308.3 4805.0 4838.7 4828.7 4852.5 4909.2 5043.6 5053.3 4536.0 4964.6 5243.7 5250.7 5266.8 5055.6 5481.2 5528.5 5541.0 5548.1 1551.5 1591.4 1602.6 1633.5 1695.5 1342.9 1349.0 1369.4 1369.8 1390.0 4494.0 4706.5 4880.6 4889.2 4913.3 4726.6 5120.7 5281.9 5429.4 5450.6 4117.3 4453.9 4695.6 4739.3 4913.0 2483.5 2846.3 2848.6 2849.3 2853.3 4854.4 4911.8 5248.3 5304.6 5678.4 5363.3 5567.7 5573.4 5598.0 5674.4 4840.0 5595.1 5677.3 5712.3 5714.4 4571.7 4752.6 5047.6 5221.9 5576.1 4804.3 4992.8 5359.1 5398.6 5406.6 4799.4 5766.4 5853.5 5876.9 5892.5 4653.8 4924.5 4926.0 4982.1 4985.6 4994.7 5416.5 5482.8 5555.8 5744.7 4896.9 5109.2 5475.7 5524.3 5549.8 4419.8 4900.6 5531.6 5557.2 5632.8 4565.9 4744.4 5059.7 5357.5 5479.3 4992.9 5066.6 5418.1 5470.0 5490.2 4588.7 4774.3 5076.0 5391.7 5398.2 15:10:45 INFO - PROCESS | 1639 | 15:10:45 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:18676.00 Median:4173.45 stddev:26089.79 (625.1%) stddev-sans-first:26128.10 15:10:45 INFO - PROCESS | 1639 | Values: 709.6 721.2 755.5 775.5 825.1 14427.0 15240.7 15271.8 15274.3 15286.8 13595.9 13793.9 13895.1 14026.5 14211.4 935.9 948.4 948.9 949.7 950.2 894.6 925.7 940.4 944.1 944.9 981.6 985.9 987.2 987.6 987.7 980.0 981.2 981.5 982.6 985.2 731.3 732.3 732.8 733.1 734.0 15024.4 15154.5 15193.8 15215.8 15472.5 13431.4 13682.2 13803.2 13804.4 13945.8 11391.2 11508.0 11664.4 11935.8 12227.9 3132.7 3637.2 3660.7 3660.9 3661.8 92974.0 93981.5 104359.0 104729.5 105717.9 8894.8 10604.4 10615.6 10750.3 10853.3 20877.9 21225.8 22116.6 22162.2 22179.9 7378.4 7475.4 7500.9 7503.8 7546.3 4066.2 4143.7 4143.7 4151.6 4195.3 3442.8 3531.7 3539.3 3552.0 3560.2 607.4 614.0 617.1 617.7 618.5 609.3 620.2 632.8 669.0 671.0 9646.8 9743.2 9791.8 9869.6 10167.9 516.3 550.3 571.6 588.4 591.8 4295.2 4389.9 4673.8 4785.2 4792.6 95431.0 96133.0 98447.0 102131.0 103005.5 52131.4 60013.0 66093.0 66195.7 81688.6 53724.5 61937.8 68099.7 69199.0 70807.9 8360.0 9720.7 10694.6 10705.6 10829.8 37849.6 46216.8 46999.0 48015.3 48059.8 56864.4 57038.0 58462.7 58567.7 58714.0 12105.8 12282.8 12438.6 12519.4 13001.2 13944.9 13967.0 14073.6 14099.4 14202.0 13182.7 13254.2 13264.1 13314.4 13363.6 12938.7 13088.6 13405.3 13609.3 13813.9 13095.7 13105.7 13149.6 13164.4 13282.5 10503.2 10865.0 10990.5 11291.6 11567.7 9058.0 9626.0 10574.6 10640.2 10828.2 15:10:45 INFO - PROCESS | 1639 | -------- Summary: end -------- 15:10:45 INFO - PROCESS | 1639 | 15:10:45 INFO - TEST-INFO | 1639: exit 0 15:10:45 INFO - TEST-OK | dromaeo_css | took 1121653ms 15:10:45 INFO - TEST-START | kraken 15:10:45 INFO - operating with platform_type : mac_ 15:10:45 INFO - Initialising browser for kraken test... 15:10:45 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmpF3hLpM/profile http://localhost:49240/getInfo.html) 15:10:48 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 15:10:48 INFO - PROCESS | 1650 | colorDepth:24 15:10:48 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 15:10:48 INFO - PROCESS | 1650 | __metrics 15:10:48 INFO - PROCESS | 1650 | 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" 15:10:48 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:10:49 INFO - TEST-INFO | 1650: exit 0 15:10:49 INFO - Browser initialized. 15:10:49 INFO - Running cycle 1/1 for kraken test... 15:10:49 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmpF3hLpM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:11:01 INFO - PROCESS | 1651 | RSS: Main: 232042496 15:11:01 INFO - PROCESS | 1651 | 15:11:04 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 15:11:04 INFO - PROCESS | 1651 | RSS: Main: 283803648 15:11:04 INFO - PROCESS | 1651 | 15:11:07 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 15:11:08 INFO - PROCESS | 1651 | RSS: Main: 285491200 15:11:08 INFO - PROCESS | 1651 | 15:11:11 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 15:11:12 INFO - PROCESS | 1651 | RSS: Main: 377057280 15:11:12 INFO - PROCESS | 1651 | 15:11:14 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 15:11:14 INFO - PROCESS | 1651 | RSS: Main: 279740416 15:11:14 INFO - PROCESS | 1651 | 15:11:16 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:11:17 INFO - PROCESS | 1651 | RSS: Main: 283213824 15:11:17 INFO - PROCESS | 1651 | 15:11:20 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 15:11:21 INFO - PROCESS | 1651 | RSS: Main: 324132864 15:11:21 INFO - PROCESS | 1651 | 15:11:24 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 15:11:25 INFO - PROCESS | 1651 | RSS: Main: 326426624 15:11:25 INFO - PROCESS | 1651 | 15:11:28 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 15:11:29 INFO - PROCESS | 1651 | RSS: Main: 324820992 15:11:29 INFO - PROCESS | 1651 | 15:11:30 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:11:31 INFO - PROCESS | 1651 | RSS: Main: 299139072 15:11:31 INFO - PROCESS | 1651 | 15:11:33 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:11:33 INFO - PROCESS | 1651 | RSS: Main: 304861184 15:11:33 INFO - PROCESS | 1651 | 15:11:36 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:11:36 INFO - PROCESS | 1651 | RSS: Main: 310841344 15:11:36 INFO - PROCESS | 1651 | 15:11:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:11:40 INFO - PROCESS | 1651 | RSS: Main: 314634240 15:11:40 INFO - PROCESS | 1651 | 15:11:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:11:43 INFO - PROCESS | 1651 | RSS: Main: 315514880 15:11:43 INFO - PROCESS | 1651 | 15:11:45 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 15:11:45 INFO - PROCESS | 1651 | RSS: Main: 360828928 15:11:45 INFO - PROCESS | 1651 | 15:11:45 INFO - PROCESS | 1651 | __start_tp_report 15:11:45 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 15:11:45 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 15:11:45 INFO - PROCESS | 1651 | |i|pagename|runs| 15:11:45 INFO - PROCESS | 1651 | |0;ai-astar;116;116;114;114;113;116;114;114;114;115 15:11:45 INFO - PROCESS | 1651 | |1;audio-beat-detection;146;111;109;146;101;108;95;125;155;127 15:11:45 INFO - PROCESS | 1651 | |2;audio-dft;186;185;188;185;180;182;181;183;183;184 15:11:45 INFO - PROCESS | 1651 | |3;audio-fft;80;64;84;115;63;60;60;62;87;61 15:11:45 INFO - PROCESS | 1651 | |4;audio-oscillator;95;70;89;71;71;68;87;72;91;113 15:11:45 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;87;86;87;87;88;87;87;87;88;87 15:11:45 INFO - PROCESS | 1651 | |6;imaging-darkroom;110;95;95;131;150;95;95;95;119;150 15:11:45 INFO - PROCESS | 1651 | |7;imaging-desaturate;85;83;85;86;83;86;104;141;122;86 15:11:45 INFO - PROCESS | 1651 | |8;json-parse-financial;63;63;61;61;62;61;62;62;62;62 15:11:45 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;54;62;56;64;60;59;57;57;57;57 15:11:45 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;90;89;90;88;88;90;89;91;87;125 15:11:45 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;143;142;141;137;141;135;150;140;160;142 15:11:45 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;177;173;174;176;174;172;172;173;174;176 15:11:45 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;68;68;68;68;69;62;59;69;77;84 15:11:45 INFO - PROCESS | 1651 | __end_tp_report 15:11:45 INFO - PROCESS | 1651 | __start_cc_report 15:11:45 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,2089 15:11:45 INFO - PROCESS | 1651 | __end_cc_report 15:11:45 INFO - PROCESS | 1651 | __startTimestamp1488496305902__endTimestamp 15:11:45 INFO - PROCESS | 1651 | 15:11:45 INFO - PROCESS | 1651 | ------- Summary: start ------- 15:11:45 INFO - PROCESS | 1651 | Number of tests: 14 15:11:45 INFO - PROCESS | 1651 | 15:11:45 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:114.60 Median:114.50 stddev:1.07 (0.9%) stddev-sans-first:1.01 15:11:45 INFO - PROCESS | 1651 | Values: 116.0 116.0 114.0 114.0 113.0 116.0 114.0 114.0 114.0 115.0 15:11:45 INFO - PROCESS | 1651 | 15:11:45 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:122.30 Median:136.50 stddev:20.90 (15.3%) stddev-sans-first:20.33 15:11:45 INFO - PROCESS | 1651 | Values: 146.0 111.0 109.0 146.0 101.0 108.0 95.0 125.0 155.0 127.0 15:11:45 INFO - PROCESS | 1651 | 15:11:45 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.50 stddev:2.41 (1.3%) stddev-sans-first:2.40 15:11:45 INFO - PROCESS | 1651 | Values: 186.0 185.0 188.0 185.0 180.0 182.0 181.0 183.0 183.0 184.0 15:11:45 INFO - PROCESS | 1651 | 15:11:45 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:73.60 Median:63.50 stddev:17.98 (28.3%) stddev-sans-first:18.92 15:11:45 INFO - PROCESS | 1651 | Values: 80.0 64.0 84.0 115.0 63.0 60.0 60.0 62.0 87.0 61.0 15:11:45 INFO - PROCESS | 1651 | 15:11:45 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:82.70 Median:79.50 stddev:14.77 (18.6%) stddev-sans-first:14.97 15:11:45 INFO - PROCESS | 1651 | Values: 95.0 70.0 89.0 71.0 71.0 68.0 87.0 72.0 91.0 113.0 15:11:45 INFO - PROCESS | 1651 | 15:11:45 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:87.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 15:11:45 INFO - PROCESS | 1651 | Values: 87.0 86.0 87.0 87.0 88.0 87.0 87.0 87.0 88.0 87.0 15:11:45 INFO - PROCESS | 1651 | 15:11:45 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:113.50 Median:95.00 stddev:22.91 (24.1%) stddev-sans-first:24.27 15:11:45 INFO - PROCESS | 1651 | Values: 110.0 95.0 95.0 131.0 150.0 95.0 95.0 95.0 119.0 150.0 15:11:45 INFO - PROCESS | 1651 | 15:11:45 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:85.00 stddev:20.12 (23.7%) stddev-sans-first:20.94 15:11:45 INFO - PROCESS | 1651 | Values: 85.0 83.0 85.0 86.0 83.0 86.0 104.0 141.0 122.0 86.0 15:11:45 INFO - PROCESS | 1651 | 15:11:45 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 15:11:45 INFO - PROCESS | 1651 | Values: 63.0 63.0 61.0 61.0 62.0 61.0 62.0 62.0 62.0 62.0 15:11:45 INFO - PROCESS | 1651 | 15:11:45 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:2.98 (5.1%) stddev-sans-first:2.73 15:11:45 INFO - PROCESS | 1651 | Values: 54.0 62.0 56.0 64.0 60.0 59.0 57.0 57.0 57.0 57.0 15:11:45 INFO - PROCESS | 1651 | 15:11:45 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:92.70 Median:89.50 stddev:11.41 (12.8%) stddev-sans-first:12.06 15:11:45 INFO - PROCESS | 1651 | Values: 90.0 89.0 90.0 88.0 88.0 90.0 89.0 91.0 87.0 125.0 15:11:45 INFO - PROCESS | 1651 | 15:11:45 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:142.00 stddev:7.13 (5.0%) stddev-sans-first:7.56 15:11:45 INFO - PROCESS | 1651 | Values: 143.0 142.0 141.0 137.0 141.0 135.0 150.0 140.0 160.0 142.0 15:11:45 INFO - PROCESS | 1651 | 15:11:45 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:174.00 stddev:1.73 (1.0%) stddev-sans-first:1.48 15:11:45 INFO - PROCESS | 1651 | Values: 177.0 173.0 174.0 176.0 174.0 172.0 172.0 173.0 174.0 176.0 15:11:45 INFO - PROCESS | 1651 | 15:11:45 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:68.50 stddev:7.00 (10.2%) stddev-sans-first:7.42 15:11:45 INFO - PROCESS | 1651 | Values: 68.0 68.0 68.0 68.0 69.0 62.0 59.0 69.0 77.0 84.0 15:11:45 INFO - PROCESS | 1651 | -------- Summary: end -------- 15:11:45 INFO - PROCESS | 1651 | 15:11:46 INFO - TEST-INFO | 1651: exit 0 15:11:46 INFO - TEST-OK | kraken | took 61033ms 15:11:46 INFO - SUITE-END | took 1182s 15:11:47 INFO - Completed test suite (00:19:42) 15:11:47 INFO - javascript benchmark 15:11:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7382.463540141872, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2705.310145912792, 3150.9054728358146, 3289.2105894585306, 3315.9502607460877, 3350.5309256704068, 5519.668819870811, 5626.2967129108865, 5627.352854421742, 5719.313682358123, 5740.425957404263, 5533.667979921198, 5608.130739735338, 5649.830505084844, 5660.9716951415285, 5662.348829884564, 5075.467075957008, 5079.492050794928, 5152.407473140581, 5162.0192163489, 5187.455317191697, 4383.846565370212, 5232.6075544334135, 5245.711485868275, 5275.314209152804, 5302.045631786277, 5085.160948443502, 5102.719350435725, 5124.8206312778875, 5137.2807806906685, 5230.843074707765, 5124.769385377667, 5141.537261646432, 5149.150390185615, 5164.535191832753, 5168.741562921877, 5082.822101226439, 5112.335396398445, 5123.513266239701, 5130.769115389817, 5149.6910185389, 5576.972115139439, 5584.664920104807, 5595.468430499096, 5607.355154157283, 5616.831495055155, 6105.217149441772, 6128.319797384534, 6128.667102172704, 6136.807362171507, 6147.784827531015, 6114.306182961508, 6144.064619644798, 6195.783147589857, 6204.47261982732, 6207.968960155215, 5416.83749487516, 5713.143028545752, 5729.541636669056, 5741.483266506035, 5759.222504961818, 6291.433770960544, 6304.653244071528, 6312.5581209314905, 6316.0, 6319.905201421982, 5921.14143449206, 5958.940410595926, 6131.846703832351, 6140.815775526741, 6157.415045570664, 6126.120738204555, 6140.324564297924, 6175.289841668266, 6205.100260462298, 6249.937510623205, 6214.130021796952, 6227.719752611143, 6233.0, 6241.375862413813, 6256.6871656417, 6016.1878146450545, 6109.969450152809, 6229.283632382243, 6237.563370564017, 6255.6872156392, 4865.513448655106, 4904.337914381585, 4905.9264111038365, 4907.460179380265, 4918.754062296943, 4354.042110735633, 4375.343698445258, 4424.889377765581, 4457.754823484739, 4484.215262329145, 5573.749181286771, 5586.301712285965, 5593.692346920959, 5618.6628802272, 5625.0, 6111.166351794787, 6153.969230153821, 6155.199824022849, 6163.506919446433, 6169.2288463942, 5541.141123125922, 5561.082421400504, 5589.301337332833, 5605.0, 5622.606417550732, 5345.1982202669915, 5463.9180412293845, 5466.0, 5476.2333273341765, 5482.890342193134, 6292.182016337847, 6313.43179113882, 6343.460805831556, 6344.460720838781, 6365.52258580599, 6280.309165991828, 6289.811305660837, 6299.08663243818, 6313.936860631335, 6321.652309123042, 6192.81421557354, 6271.498280137669, 6280.811575652738, 6302.0, 6303.747850085945, 6150.7847225346895, 6204.503639708722, 6224.253089629274, 6230.6884655767935, 6236.095766113797, 5215.269862219368, 6053.273607166992, 6264.874702505833, 6287.905681414874, 6291.402316779899, 5781.653100813965, 5861.35525092231, 5877.089051197071, 6059.939400606114, 6062.181605483203, 5806.0, 5897.233359663216, 5903.645781253139, 5904.3800400959, 5925.733341999534, 5782.335031471266, 5784.21913041734, 5784.363719990882, 5785.739641716049, 5789.8263052108505, 5883.2057672213705, 5919.437653422918, 5922.881542369215, 5924.200232968494, 5926.318473375617, 5693.370481284465, 5705.828825135252, 5740.6268592541355, 5752.1659359391815, 5756.510696590669], "value": 5623.592960992307, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.8351304469538, 788.6963519045166, 843.1105184030849, 860.9913900860994, 861.3755027604991, 27380.0, 38456.0, 39065.804670976606, 39442.0, 41104.58895411045, 39682.8095157145, 39792.40311395324, 39920.80039599805, 39961.00097497564, 39968.00079997994, 8985.775355616097, 9153.130452606993, 9159.771005724877, 9163.679271225508, 9171.816563668723, 7226.349628533431, 7419.406447484188, 7424.183339832614, 7465.0295461590185, 7493.625318734069, 10651.78696426071, 10905.0, 10907.236493445462, 11087.944560277228, 11126.109911207084, 10814.243002989793, 10860.565577376896, 10879.347239165676, 10890.455477226107, 10894.509747061402, 7180.389666878322, 10656.467176641137, 10700.090492308163, 10720.51757670899, 10729.624463143831, 27203.183904482896, 27406.862965685243, 27443.86278068617, 39207.21585568273, 39732.40401393981, 3821.197548514815, 3824.445455408978, 3843.0584506796013, 3863.517060367454, 3938.310795610785, 22348.99429525675, 26360.0, 27661.031863884666, 27739.722602773916, 27764.30589235265, 3093.613298337708, 3161.351922855809, 3162.509810979302, 3180.284436001881, 3187.2987942652812, 310823.0, 316341.0, 316377.9999999977, 316556.0, 318244.0, 40778.79610601987, 41977.580224197976, 50018.999620007395, 50138.74930625324, 50223.744406390135, 38708.61291387107, 41104.79447602803, 52115.21827172596, 52382.0, 55185.72407137939, 13549.458021679022, 13642.522511712043, 13650.795238071438, 13655.931720341334, 13656.180629162282, 11684.415779211005, 11696.70758231051, 11729.4135293235, 11733.237339572901, 11733.706657333465, 12053.819192712117, 12122.333271669966, 12129.575464858688, 12143.635690929286, 12165.574204902787, 5028.371453568304, 5328.307320048369, 5336.4129945705945, 5338.172583249525, 5350.17072353778, 996.5814357969671, 1033.1682995188794, 1055.335138862527, 1062.1290541755686, 1067.1782727299935, 15069.849301507064, 15114.924425377803, 15172.317245723969, 15211.0, 15450.99568528042, 985.8866230383597, 1028.3932479836933, 1113.1651261553834, 1154.0536759857005, 1156.9652910412701, 7803.9609801951765, 7809.960950195326, 7881.684732610632, 7906.486078404885, 8078.757637270891, 431081.0, 443712.0, 444026.0, 444247.0, 444721.0, 53290.20064699033, 53302.46697533053, 53315.933681326154, 53372.0, 53420.46579534155, 1409.4996276321963, 1443.4514884343882, 1445.3784872504923, 1446.378057435313, 1449.340550049725, 14776.778348324999, 14809.92595037061, 15297.46458873934, 15414.99802512833, 15432.614184645474, 43255.13489730125, 43266.0, 43308.78345608378, 43363.0, 43387.9153021177, 393322.0, 393817.0, 395485.0, 395728.0, 396264.0, 32056.67943320537, 32165.517517236793, 32228.0, 32525.837370812995, 32674.50988235226, 41445.1710965785, 41457.58542414537, 41505.58494415138, 42063.0, 42085.57914420939, 28421.57367639446, 32201.677983219866, 32980.50529242015, 34056.318873621894, 34914.30171396609, 30539.54190687097, 30944.847078926774, 32033.359332813678, 32322.83838580792, 32348.83825580951, 32095.839520802245, 32695.836520817244, 33044.0, 33176.33647326992, 33307.83346083254, 27248.591271131347, 28098.578521322605, 28949.065441584848, 29188.854055729586, 29508.852455738444, 21229.363119106452, 21342.89328553347, 22066.44833879166, 22298.21956231524, 22397.77602223957], "value": 17110.085782963422, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.8711837975088, 393.9980300098499, 403.1111399364401, 415.5325259083531, 431.9676024298178, 12089.237262586668, 19272.710909336354, 21280.255191068296, 22059.33821985339, 22359.441013974658, 21542.0, 21849.453763655918, 22412.0, 22605.0, 22724.318270451913, 6418.646974416405, 6522.576032557892, 6618.801435956929, 6698.1292431983775, 6758.324167583251, 6518.120053792748, 6664.500162487809, 6666.600003999752, 6678.232003319607, 6693.163354580677, 6357.68211589421, 6500.837479063014, 6576.276609572943, 6592.077109204715, 6666.100076489684, 6455.580387274812, 6482.513811464112, 6526.28210896801, 6607.405333519982, 6610.272869984346, 6410.134631824691, 6422.100905873182, 6427.8393040173905, 6428.228612566522, 6433.131527243809, 22602.660960085614, 26216.344591385176, 26224.475510489683, 26283.60574591383, 26601.866990664923, 2853.571964205386, 2877.9712202877913, 2878.481873262812, 2878.7553057990094, 2880.423915216944, 14964.401423943029, 15209.61975950599, 15314.540563783105, 15616.063036217864, 16398.754018689728, 1920.3662791278844, 1924.3553409607657, 1937.806219378065, 1941.805819418061, 1966.803319668036, 136885.3155734225, 161455.66171213717, 177434.0, 178891.0, 179810.30284545742, 14580.95398885711, 18790.812091878906, 19027.429177124708, 19451.70822437636, 19468.478059849826, 27956.0, 29128.563071553945, 29183.0, 29211.83152673912, 29211.85394073016, 7933.365330773524, 8154.551499667576, 8590.656373745105, 9661.951690241503, 9686.854697179548, 7920.24785128918, 8021.959890200512, 8104.878426823602, 8128.187181281824, 8180.345572354197, 7970.442069055226, 8519.616617252239, 9029.23251523628, 9152.954235228914, 9190.910045029897, 3663.058578953159, 3755.9013813603888, 3756.6896358739723, 3791.431285307226, 3794.9640287769676, 804.8792681097765, 999.6251405722854, 1006.9949650251701, 1030.2324768047702, 1034.3018462537757, 18917.337893173673, 20099.39701808948, 20382.0, 20532.58934821295, 20763.58472830565, 930.3716999476505, 975.512243878061, 1006.954687039085, 1007.445904752398, 1014.8071866345371, 9171.77070573241, 10082.647107351208, 10444.425556594308, 10515.789684206426, 10599.62901298451, 699275.0, 706940.0, 713243.0, 726290.0, 735798.0, 122785.0, 147973.82745917363, 152255.23872380788, 154282.0, 155474.44525554826, 774.7327172125721, 823.279630323467, 947.4694171263976, 999.9050090241416, 1026.4918865161792, 13994.580162595139, 17055.403060893306, 17745.378911738542, 17808.46574602764, 18162.545936351697, 46835.53164468312, 59075.0, 59163.40836591579, 60015.09977350256, 60514.107460657506, 52207.0, 75027.62486187535, 80931.19068809236, 83600.0, 84626.57686711528, 11019.393933333744, 11076.723081923017, 11385.462962499956, 11492.827607585725, 11584.94207528957, 12335.136540442441, 12341.0, 12372.443240054039, 12745.936270318589, 12766.978641708827, 10639.361638301727, 10875.401852898167, 11036.5033573491, 11100.500477478372, 11182.552697892319, 10384.480775961323, 10559.419231942009, 10564.788704226026, 10910.2362834604, 10919.181061420266, 10828.0, 11054.557817687202, 11057.778844422906, 11113.777724445628, 11137.721556961142, 10897.166736648687, 11161.0, 11229.75404919003, 11282.574246537033, 11407.946569617548, 10558.947205264232, 10624.096951758878, 10849.240553161202, 10920.78158436811, 11003.009729124416], "value": 10984.24613524983, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1557.1824791984207, 1559.0489801221247, 1570.050119677595, 1588.7616857471378, 1591.7771511988324, 10214.693559193218, 10725.517351719182, 10735.463226838656, 10740.03339699427, 10744.033037026686, 10333.483325833717, 10470.16238700904, 10666.360018398882, 10690.893091069087, 10820.621278255263, 2292.6561015847633, 2313.8611683299055, 2328.813694904412, 2331.8484298520625, 2333.8366314358, 2332.8716920569364, 2351.271105957159, 2362.1850461590725, 2362.9291121266306, 2367.3016460144213, 2045.5090778213196, 2292.4727312718087, 2301.309607117866, 2305.2738387408, 2333.148400833692, 2311.0, 2312.456572705413, 2330.7436182019965, 2332.54515369503, 2339.2865176121277, 2281.4296425893526, 2358.2689366296504, 2363.220137354686, 2365.6806331145417, 2365.7989070928993, 9091.0, 10879.673609791718, 10885.673429797118, 10888.0, 10893.0, 5344.625876188668, 5532.474414930615, 5544.695041772741, 5555.194496797942, 5558.110702287615, 3319.2365755876285, 3399.2351720862607, 3622.2212224371624, 3628.9274214515563, 3637.781733095996, 1127.644791890552, 1156.7859945910034, 1196.8503937007874, 1230.2864338683542, 1244.265883128949, 13438.19370837743, 13786.103903246358, 13801.171929684251, 14752.926235368754, 14777.187254700988, 3739.495168152319, 4651.162790697639, 4654.650901182425, 4664.720116793003, 4671.929921051187, 11179.888201118047, 11199.384033878216, 11205.719857003478, 11214.0, 11217.15871309655, 4820.180569303227, 5016.949830501721, 5017.0, 5601.243832082617, 5623.775048998076, 4226.218149642326, 4959.380077490314, 5213.504717051874, 5235.319408476874, 5241.528262456397, 3837.0407398150464, 3979.4826672532386, 4010.47863777707, 4014.2573623879093, 4033.092554175346, 1095.3044816541394, 1125.2123513540555, 1126.6056880091903, 1135.8977692007759, 1151.1711567671264, 888.6312180445043, 916.1159481100636, 918.0865039285819, 933.2487347685178, 944.8252073366449, 5092.28707980883, 6044.002739548013, 6368.172137622079, 6407.167068281186, 6507.609543427409, 927.8376284150381, 955.5795450001976, 956.784723437221, 964.6479035152119, 976.9364991275544, 3928.2143571285856, 3951.920961580752, 3973.940390894139, 4040.5353384360587, 4069.4302797608357, 13000.739985200244, 13398.263095529644, 13403.128796628189, 13403.597892063253, 13413.597592072254, 11178.552857885756, 12901.0, 13155.013373996797, 13324.933375333256, 13344.399502022432, 9692.951535242279, 9910.65312714066, 9918.80162396748, 9925.702228933143, 9930.652427165014, 6426.164598602152, 6433.228012638513, 6471.838204044937, 6660.034295027291, 6688.933110668831, 11542.365169915734, 12110.031197504355, 12147.149699520949, 12148.967337776388, 12155.939220303842, 10968.451577421256, 11050.778984420427, 12092.455839487067, 12255.938720306342, 12262.325572093621, 7859.764207073797, 8827.16141966512, 8868.689595864114, 9044.14080662336, 9058.320625953213, 8450.619722112397, 10215.693529194135, 10224.795504090025, 10230.335028223142, 10295.897041029793, 8451.873221901553, 8642.524661143698, 8735.825283494167, 8805.339599530189, 8810.427322224292, 8237.423380363318, 8649.8702519461, 8650.870236946577, 8715.52064636451, 8776.429532080394, 7372.557646541225, 7544.735934242275, 7550.66022029021, 7556.622168891643, 7597.848043039219, 5016.573591244785, 5055.974720126376, 5191.273221749034, 5211.0359583477175, 5366.221897824716, 5741.8564535886935, 5795.3625101237985, 5807.448292412214, 5852.619579727304, 5855.121731740102], "value": 4968.064663132439, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.25075964335423, 368.6608320345282, 371.97706307653954, 373.52748772802425, 377.56014243406435, 4808.350872632193, 4842.612590992721, 5240.580753539717, 5360.954613850301, 5368.91946620801, 4049.4128351389104, 4735.71585704858, 5110.936805239834, 5146.768395422206, 5251.291075704778, 3626.5104210931518, 4282.528921818597, 4295.055087880677, 4332.740035597859, 4360.280553708634, 4357.172137293904, 4375.846845360413, 4386.978065109686, 4388.517263101056, 4455.086707225011, 4068.172620029081, 4073.063195465045, 4274.551172126929, 4327.848525301615, 4371.650267978554, 3749.4938183345307, 4022.839086436539, 4031.677465802758, 4069.47096877407, 4296.613304802551, 3510.473428985647, 3941.9159731073896, 4006.419069234974, 4018.8144497373346, 4041.5150181978056, 4410.558944105596, 4836.709797412166, 4918.631102667314, 4998.250262460624, 5078.771455284521, 5174.353205849269, 5239.345081864767, 5253.658512196695, 5270.4729527047375, 5313.814016509442, 5557.305336832896, 5579.414161513023, 5601.9469389183, 5618.971905140489, 5639.6334238274385, 4013.3545246448816, 4537.2059889519205, 4811.879703007417, 4832.840118371566, 4902.7058376497525, 4707.5057119002695, 4960.2559616057515, 5101.566366858784, 5280.471952804689, 5822.767089316422, 3821.8662346817728, 3969.503812023497, 4308.298222202213, 4805.0, 4838.661293709407, 4828.686135401188, 4852.514748525119, 4909.189983652729, 5043.595572988218, 5053.343065401475, 4535.9773201133785, 4964.553190212898, 5243.68537887728, 5250.687328167958, 5266.8419947401635, 5055.620828437808, 5481.24534693736, 5528.474794894479, 5541.0, 5548.059528449928, 1551.5112739487251, 1591.427245833089, 1602.5833283346415, 1633.4890226540404, 1695.5422036050197, 1342.89256859451, 1348.9797653035212, 1369.431685850361, 1369.7535242928886, 1389.9583012509438, 4494.0, 4706.505816889177, 4880.632363669057, 4889.193283108248, 4913.287573301851, 4726.557036385855, 5120.745417372767, 5281.9207711884355, 5429.4027656957705, 5450.563954883679, 4117.341225403921, 4453.910921781611, 4695.614793635886, 4739.289106634033, 4912.9508704913205, 2483.478469521385, 2846.2599724071893, 2848.5869548915707, 2849.33040735427, 2853.3009412694023, 4854.393200849894, 4911.7544122793715, 5248.317718696545, 5304.628675992643, 5678.432156784371, 5363.2759577456545, 5567.749451274703, 5573.442655734475, 5598.0, 5674.389780700923, 4839.951600484021, 5595.076812326002, 5677.316214123365, 5712.25740653729, 5714.428557144335, 4571.657125715651, 4752.596029337545, 5047.596192304681, 5221.947780522298, 5576.079946808731, 4804.279358096313, 4992.750362481934, 5359.14253719403, 5398.5951053671915, 5406.567474602101, 4799.448063472606, 5766.394528574439, 5853.507355624289, 5876.853078673067, 5892.499137573182, 4653.837115700934, 4924.507549245047, 4926.0, 4982.078315511642, 4985.601151907911, 4994.725290108933, 5416.4563099516445, 5482.835514934558, 5555.833325000256, 5744.741486633196, 4896.853094407174, 5109.20807274873, 5475.698836564027, 5524.33707955048, 5549.833504994856, 4419.779011049499, 4900.558949694545, 5531.640443371168, 5557.249771280987, 5632.81710840728, 4565.931511027404, 4744.430668319824, 5059.747012649426, 5357.517823395913, 5479.274028680953, 4992.926520798046, 5066.5693416058575, 5418.133098704188, 5469.972650136724, 5490.231367608618, 4588.678792484494, 4774.259989701602, 5076.0, 5391.7059905623155, 5398.2442458056685], "value": 4233.905566579217, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.6026225313822, 721.1958666087311, 755.4560716284277, 775.4843029385461, 825.0717942314895, 14427.0, 15240.6951860963, 15271.770923436143, 15274.312655930482, 15286.84713152868, 13595.864041359584, 13793.862061379383, 13895.096818706803, 14026.509072182476, 14211.360488778004, 935.9251259899208, 948.369334392628, 948.8576713492962, 949.6533765175731, 950.1543626172712, 894.5661354243219, 925.7222833150028, 940.3793496292449, 944.117250370902, 944.8629948657475, 981.5975450065474, 985.8915519292872, 987.2496902354227, 987.6148302162162, 987.7333120057616, 980.0395612299986, 981.1709105805583, 981.4994352880011, 982.5971351745785, 985.2462865907586, 731.2833423245249, 732.318943382654, 732.8424388756443, 733.1385621894253, 734.0090877315635, 15024.399024039025, 15154.545363639108, 15193.848061519464, 15215.771763423558, 15472.5358239253, 13431.3955871986, 13682.179069255777, 13803.17180969145, 13804.378802953892, 13945.790813137812, 11391.202615816896, 11508.0, 11664.416779161009, 11935.761284774257, 12227.938860305641, 3132.7023932726356, 3637.1634524059614, 3660.652238037382, 3660.8535658573624, 3661.761985470936, 92974.0, 93981.53009234979, 104358.95641043568, 104729.47635261776, 105717.8856422875, 8894.822103557892, 10604.416757078434, 10615.628453004108, 10750.301230419998, 10853.348799071922, 20877.85171815565, 21225.78774212269, 22116.557668846533, 22162.224322148646, 22179.889100554396, 7378.446616503784, 7475.36459400957, 7500.924990750132, 7503.812404689817, 7546.320831125116, 4066.2274167908004, 4143.6685065194715, 4143.6892233082035, 4151.584841515824, 4195.30777421722, 3442.846646373443, 3531.6644918732677, 3539.2567560812004, 3551.982240088783, 3560.1633616100194, 607.3956413368638, 614.0267675733922, 617.0990354083089, 617.7220250887119, 618.5144661440837, 609.2871340531589, 620.2494981072953, 632.8196464007735, 668.9799306020827, 670.9530332876652, 9646.794150731159, 9743.171830394354, 9791.755206119904, 9869.605215791287, 10167.949160254298, 516.2514354186445, 550.2626480516128, 571.5856004396862, 588.3939542271468, 591.819495054004, 4295.248331541968, 4389.934150987674, 4673.789679464432, 4785.234362501983, 4792.616590672737, 95431.0, 96133.0386696124, 98447.0, 102131.0, 103005.48497257466, 52131.43067065497, 60013.0, 66093.00860487096, 66195.66902165458, 81688.59155704302, 53724.46275537195, 61937.76124477576, 68099.65950170218, 69199.0, 70807.9378809308, 8359.95820020896, 9720.708378748648, 10694.572217111228, 10705.571777128827, 10829.837552436877, 37849.62150378461, 46216.768916155204, 46999.0, 48015.279770802765, 48059.75970120127, 56864.43135568591, 57038.0, 58462.7076864613, 58567.70716146392, 58714.0, 12105.788423153692, 12282.815757763461, 12438.626841194779, 12519.436625352064, 13001.15492492985, 13944.860551394357, 13967.0, 14073.648158796112, 14099.365528551034, 14202.0, 13182.73634527285, 13254.206700974582, 13264.137831041338, 13314.400851961878, 13363.599092027254, 12938.676533086747, 13088.607341779762, 13405.262710551013, 13609.319534023458, 13813.930930345285, 13095.67260818449, 13105.737885242432, 13149.60551183466, 13164.355252346917, 13282.468701252228, 10503.212259080447, 10864.96948042262, 10990.505427255634, 11291.604793832177, 11567.710807229887, 9057.954844116464, 9625.951870240604, 10574.577016919236, 10640.201984851012, 10828.24202305831], "value": 7281.2229226827285, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1472.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 114.0, 114.0, 113.0, 116.0, 114.0, 114.0, 114.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 109.0, 146.0, 101.0, 108.0, 95.0, 125.0, 155.0, 127.0], "value": 122.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 188.0, 185.0, 180.0, 182.0, 181.0, 183.0, 183.0, 184.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 64.0, 84.0, 115.0, 63.0, 60.0, 60.0, 62.0, 87.0, 61.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 70.0, 89.0, 71.0, 71.0, 68.0, 87.0, 72.0, 91.0, 113.0], "value": 82.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 87.0, 88.0, 87.0, 87.0, 87.0, 88.0, 87.0], "value": 87.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 95.0, 95.0, 131.0, 150.0, 95.0, 95.0, 95.0, 119.0, 150.0], "value": 113.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 85.0, 86.0, 83.0, 86.0, 104.0, 141.0, 122.0, 86.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 61.0, 61.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 62.0, 56.0, 64.0, 60.0, 59.0, 57.0, 57.0, 57.0, 57.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 90.0, 88.0, 88.0, 90.0, 89.0, 91.0, 87.0, 125.0], "value": 92.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 142.0, 141.0, 137.0, 141.0, 135.0, 150.0, 140.0, 160.0, 142.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 173.0, 174.0, 176.0, 174.0, 172.0, 172.0, 173.0, 174.0, 176.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 62.0, 59.0, 69.0, 77.0, 84.0], "value": 69.2, "unit": "score"}]}]} 15:11:47 INFO - Return code: 0 15:11:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:11:47 ERROR - # TBPL SUCCESS # 15:11:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:11:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:11:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:11:47 INFO - 2017-03-02 15:11:47.181 screenresolution[1655:10355] starting screenresolution argv=screenresolution get 15:11:47 INFO - 2017-03-02 15:11:47.184 screenresolution[1655:10355] Display 0: 1600x1200x32@50 15:11:47 INFO - 2017-03-02 15:11:47.191 screenresolution[1656:10358] starting screenresolution argv=screenresolution list 15:11:47 INFO - Available Modes on Display 0 15:11:47 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 15:11:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:11:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:11:47 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 15:11:47 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 15:11:47 INFO - Graphics/Displays: 15:11:47 INFO - Intel Iris: 15:11:47 INFO - Chipset Model: Intel Iris 15:11:47 INFO - Type: GPU 15:11:47 INFO - Bus: Built-In 15:11:47 INFO - VRAM (Dynamic, Max): 1536 MB 15:11:47 INFO - Vendor: Intel (0x8086) 15:11:47 INFO - Device ID: 0x0a2e 15:11:47 INFO - Revision ID: 0x0009 15:11:47 INFO - Displays: 15:11:47 INFO - Display: 15:11:47 INFO - Resolution: 1600 x 1200 @ 50 Hz 15:11:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:11:47 INFO - Display Serial Number: 1600x1200 50 15:11:47 INFO - Main Display: Yes 15:11:47 INFO - Mirror: Off 15:11:47 INFO - Online: Yes 15:11:47 INFO - Rotation: Supported 15:11:47 INFO - Return code: 0 15:11:47 INFO - Running post-action listener: _resource_record_post_action 15:11:47 INFO - [mozharness: 2017-03-02 23:11:47.429258Z] Finished run-tests step (success) 15:11:47 INFO - Running post-run listener: _resource_record_post_run 15:11:47 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 41034752; Write bytes: 513785856; Read time: 403; Write time: 1659 15:11:47 INFO - TinderboxPrint: CPU usage
53.8% 15:11:47 INFO - TinderboxPrint: I/O read bytes / time
41,034,752 / 403 15:11:47 INFO - TinderboxPrint: I/O write bytes / time
513,785,856 / 1,659 15:11:47 INFO - TinderboxPrint: CPU idle
2,225.6 (46.2%) 15:11:47 INFO - TinderboxPrint: CPU system
955.3 (19.8%) 15:11:47 INFO - TinderboxPrint: CPU user
1,636.7 (34.0%) 15:11:47 INFO - TinderboxPrint: Swap in / out
249,348,096 / 0 15:11:47 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 202697216; Write bytes: 204249088; Read time: 16056; Write time: 395 15:11:47 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 40014848; Write bytes: 299722752; Read time: 386; Write time: 1231 15:11:47 INFO - Running post-run listener: _upload_blobber_files 15:11:47 INFO - Blob upload gear active. 15:11:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:11:47 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 15:11:47 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'] 15:11:47 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 15:11:48 INFO - (blobuploader) - INFO - Open directory for files ... 15:11:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:11:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:11:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:49 INFO - (blobuploader) - INFO - Done attempting. 15:11:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:11:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:11:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:49 INFO - (blobuploader) - INFO - Done attempting. 15:11:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:11:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:11:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:50 INFO - (blobuploader) - INFO - Done attempting. 15:11:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:11:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:11:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:11:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:11:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:11:53 INFO - (blobuploader) - INFO - Done attempting. 15:11:53 INFO - (blobuploader) - INFO - Iteration through files over. 15:11:53 INFO - Return code: 0 15:11:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:11:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:11:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4db390d4a2e2e98cd738b93cf91e3ceefd0705c0604329c1c8041344d719e03e861c36b1a3f8fd91dc22b79d991366f7a30a4e0406589d39ad87e91c4f28fc52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/514cf57e2cbc66abeab1db7110ae77fd174b877fef39071724c291f3ad474b8484097fcf27fd85e24bd0a4030c86c5844656338c22c63850dddd929198c6fe20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1427a7210b45fb6a50e0c4a4b3ccce2eeec58a56f0a45b73b4712916c7d492f92809559ebe3c963e46bb8f1b5be4061fb5555e1baa6f5da63bf0aeec2458aa46", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/967e2799cddeccda4daf44d36d3fb591ce6c08250bbe922b38dd38c5cbac5e50d0251a3dc8cd0d027e062b22464b084481eb1633f30ddbeaadb2bc49efbc0695"} 15:11:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:11:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:11:53 INFO - Contents: 15:11:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4db390d4a2e2e98cd738b93cf91e3ceefd0705c0604329c1c8041344d719e03e861c36b1a3f8fd91dc22b79d991366f7a30a4e0406589d39ad87e91c4f28fc52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/514cf57e2cbc66abeab1db7110ae77fd174b877fef39071724c291f3ad474b8484097fcf27fd85e24bd0a4030c86c5844656338c22c63850dddd929198c6fe20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1427a7210b45fb6a50e0c4a4b3ccce2eeec58a56f0a45b73b4712916c7d492f92809559ebe3c963e46bb8f1b5be4061fb5555e1baa6f5da63bf0aeec2458aa46", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/967e2799cddeccda4daf44d36d3fb591ce6c08250bbe922b38dd38c5cbac5e50d0251a3dc8cd0d027e062b22464b084481eb1633f30ddbeaadb2bc49efbc0695"} 15:11:53 INFO - Running post-run listener: copy_logs_to_upload_dir 15:11:53 INFO - Copying logs to upload dir... 15:11:53 INFO - mkdir: /builds/slave/test/build/upload/logs 15:11:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.580126 ========= master_lag: 0.68 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-03-02 15:11:53.627066) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-03-02 15:11:53.630337) ========= 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.zWjH27EB8u/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.UY2SndPSIh/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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/4db390d4a2e2e98cd738b93cf91e3ceefd0705c0604329c1c8041344d719e03e861c36b1a3f8fd91dc22b79d991366f7a30a4e0406589d39ad87e91c4f28fc52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/514cf57e2cbc66abeab1db7110ae77fd174b877fef39071724c291f3ad474b8484097fcf27fd85e24bd0a4030c86c5844656338c22c63850dddd929198c6fe20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1427a7210b45fb6a50e0c4a4b3ccce2eeec58a56f0a45b73b4712916c7d492f92809559ebe3c963e46bb8f1b5be4061fb5555e1baa6f5da63bf0aeec2458aa46", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/967e2799cddeccda4daf44d36d3fb591ce6c08250bbe922b38dd38c5cbac5e50d0251a3dc8cd0d027e062b22464b084481eb1633f30ddbeaadb2bc49efbc0695"} build_url:https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010955 build_url: 'https://queue.taskcluster.net/v1/task/XKVtanTrT_aEKUTvim7zWw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4db390d4a2e2e98cd738b93cf91e3ceefd0705c0604329c1c8041344d719e03e861c36b1a3f8fd91dc22b79d991366f7a30a4e0406589d39ad87e91c4f28fc52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/514cf57e2cbc66abeab1db7110ae77fd174b877fef39071724c291f3ad474b8484097fcf27fd85e24bd0a4030c86c5844656338c22c63850dddd929198c6fe20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1427a7210b45fb6a50e0c4a4b3ccce2eeec58a56f0a45b73b4712916c7d492f92809559ebe3c963e46bb8f1b5be4061fb5555e1baa6f5da63bf0aeec2458aa46", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/967e2799cddeccda4daf44d36d3fb591ce6c08250bbe922b38dd38c5cbac5e50d0251a3dc8cd0d027e062b22464b084481eb1633f30ddbeaadb2bc49efbc0695"}' ========= master_lag: 1.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-03-02 15:11:54.675742) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 15:11:54.676121) ========= 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.zWjH27EB8u/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.UY2SndPSIh/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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.005231 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 15:11:54.705813) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 15:11:54.706189) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 15:11:54.706559) ========= ========= Total master_lag: 1.81 =========