builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0227 starttime: 1489052182.13 results: success (0) buildid: 20170309004016 builduid: 13533ca369484615b64bde737027f7d2 revision: fc5b01fb884a73b3bf8d7f03d30b7b8d498c52e9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-09 01:36:22.131886) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-09 01:36:22.132338) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-09 01:36:22.132619) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-09 01:36:22.159138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 01:36:22.159519) ========= 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.B0khhA6xE8/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.W8TU98hJ6b/Listeners TMPDIR=/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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-09 01:36:22-- 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% 38.6M=0s 2017-03-09 01:36:22 (38.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119696 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 01:36:22.303806) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 01:36:22.304122) ========= 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.B0khhA6xE8/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.W8TU98hJ6b/Listeners TMPDIR=/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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.040700 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 01:36:22.366600) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-09 01:36:22.366967) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fc5b01fb884a73b3bf8d7f03d30b7b8d498c52e9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fc5b01fb884a73b3bf8d7f03d30b7b8d498c52e9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.B0khhA6xE8/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.W8TU98hJ6b/Listeners TMPDIR=/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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-09 01:36:22,479 truncating revision to first 12 chars 2017-03-09 01:36:22,479 Setting DEBUG logging. 2017-03-09 01:36:22,479 attempt 1/10 2017-03-09 01:36:22,479 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fc5b01fb884a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-09 01:36:24,035 unpacking tar archive at: mozilla-aurora-fc5b01fb884a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.833331 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-09 01:36:24.223941) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-09 01:36:24.224416) ========= script_repo_revision: fc5b01fb884a73b3bf8d7f03d30b7b8d498c52e9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-09 01:36:24.224923) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-09 01:36:24.225270) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-09 01:36:24.245545) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-09 01:36:24.245984) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.B0khhA6xE8/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.W8TU98hJ6b/Listeners TMPDIR=/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 01:36:24 INFO - MultiFileLogger online at 20170309 01:36:24 in /builds/slave/test 01:36:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:36:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:36:24 INFO - {'append_to_log': False, 01:36:24 INFO - 'base_work_dir': '/builds/slave/test', 01:36:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:36:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:36:24 INFO - 'branch': 'Mozilla-Aurora', 01:36:24 INFO - 'buildbot_json_path': 'buildprops.json', 01:36:24 INFO - 'config_files': ('talos/mac_config.py',), 01:36:24 INFO - 'default_actions': ('clobber', 01:36:24 INFO - 'read-buildbot-config', 01:36:24 INFO - 'download-and-extract', 01:36:24 INFO - 'populate-webroot', 01:36:24 INFO - 'create-virtualenv', 01:36:24 INFO - 'install', 01:36:24 INFO - 'run-tests'), 01:36:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:36:24 INFO - 'download_minidump_stackwalk': True, 01:36:24 INFO - 'download_symbols': 'ondemand', 01:36:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:36:24 INFO - 'tooltool.py': '/tools/tooltool.py', 01:36:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:36:24 INFO - '/tools/misc-python/virtualenv.py')}, 01:36:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:36:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:36:24 INFO - 'gecko_profile': False, 01:36:24 INFO - 'gecko_profile_interval': 0, 01:36:24 INFO - 'installer_path': 'installer.exe', 01:36:24 INFO - 'log_level': 'info', 01:36:24 INFO - 'log_name': 'talos', 01:36:24 INFO - 'log_to_console': True, 01:36:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:36:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:36:24 INFO - 'opt_config_files': (), 01:36:24 INFO - 'pip_index': False, 01:36:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:36:24 INFO - 'cmd': ('bash', 01:36:24 INFO - '-c', 01:36:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:36:24 INFO - 'enabled': True, 01:36:24 INFO - 'halt_on_failure': False, 01:36:24 INFO - 'name': 'check_screen_resolution'},), 01:36:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:36:24 INFO - 'cmd': ('bash', 01:36:24 INFO - '-c', 01:36:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:36:24 INFO - 'enabled': True, 01:36:24 INFO - 'halt_on_failure': False, 01:36:24 INFO - 'name': 'check_screen_resolution'},), 01:36:24 INFO - 'run_cmd_checks_enabled': True, 01:36:24 INFO - 'suite': 'dromaeojs', 01:36:24 INFO - 'system_bits': '32', 01:36:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:36:24 INFO - 'title': 't-yosemite-r7-0227', 01:36:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:36:24 INFO - 'use_talos_json': True, 01:36:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:36:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:36:24 INFO - 'work_dir': 'build'} 01:36:24 INFO - [mozharness: 2017-03-09 09:36:24.456194Z] Running clobber step. 01:36:24 INFO - Running pre-action listener: _resource_record_pre_action 01:36:24 INFO - Running main action method: clobber 01:36:24 INFO - rmtree: /builds/slave/test/build 01:36:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:36:26 INFO - Running post-action listener: _resource_record_post_action 01:36:26 INFO - [mozharness: 2017-03-09 09:36:26.860861Z] Finished clobber step (success) 01:36:26 INFO - [mozharness: 2017-03-09 09:36:26.861026Z] Running read-buildbot-config step. 01:36:26 INFO - Running pre-action listener: _resource_record_pre_action 01:36:26 INFO - Running main action method: read_buildbot_config 01:36:26 INFO - Using buildbot properties: 01:36:26 INFO - { 01:36:26 INFO - "project": "", 01:36:26 INFO - "product": "firefox", 01:36:26 INFO - "script_repo_revision": "production", 01:36:26 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 01:36:26 INFO - "repository": "", 01:36:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 01:36:26 INFO - "buildid": "20170309004016", 01:36:26 INFO - "stage_platform": "macosx64", 01:36:26 INFO - "basedir": "/builds/slave/test", 01:36:26 INFO - "nightly_build": "True", 01:36:26 INFO - "buildnumber": 5, 01:36:26 INFO - "slavename": "t-yosemite-r7-0227", 01:36:26 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 01:36:26 INFO - "platform": "yosemite_r7", 01:36:26 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:36:26 INFO - "branch": "mozilla-aurora", 01:36:26 INFO - "repo_path": "releases/mozilla-aurora", 01:36:26 INFO - "revision": "fc5b01fb884a73b3bf8d7f03d30b7b8d498c52e9", 01:36:26 INFO - "pgo_build": "False", 01:36:26 INFO - "builduid": "13533ca369484615b64bde737027f7d2", 01:36:26 INFO - "slavebuilddir": "test" 01:36:26 INFO - } 01:36:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 01:36:26 INFO - Running post-action listener: _resource_record_post_action 01:36:26 INFO - [mozharness: 2017-03-09 09:36:26.864489Z] Finished read-buildbot-config step (success) 01:36:26 INFO - [mozharness: 2017-03-09 09:36:26.864607Z] Running download-and-extract step. 01:36:26 INFO - Running pre-action listener: _resource_record_pre_action 01:36:26 INFO - Running main action method: download_and_extract 01:36:26 INFO - mkdir: /builds/slave/test/build/tests 01:36: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')]} 01:36:26 INFO - trying https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 01:36:26 INFO - Downloading https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 01:36:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 01:36:28 INFO - Downloaded 1199 bytes. 01:36:28 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 01:36:28 INFO - Using the following test package requirements: 01:36:28 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 01:36:28 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:36:28 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 01:36:28 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:36:28 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 01:36:28 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:36:28 INFO - u'jsshell-mac.zip'], 01:36:28 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:36:28 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 01:36:28 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 01:36:28 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:36:28 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 01:36:28 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:36:28 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 01:36:28 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:36:28 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 01:36:28 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:36:28 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 01:36:28 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 01:36:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 01:36:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:36:28 INFO - Fetch https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 01:36:30 INFO - Expected file size: 51777400 01:36:30 INFO - Obtained file size: 51777400 01:36:45 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 01:36:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 01:36:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:36:45 INFO - Fetch https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 01:36:47 INFO - Expected file size: 51777400 01:36:47 INFO - Obtained file size: 51777400 01:37:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 01:37:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 01:37:02 INFO - Fetch https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 01:37:04 INFO - Expected file size: 14404424 01:37:04 INFO - Obtained file size: 14404424 01:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:05 INFO - trying https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:37:05 INFO - Downloading https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 01:37:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 01:37:08 INFO - Downloaded 74641654 bytes. 01:37:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:37:08 INFO - mkdir: /builds/slave/test/properties 01:37:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:37:08 INFO - Writing to file /builds/slave/test/properties/build_url 01:37:08 INFO - Contents: 01:37:08 INFO - build_url:https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:37:09 INFO - Running post-action listener: _resource_record_post_action 01:37:09 INFO - Running post-action listener: set_extra_try_arguments 01:37:09 INFO - [mozharness: 2017-03-09 09:37:09.023700Z] Finished download-and-extract step (success) 01:37:09 INFO - [mozharness: 2017-03-09 09:37:09.023833Z] Running populate-webroot step. 01:37:09 INFO - Running pre-action listener: _resource_record_pre_action 01:37:09 INFO - Running main action method: populate_webroot 01:37:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:37:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:37:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:37:09 INFO - '--tppagecycles', 01:37:09 INFO - '7'], 01:37:09 INFO - 'tests': ['tsvgm']}}, 01:37:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:37:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:37:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:37:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:37:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:37:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:37:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:37:09 INFO - 'talos_options': ['--disable-e10s'], 01:37:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:37:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:37:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:37:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:37:09 INFO - 'talos_options': ['--disable-e10s'], 01:37:09 INFO - 'tests': ['damp', 'tps']}, 01:37:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:37:09 INFO - 'tests': ['damp', 'tps']}, 01:37:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:37:09 INFO - 'tests': ['dromaeo_dom']}, 01:37:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:37:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:37:09 INFO - 'tests': ['basic_compositor_video']}, 01:37:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:37:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:37:09 INFO - 'tests': ['a11yr', 01:37:09 INFO - 'ts_paint', 01:37:09 INFO - 'tpaint', 01:37:09 INFO - 'sessionrestore', 01:37:09 INFO - 'sessionrestore_no_auto_restore', 01:37:09 INFO - 'tabpaint']}, 01:37:09 INFO - 'other-e10s': {'tests': ['a11yr', 01:37:09 INFO - 'ts_paint', 01:37:09 INFO - 'tpaint', 01:37:09 INFO - 'sessionrestore', 01:37:09 INFO - 'sessionrestore_no_auto_restore', 01:37:09 INFO - 'tabpaint']}, 01:37:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:37:09 INFO - 'ts_paint', 01:37:09 INFO - 'tpaint', 01:37:09 INFO - 'sessionrestore', 01:37:09 INFO - 'sessionrestore_no_auto_restore', 01:37:09 INFO - 'tabpaint']}, 01:37:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:37:09 INFO - 'ts_paint', 01:37:09 INFO - 'tpaint', 01:37:09 INFO - 'sessionrestore', 01:37:09 INFO - 'sessionrestore_no_auto_restore', 01:37:09 INFO - 'tabpaint']}, 01:37:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:37:09 INFO - 'tests': ['a11yr', 01:37:09 INFO - 'ts_paint', 01:37:09 INFO - 'tpaint', 01:37:09 INFO - 'sessionrestore', 01:37:09 INFO - 'sessionrestore_no_auto_restore', 01:37:09 INFO - 'tabpaint']}, 01:37:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:37:09 INFO - 'tests': ['a11yr', 01:37:09 INFO - 'ts_paint', 01:37:09 INFO - 'tpaint', 01:37:09 INFO - 'sessionrestore', 01:37:09 INFO - 'sessionrestore_no_auto_restore', 01:37:09 INFO - 'tabpaint']}, 01:37:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:37:09 INFO - 'tests': ['tsvgx', 01:37:09 INFO - 'tsvgr_opacity', 01:37:09 INFO - 'tart', 01:37:09 INFO - 'tscrollx', 01:37:09 INFO - 'cart', 01:37:09 INFO - 'tsvg_static']}, 01:37:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:37:09 INFO - 'tsvgr_opacity', 01:37:09 INFO - 'tart', 01:37:09 INFO - 'tscrollx', 01:37:09 INFO - 'cart', 01:37:09 INFO - 'tsvg_static']}, 01:37:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:37:09 INFO - 'talos_options': ['--disable-e10s'], 01:37:09 INFO - 'tests': ['tp5o']}, 01:37:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:37:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:37:09 INFO - 'talos_options': ['--disable-e10s', 01:37:09 INFO - '--xperf_path', 01:37:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:37:09 INFO - 'tests': ['tp5n']}, 01:37:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:37:09 INFO - 'talos_options': ['--xperf_path', 01:37:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:37:09 INFO - 'tests': ['tp5n']}}, 01:37:09 INFO - 'talos.zip': {'path': '', 01:37:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:37:09 INFO - Running post-action listener: _resource_record_post_action 01:37:09 INFO - [mozharness: 2017-03-09 09:37:09.042333Z] Finished populate-webroot step (success) 01:37:09 INFO - [mozharness: 2017-03-09 09:37:09.042424Z] Running create-virtualenv step. 01:37:09 INFO - Running pre-action listener: _resource_record_pre_action 01:37:09 INFO - Running main action method: create_virtualenv 01:37:09 INFO - Creating virtualenv /builds/slave/test/build/venv 01:37: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 01:37:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:37:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:37:09 INFO - Using real prefix '/tools/python27' 01:37:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:37:09 INFO - Installing distribute.............................................................................................................................................................................................done. 01:37:12 INFO - Installing pip.................done. 01:37:12 INFO - Return code: 0 01:37:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:37:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:37:13 INFO - Reading from file tmpfile_stdout 01:37:13 INFO - Output received: 01:37: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) 01:37:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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 0x103ff1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ff4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feae0d89a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dcfd30>, '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 0x103cf6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dc4be8>, '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.B0khhA6xE8/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.W8TU98hJ6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 01:37: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 01:37: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 01:37:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0khhA6xE8/Render', 01:37:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:13 INFO - 'HOME': '/Users/cltbld', 01:37:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:13 INFO - 'LOGNAME': 'cltbld', 01:37:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:13 INFO - 'MOZ_NO_REMOTE': '1', 01:37:13 INFO - 'NO_EM_RESTART': '1', 01:37:13 INFO - 'PAGER': '/bin/cat', 01:37:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:13 INFO - 'PWD': '/builds/slave/test', 01:37:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:13 INFO - 'SHELL': '/bin/bash', 01:37:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W8TU98hJ6b/Listeners', 01:37:13 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 01:37:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:13 INFO - 'USER': 'cltbld', 01:37:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:13 INFO - 'XPC_FLAGS': '0x0', 01:37:13 INFO - 'XPC_SERVICE_NAME': '0', 01:37:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37: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 01:37:13 INFO - Cleaning up... 01:37:13 INFO - Return code: 0 01:37:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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 0x103ff1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ff4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feae0d89a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dcfd30>, '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 0x103cf6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dc4be8>, '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.B0khhA6xE8/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.W8TU98hJ6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 01:37: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 01:37: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 01:37:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0khhA6xE8/Render', 01:37:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:13 INFO - 'HOME': '/Users/cltbld', 01:37:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:13 INFO - 'LOGNAME': 'cltbld', 01:37:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:13 INFO - 'MOZ_NO_REMOTE': '1', 01:37:13 INFO - 'NO_EM_RESTART': '1', 01:37:13 INFO - 'PAGER': '/bin/cat', 01:37:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:13 INFO - 'PWD': '/builds/slave/test', 01:37:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:13 INFO - 'SHELL': '/bin/bash', 01:37:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W8TU98hJ6b/Listeners', 01:37:13 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 01:37:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:13 INFO - 'USER': 'cltbld', 01:37:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:13 INFO - 'XPC_FLAGS': '0x0', 01:37:13 INFO - 'XPC_SERVICE_NAME': '0', 01:37:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:13 INFO - Downloading/unpacking psutil>=3.1.1 01:37:13 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 01:37:13 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 01:37:13 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 01:37:13 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 01:37:13 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 01:37:13 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 01:37:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:37:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:37:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:37:17 INFO - Installing collected packages: psutil 01:37:17 INFO - Running setup.py install for psutil 01:37:17 INFO - building 'psutil._psutil_osx' extension 01:37: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 01:37: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 01:37: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 01:37:17 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 01:37:17 INFO - building 'psutil._psutil_posix' extension 01:37:17 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 01:37:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:37:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:37:17 INFO - ^ 01:37:18 INFO - 1 warning generated. 01:37: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 01:37:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:37:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:37:18 INFO - Successfully installed psutil 01:37:18 INFO - Cleaning up... 01:37:18 INFO - Return code: 0 01:37:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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 0x103ff1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ff4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feae0d89a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dcfd30>, '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 0x103cf6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dc4be8>, '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.B0khhA6xE8/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.W8TU98hJ6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 01:37: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 01:37: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 01:37:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0khhA6xE8/Render', 01:37:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:18 INFO - 'HOME': '/Users/cltbld', 01:37:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:18 INFO - 'LOGNAME': 'cltbld', 01:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:18 INFO - 'MOZ_NO_REMOTE': '1', 01:37:18 INFO - 'NO_EM_RESTART': '1', 01:37:18 INFO - 'PAGER': '/bin/cat', 01:37:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:18 INFO - 'PWD': '/builds/slave/test', 01:37:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:18 INFO - 'SHELL': '/bin/bash', 01:37:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W8TU98hJ6b/Listeners', 01:37:18 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 01:37:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:18 INFO - 'USER': 'cltbld', 01:37:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:18 INFO - 'XPC_FLAGS': '0x0', 01:37:18 INFO - 'XPC_SERVICE_NAME': '0', 01:37:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:37:18 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 01:37:18 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 01:37:18 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 01:37:18 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 01:37:18 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 01:37:18 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 01:37:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:37:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:37:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:37:21 INFO - Installing collected packages: mozsystemmonitor 01:37:21 INFO - Running setup.py install for mozsystemmonitor 01:37:22 INFO - Successfully installed mozsystemmonitor 01:37:22 INFO - Cleaning up... 01:37:22 INFO - Return code: 0 01:37:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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 0x103ff1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ff4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feae0d89a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dcfd30>, '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 0x103cf6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dc4be8>, '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.B0khhA6xE8/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.W8TU98hJ6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 01:37: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 01:37: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 01:37:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0khhA6xE8/Render', 01:37:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:22 INFO - 'HOME': '/Users/cltbld', 01:37:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:22 INFO - 'LOGNAME': 'cltbld', 01:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:22 INFO - 'MOZ_NO_REMOTE': '1', 01:37:22 INFO - 'NO_EM_RESTART': '1', 01:37:22 INFO - 'PAGER': '/bin/cat', 01:37:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:22 INFO - 'PWD': '/builds/slave/test', 01:37:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:22 INFO - 'SHELL': '/bin/bash', 01:37:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W8TU98hJ6b/Listeners', 01:37:22 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 01:37:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:22 INFO - 'USER': 'cltbld', 01:37:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:22 INFO - 'XPC_FLAGS': '0x0', 01:37:22 INFO - 'XPC_SERVICE_NAME': '0', 01:37:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:22 INFO - Downloading/unpacking jsonschema==2.5.1 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:37:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:37:25 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 01:37:25 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 01:37:25 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 01:37:25 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 01:37:25 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 01:37:25 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 01:37:25 INFO - Downloading functools32-3.2.3-2.tar.gz 01:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:37:25 INFO - warning: no files found matching '*.txt' 01:37:25 INFO - no previously-included directories found matching 'build' 01:37:25 INFO - no previously-included directories found matching 'dist' 01:37:25 INFO - no previously-included directories found matching '.git*' 01:37:25 INFO - Installing collected packages: jsonschema, functools32 01:37:25 INFO - Running setup.py install for functools32 01:37:25 INFO - warning: no files found matching '*.txt' 01:37:25 INFO - no previously-included directories found matching 'build' 01:37:25 INFO - no previously-included directories found matching 'dist' 01:37:25 INFO - no previously-included directories found matching '.git*' 01:37:25 INFO - Successfully installed jsonschema functools32 01:37:25 INFO - Cleaning up... 01:37:25 INFO - Return code: 0 01:37:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:37:25 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')]} 01:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:25 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')]} 01:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:25 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 0x103ff1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ff4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feae0d89a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dcfd30>, '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 0x103cf6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dc4be8>, '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.B0khhA6xE8/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.W8TU98hJ6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 01:37:25 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 01:37:25 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 01:37:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0khhA6xE8/Render', 01:37:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:25 INFO - 'HOME': '/Users/cltbld', 01:37:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:26 INFO - 'LOGNAME': 'cltbld', 01:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:26 INFO - 'MOZ_NO_REMOTE': '1', 01:37:26 INFO - 'NO_EM_RESTART': '1', 01:37:26 INFO - 'PAGER': '/bin/cat', 01:37:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:26 INFO - 'PWD': '/builds/slave/test', 01:37:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:26 INFO - 'SHELL': '/bin/bash', 01:37:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W8TU98hJ6b/Listeners', 01:37:26 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 01:37:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:26 INFO - 'USER': 'cltbld', 01:37:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:26 INFO - 'XPC_FLAGS': '0x0', 01:37:26 INFO - 'XPC_SERVICE_NAME': '0', 01:37:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:37:26 INFO - Cleaning up... 01:37:26 INFO - Return code: 0 01:37:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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', '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 0x103ff1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ff4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feae0d89a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dcfd30>, '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 0x103cf6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dc4be8>, '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.B0khhA6xE8/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.W8TU98hJ6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 01:37: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:37: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 blobuploader==1.2.4 01:37:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0khhA6xE8/Render', 01:37:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:26 INFO - 'HOME': '/Users/cltbld', 01:37:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:26 INFO - 'LOGNAME': 'cltbld', 01:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:26 INFO - 'MOZ_NO_REMOTE': '1', 01:37:26 INFO - 'NO_EM_RESTART': '1', 01:37:26 INFO - 'PAGER': '/bin/cat', 01:37:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:26 INFO - 'PWD': '/builds/slave/test', 01:37:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:26 INFO - 'SHELL': '/bin/bash', 01:37:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W8TU98hJ6b/Listeners', 01:37:26 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 01:37:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:26 INFO - 'USER': 'cltbld', 01:37:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:26 INFO - 'XPC_FLAGS': '0x0', 01:37:26 INFO - 'XPC_SERVICE_NAME': '0', 01:37:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:26 INFO - Downloading/unpacking blobuploader==1.2.4 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37:29 INFO - Downloading blobuploader-1.2.4.tar.gz 01:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:37:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:37:29 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 01:37:29 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 01:37:29 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 01:37:29 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 01:37:29 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 01:37:29 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 01:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:37:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:37:29 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 01:37:29 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 01:37:29 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 01:37:29 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 01:37:29 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 01:37:29 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 01:37:30 INFO - Downloading docopt-0.6.1.tar.gz 01:37:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:37:30 INFO - Installing collected packages: blobuploader, requests, docopt 01:37:30 INFO - Running setup.py install for blobuploader 01:37:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:37:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:37:30 INFO - Running setup.py install for requests 01:37:31 INFO - Running setup.py install for docopt 01:37:31 INFO - Successfully installed blobuploader requests docopt 01:37:31 INFO - Cleaning up... 01:37:31 INFO - Return code: 0 01:37:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:31 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 0x103ff1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ff4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feae0d89a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dcfd30>, '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 0x103cf6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dc4be8>, '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.B0khhA6xE8/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.W8TU98hJ6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 01:37:31 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 01:37:31 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 01:37:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0khhA6xE8/Render', 01:37:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:31 INFO - 'HOME': '/Users/cltbld', 01:37:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:31 INFO - 'LOGNAME': 'cltbld', 01:37:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:31 INFO - 'MOZ_NO_REMOTE': '1', 01:37:31 INFO - 'NO_EM_RESTART': '1', 01:37:31 INFO - 'PAGER': '/bin/cat', 01:37:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:31 INFO - 'PWD': '/builds/slave/test', 01:37:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:31 INFO - 'SHELL': '/bin/bash', 01:37:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W8TU98hJ6b/Listeners', 01:37:31 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 01:37:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:31 INFO - 'USER': 'cltbld', 01:37:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:31 INFO - 'XPC_FLAGS': '0x0', 01:37:31 INFO - 'XPC_SERVICE_NAME': '0', 01:37:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:37:31 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-QpgTcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:37:31 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-NpAtkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:37:31 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-Ou6ey3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:37:31 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-AEsdKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:37:32 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-o0K3dP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:37:32 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-0Xm3bV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:37:32 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-46fD18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:37:32 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-XdDbb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:37:32 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-Un2wn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:37:32 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-4cOU3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:37:32 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-vjfAz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:37:32 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-IZNECW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:37:32 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-D_HjV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:37:32 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-b8VIi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:33 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-BSFOM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:37:33 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-xjQhSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:37:33 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-xrdS9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:37:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:37:33 INFO - Running setup.py install for manifestparser 01:37:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:37:33 INFO - Running setup.py install for mozcrash 01:37:33 INFO - Running setup.py install for mozdebug 01:37:33 INFO - Running setup.py install for mozdevice 01:37:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:37:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:37:33 INFO - Running setup.py install for mozfile 01:37:34 INFO - Running setup.py install for mozhttpd 01:37:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:37:34 INFO - Running setup.py install for mozinfo 01:37:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:37:34 INFO - Running setup.py install for mozInstall 01:37:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:37:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:37:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:37:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:37:34 INFO - Running setup.py install for mozleak 01:37:34 INFO - Running setup.py install for mozlog 01:37:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:37:34 INFO - Running setup.py install for moznetwork 01:37:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:37:35 INFO - Running setup.py install for mozprocess 01:37:35 INFO - Running setup.py install for mozprofile 01:37:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:37:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:37:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:37:35 INFO - Running setup.py install for mozrunner 01:37:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:37:35 INFO - Running setup.py install for mozscreenshot 01:37:35 INFO - Running setup.py install for moztest 01:37:35 INFO - Running setup.py install for mozversion 01:37:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:37:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:37:35 INFO - Cleaning up... 01:37:35 INFO - Return code: 0 01:37:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:37:35 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')]} 01:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:35 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')]} 01:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:35 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 0x103ff1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ff4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feae0d89a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dcfd30>, '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 0x103cf6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dc4be8>, '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.B0khhA6xE8/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.W8TU98hJ6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 01:37:35 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 01:37:35 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 01:37:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0khhA6xE8/Render', 01:37:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:35 INFO - 'HOME': '/Users/cltbld', 01:37:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:35 INFO - 'LOGNAME': 'cltbld', 01:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:35 INFO - 'MOZ_NO_REMOTE': '1', 01:37:35 INFO - 'NO_EM_RESTART': '1', 01:37:35 INFO - 'PAGER': '/bin/cat', 01:37:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:35 INFO - 'PWD': '/builds/slave/test', 01:37:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:35 INFO - 'SHELL': '/bin/bash', 01:37:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W8TU98hJ6b/Listeners', 01:37:35 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 01:37:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:35 INFO - 'USER': 'cltbld', 01:37:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:35 INFO - 'XPC_FLAGS': '0x0', 01:37:35 INFO - 'XPC_SERVICE_NAME': '0', 01:37:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:37:36 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-zsMj26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:37:36 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)) 01:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:37:36 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-Ym45G1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:37:36 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)) 01:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:37:36 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-U_koGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:37:36 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)) 01:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:37:36 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-jWyCFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:37:36 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)) 01:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:37:36 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-2zMaBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:37:36 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)) 01:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:37:36 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-0ckU85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:37:36 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)) 01:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:37:36 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-dnpKFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:37:36 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)) 01:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:37:36 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-cl6Isn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:37: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)) 01:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:37:37 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-Xl0A1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:37: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)) 01:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:37:37 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-Nxxss0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:37:37 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)) 01:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:37:37 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-YL43eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:37:37 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)) 01:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:37:37 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-6Z9sZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:37:37 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)) 01:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:37:37 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-9stgF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:37:37 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)) 01:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:37:37 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-vw3rRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:37:37 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)) 01:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:37 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-SbLFw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:37 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)) 01:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:37:37 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-XK6L7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:37:37 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)) 01:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:37:37 INFO - Running setup.py (path:/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/pip-cGx0qM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:37: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)) 01:37: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)) 01:37: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)) 01:37: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)) 01:37: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)) 01:37: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)) 01:37:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37:40 INFO - Downloading blessings-1.6.tar.gz 01:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:37:40 INFO - Installing collected packages: blessings 01:37:40 INFO - Running setup.py install for blessings 01:37:40 INFO - Successfully installed blessings 01:37:40 INFO - Cleaning up... 01:37:41 INFO - Return code: 0 01:37:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:37:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:37:41 INFO - Reading from file tmpfile_stdout 01:37:41 INFO - Current package versions: 01:37:41 INFO - blessings == 1.6 01:37:41 INFO - blobuploader == 1.2.4 01:37:41 INFO - docopt == 0.6.1 01:37:41 INFO - functools32 == 3.2.3-2 01:37:41 INFO - jsonschema == 2.5.1 01:37:41 INFO - manifestparser == 1.1 01:37:41 INFO - mozInstall == 1.12 01:37:41 INFO - mozcrash == 1.0 01:37:41 INFO - mozdebug == 0.1 01:37:41 INFO - mozdevice == 0.49 01:37:41 INFO - mozfile == 1.2 01:37:41 INFO - mozhttpd == 0.7 01:37:41 INFO - mozinfo == 0.9 01:37:41 INFO - mozleak == 0.1 01:37:41 INFO - mozlog == 3.4 01:37:41 INFO - moznetwork == 0.27 01:37:41 INFO - mozprocess == 0.25 01:37:41 INFO - mozprofile == 0.28 01:37:41 INFO - mozrunner == 6.13 01:37:41 INFO - mozscreenshot == 0.1 01:37:41 INFO - mozsystemmonitor == 0.3 01:37:41 INFO - moztest == 0.8 01:37:41 INFO - mozversion == 1.4 01:37:41 INFO - psutil == 3.1.1 01:37:41 INFO - requests == 1.2.3 01:37:41 INFO - wsgiref == 0.1.2 01:37:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:41 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 0x103ff1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ff4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feae0d89a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dcfd30>, '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 0x103cf6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dc4be8>, '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.B0khhA6xE8/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.W8TU98hJ6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 01:37:41 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 01:37:41 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 01:37:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0khhA6xE8/Render', 01:37:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:41 INFO - 'HOME': '/Users/cltbld', 01:37:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:41 INFO - 'LOGNAME': 'cltbld', 01:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:41 INFO - 'MOZ_NO_REMOTE': '1', 01:37:41 INFO - 'NO_EM_RESTART': '1', 01:37:41 INFO - 'PAGER': '/bin/cat', 01:37:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:41 INFO - 'PWD': '/builds/slave/test', 01:37:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:41 INFO - 'SHELL': '/bin/bash', 01:37:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W8TU98hJ6b/Listeners', 01:37:41 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 01:37:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:41 INFO - 'USER': 'cltbld', 01:37:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:41 INFO - 'XPC_FLAGS': '0x0', 01:37:41 INFO - 'XPC_SERVICE_NAME': '0', 01:37:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:41 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)) 01:37:41 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)) 01:37:41 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)) 01:37:41 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)) 01:37:41 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)) 01:37:41 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)) 01:37:41 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)) 01:37:41 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)) 01:37:41 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)) 01:37:41 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)) 01:37:41 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)) 01:37:41 INFO - Cleaning up... 01:37:41 INFO - Return code: 0 01:37:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103ff1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ff4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feae0d89a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103dcfd30>, '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 0x103cf6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dc4be8>, '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.B0khhA6xE8/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.W8TU98hJ6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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 01:37:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:37:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0khhA6xE8/Render', 01:37:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:41 INFO - 'HOME': '/Users/cltbld', 01:37:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:41 INFO - 'LOGNAME': 'cltbld', 01:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:41 INFO - 'MOZ_NO_REMOTE': '1', 01:37:41 INFO - 'NO_EM_RESTART': '1', 01:37:41 INFO - 'PAGER': '/bin/cat', 01:37:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:41 INFO - 'PWD': '/builds/slave/test', 01:37:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:41 INFO - 'SHELL': '/bin/bash', 01:37:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W8TU98hJ6b/Listeners', 01:37:41 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 01:37:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:41 INFO - 'USER': 'cltbld', 01:37:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:41 INFO - 'XPC_FLAGS': '0x0', 01:37:41 INFO - 'XPC_SERVICE_NAME': '0', 01:37:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:37:41 INFO - Cleaning up... 01:37:41 INFO - Return code: 0 01:37:41 INFO - Running post-action listener: _resource_record_post_action 01:37:41 INFO - Running post-action listener: _start_resource_monitoring 01:37:41 INFO - Starting resource monitoring. 01:37:41 INFO - [mozharness: 2017-03-09 09:37:41.877488Z] Finished create-virtualenv step (success) 01:37:41 INFO - [mozharness: 2017-03-09 09:37:41.878457Z] Running install step. 01:37:41 INFO - Running pre-action listener: _resource_record_pre_action 01:37:41 INFO - Running main action method: install 01:37:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:37:42 INFO - Reading from file tmpfile_stdout 01:37:42 INFO - Detecting whether we're running mozinstall >=1.0... 01:37:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:37:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:37:42 INFO - Reading from file tmpfile_stdout 01:37:42 INFO - Output received: 01:37:42 INFO - Usage: mozinstall [options] installer 01:37:42 INFO - Options: 01:37:42 INFO - -h, --help show this help message and exit 01:37:42 INFO - -d DEST, --destination=DEST 01:37:42 INFO - Directory to install application into. [default: 01:37:42 INFO - "/builds/slave/test"] 01:37:42 INFO - --app=APP Application being installed. [default: firefox] 01:37:42 INFO - mkdir: /builds/slave/test/build/application 01:37:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:37:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 01:38:02 INFO - Reading from file tmpfile_stdout 01:38:02 INFO - Output received: 01:38:02 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 01:38:02 INFO - Running post-action listener: _resource_record_post_action 01:38:02 INFO - [mozharness: 2017-03-09 09:38:02.071337Z] Finished install step (success) 01:38:02 INFO - [mozharness: 2017-03-09 09:38:02.071500Z] Running run-tests step. 01:38:02 INFO - Running pre-action listener: _resource_record_pre_action 01:38:02 INFO - Running main action method: run_tests 01:38:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:38:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:38:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:38:02 INFO - 2017-03-09 01:38:02.086 screenresolution[1620:7331] starting screenresolution argv=screenresolution get 01:38:02 INFO - 2017-03-09 01:38:02.088 screenresolution[1620:7331] Display 0: 1600x1200x32@60 01:38:02 INFO - 2017-03-09 01:38:02.094 screenresolution[1621:7334] starting screenresolution argv=screenresolution list 01:38:02 INFO - Available Modes on Display 0 01:38:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:38:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:38:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:38:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:38:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:38:02 INFO - Intel Iris: 01:38:02 INFO - Chipset Model: Intel Iris 01:38:02 INFO - Type: GPU 01:38:02 INFO - Bus: Built-In 01:38:02 INFO - VRAM (Dynamic, Max): 1536 MB 01:38:02 INFO - Vendor: Intel (0x8086) 01:38:02 INFO - Device ID: 0x0a2e 01:38:02 INFO - Revision ID: 0x0009 01:38:02 INFO - Displays: 01:38:02 INFO - Display: 01:38:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:38:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:38:02 INFO - Display Serial Number: 1600x1200 60 01:38:02 INFO - Main Display: Yes 01:38:02 INFO - Mirror: Off 01:38:02 INFO - Online: Yes 01:38:02 INFO - Rotation: Supported 01:38:02 INFO - Return code: 0 01:38:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:38:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:38:02 INFO - Python 2.7.3 01:38:02 INFO - Return code: 0 01:38:02 INFO - grabbing minidump binary from tooltool 01:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:02 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 0x103dcfd30>, '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 0x103cf6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103dc4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:38:02 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 01:38:02 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 01:38:02 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 01:38:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:38:02 INFO - Return code: 0 01:38:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:38:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:38:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:38:02 INFO - ENV: RUST_BACKTRACE is now 1 01:38:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:38:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:38:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0227', '--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 01:38:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0227 --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 01:38:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B0khhA6xE8/Render', 01:38:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:02 INFO - 'HOME': '/Users/cltbld', 01:38:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:02 INFO - 'LOGNAME': 'cltbld', 01:38:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:38:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:02 INFO - 'MOZ_NO_REMOTE': '1', 01:38:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:38:02 INFO - 'NO_EM_RESTART': '1', 01:38:02 INFO - 'PAGER': '/bin/cat', 01:38:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:02 INFO - 'PWD': '/builds/slave/test', 01:38:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:38:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:02 INFO - 'RUST_BACKTRACE': '1', 01:38:02 INFO - 'SHELL': '/bin/bash', 01:38:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W8TU98hJ6b/Listeners', 01:38:02 INFO - 'TMPDIR': '/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/', 01:38:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:02 INFO - 'USER': 'cltbld', 01:38:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:02 INFO - 'XPC_FLAGS': '0x0', 01:38:02 INFO - 'XPC_SERVICE_NAME': '0', 01:38:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0227', '--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 01:38:02 INFO - mozversion application_buildid: 20170309004016 01:38:02 INFO - mozversion application_changeset: fc5b01fb884a73b3bf8d7f03d30b7b8d498c52e9 01:38:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:38:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:38:02 INFO - mozversion application_name: Firefox 01:38:02 INFO - mozversion application_remotingname: firefox-dev 01:38:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:38:02 INFO - mozversion application_vendor: Mozilla 01:38:02 INFO - mozversion application_version: 54.0a2 01:38:02 INFO - mozversion platform_buildid: 20170309004016 01:38:02 INFO - mozversion platform_changeset: fc5b01fb884a73b3bf8d7f03d30b7b8d498c52e9 01:38:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:38:02 INFO - mozversion platform_version: 54.0a2 01:38:02 INFO - using testdate: 1489052282 01:38:02 INFO - actual date: 1489052282 01:38:02 INFO - starting webserver on 'localhost:49241' 01:38:02 INFO - SUITE-START | Running 2 tests 01:38:02 INFO - TEST-START | dromaeo_css 01:38:02 INFO - operating with platform_type : mac_ 01:38:02 INFO - Initialising browser for dromaeo_css test... 01:38:02 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/tmpLO7dD2/profile http://localhost:49241/getInfo.html) 01:38:05 INFO - PROCESS | 1631 | __metrics Screen width/height:1600/1200 01:38:05 INFO - PROCESS | 1631 | colorDepth:24 01:38:05 INFO - PROCESS | 1631 | Browser inner width/height: 1024/689 01:38:05 INFO - PROCESS | 1631 | __metrics 01:38:05 INFO - PROCESS | 1631 | 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" 01:38:05 INFO - PROCESS | 1631 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:38:06 INFO - TEST-INFO | 1631: exit 0 01:38:06 INFO - Browser initialized. 01:38:06 INFO - Running cycle 1/1 for dromaeo_css test... 01:38:06 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/tmpLO7dD2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:38:18 INFO - PROCESS | 1634 | RSS: Main: 214560768 01:38:18 INFO - PROCESS | 1634 | 01:41:23 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 01:41:25 INFO - PROCESS | 1634 | RSS: Main: 358617088 01:41:25 INFO - PROCESS | 1634 | 01:43:08 INFO - PROCESS | 1634 | ************************* 01:43:08 INFO - PROCESS | 1634 | A coding exception was thrown and uncaught in a Task. 01:43:08 INFO - PROCESS | 1634 | 01:43:08 ERROR - PROCESS | 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:43:08 INFO - PROCESS | 1634 | Full stack: 01:43:08 INFO - PROCESS | 1634 | ************************* 01:44:27 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 01:44:28 INFO - PROCESS | 1634 | RSS: Main: 353312768 01:44:28 INFO - PROCESS | 1634 | 01:47:31 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 01:47:31 INFO - PROCESS | 1634 | RSS: Main: 329539584 01:47:31 INFO - PROCESS | 1634 | 01:50:34 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 01:50:34 INFO - PROCESS | 1634 | RSS: Main: 319209472 01:50:34 INFO - PROCESS | 1634 | 01:53:38 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 01:53:39 INFO - PROCESS | 1634 | RSS: Main: 326615040 01:53:39 INFO - PROCESS | 1634 | 01:56:42 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 01:56:43 INFO - PROCESS | 1634 | RSS: Main: 426934272 01:56:43 INFO - PROCESS | 1634 | 01:56:43 INFO - PROCESS | 1634 | __start_tp_report 01:56:43 INFO - PROCESS | 1634 | _x_x_mozilla_page_load 01:56:43 INFO - PROCESS | 1634 | _x_x_mozilla_page_load_details 01:56:43 INFO - PROCESS | 1634 | |i|pagename|runs| 01:56:43 INFO - PROCESS | 1634 | |0;dojo.html;3317.6018877734673;3338.449155889277;3384;3430.228198655303;3431.330890476358;5862.06207006879;5887.175795388649;5895.734691938862;5911.5861889667685;5914.763409463627;5841.620294680843;5920.289565252176;5928.525717942565;5931.792387266447;5955.731992060357;5282.154855223174;5309.761060752276;5349.411564727877;5432.728363581825;5444.700541470217;5243.947560524384;5246.475352464742;5261.1319132343115;5321.388040375348;5433.483819037205;5387.865303367408;5415.0523658359825;5420.214068960018;5430.131179011359;5431.864203394927;4536.72779633223;5405.135178371442;5419.83740487786;5441.782328706847;5448.618596698233;5164.32863727713;5207.244949482304;5268.5521730652945;5352.91970620441;5371.060064488699;5756.712164391805;5778.797742079049;5784.595078344518;5788.82633520995;5817.941820581825;6231.532635052344;6291.779787707408;6297.33877942814;6313.873722525524;6325.304216536178;6263.24841019076;6297.716602752887;6325.367463253684;6333;6358.80923572289;6048.1834952281315;6051.636901785819;6054.273487181566;6057.969710151465;6058.273007239115;6379.96810015947;6416.230052393649;6421.903671444932;6424.582402143939;6450.322716114741;6124.5100391968535;6132.397922269778;6135.232666670055;6137.959273351923;6357.745690172434;5273.841784746463;6285.340039295899;6312.0531920211415;6316.810495685137;6332.715027823759;5568.638038527563;5817.418258174233;5998.790042348497;6208.9689551551955;6373.139626150503;6293.30773614902;6355.046742988497;6355.618662880242;6364.681765911686;6372.745090196433;5060.468650791614;5068.189089745623;5072.391313042384;5103.923441148386;5105.693658380509;4443.111377724404;4488.281874900001;4522.412086428809;4561.68068235227;4609.331646911246;5677.80127695537;5790.392008839095;5802.129680547867;5812.9536683396545;5818.8254352369495;6332.145160403379;6338.112664227012;6349.841253968688;6350.142730731384;6365.172527571386;5864.941350586525;5877.059670452707;5935.228420305419;5944;5950.315713692894;5542.75057622408;5552.694601796859;5567.49892509668;5588;5593.972030139823;5433.945660543423;6450.580712253689;6454.19322584677;6459.483241340681;6460.160179176677;5340.599455040965;6285.025820997753;6335.176427064452;6345.238571371465;6402.87194256103;5257.263983042453;6319.968400158154;6335.429811317003;6348.841278967878;6349.396807303298;6305.8108256752375;6311.2426508819235;6363.968180159255;6375;6391.520635952229;6269.467095296951;6290.559660823698;6303.243610766737;6346.841328966812;6352.110704501281;6131.662758548323;6344.619322840645;6345.904811427925;6353.491720662429;6358.713857876314;6202.751889924352;6292.370762923671;6301.968490157703;6305.621662700252;6320.810375688737;5912.054071348563;6000.159977603052;6056.3035250946705;6069.241344831896;6107.206063211754;6219.782307619212;6342;6349.523785715997;6358.268799088164;6372.713227904848;6134.6625935573975;6137.41694539018;6140.140380346845;6148.231471066117;6157.4458298753325 01:56:43 INFO - PROCESS | 1634 | |1;ext.html;772.64072206424;798.2855344466701;820.7948012996749;876.7720392697901;893.3300024981264;28093.719062809392;28413.005544805936;29185.978490752826;29220.831166753356;29289.853550732216;36409.45385819215;41976;43970.560294397044;44044.55955440445;44104;9093.95453022734;9222.861657075116;9240.122188392092;9241;9244.8613270801;7280.308370704801;9130.04134565871;9235.769105772342;9236.445813251226;9260.212881905012;7449.9627501862415;10838.72903177419;11086.113110951144;11102;11109.500072496716;11049.337039777598;11090.889091109066;11093;11114.499847506882;11163.274387164849;7197.532160409609;10833.620823271227;10902.073323767489;10902.400367979759;10909;27881.302967425774;28062.719372806216;28076.57885131725;28111.29721756952;38420.80789596062;3877.263319969197;3920.941185882214;3928.175083232496;3945.1123497213184;3948.269570129535;27088.1873543794;27093.593596095878;27107.1867843965;27120.59319110215;28170.43659126806;3034.908952731422;3061.311204978862;3188.85650145744;3274.8690052397874;3288.2765791525826;340600;341236;341834;342118;342845;52081;52282.69293267699;52441.16455924024;52476;52476.47523524792;54819.725901370235;54901.725491372286;54949.725251374286;55007.72496137574;55010;14749.188794616399;14908;14915.030523015968;14916;14956.326965286587;12790.232586044867;12791.552295669608;12805.615831525069;12811.359432028361;12826.61520154397;10390.792184156275;10911.890881091087;11205.215634905479;12584.874151258553;12687.936560317139;4886.098726035531;6021.909671354933;6165.32181460039;6185.536084793658;6203.8138855833495;954.8663187153666;956.6412595276771;956.7512446763892;988.0712130597216;990.2276224544867;27393.726062739515;28329;29237.415251694845;29534.704652953624;29584.852075739484;977.8510250455686;994.6319861651091;1045.7385653586603;1068;1078.8543546621263;14668.339924703414;15001.024933379296;15094.283267955663;15132.243387830784;15268.389264429521;360048;428300;429034;429851;430056;48472.27291590629;54602;56715.298541043834;56851;57216.71391643015;1414.1727089652463;1454.6654269517858;1454.985450145485;1462.5246794791735;1469.0304399096544;26310.21069367922;27225.910963561237;27708.450514935495;27827.44345113127;28004.019859304826;42234.57765422307;42474;42476.93807654834;42524.36213456739;42531.7873410631;422700;422831;423440;424399;424698;32478.35043299168;33028.66971330256;33044.66955330416;33111.83444082764;33116.337673245915;43750.34374484449;44097.338539921286;44167.55832441634;44367.89080273019;44634.55365446304;32205.033848984567;33560;35768.82115589405;35859.462108068925;37168.6283137176;32047.038588842373;33191.66808331886;35572.93281201568;36716.26567468689;36729.714459993775;35436.645633544365;35800.64199357973;35804.64195358013;36453.45319820152;36610.45084323684;31034.53448198324;32410.35179296448;32443;32486;32578.185545361557;23918.043278268673;23927;24182.032718691054;24362.634560481252;24548.772561372218 01:56:43 INFO - PROCESS | 1634 | |2;jquery.html;380.16363999201764;424.5413522357588;428.89920868595885;435.18185810675925;450.80390030336804;15959.760603590956;20423.072892495173;21691.67462488064;21870.562588748217;21887.562248755035;21175.470613234676;21757.456063598416;22031.889840550815;22413.21553745619;22701.20545780898;6285.465735412496;6351.904721429194;6408.295087540367;6538;6555.6394398308075;4028.053407449247;6317.873642527146;6449.6130232186215;6467;6476.579022363531;4206.684498662613;4246.384274280227;4274.187904298189;4345.69580129391;7345.19202887682;7343.7062517499235;7397.70409183632;7415.221401752792;7421.035265415516;7431.591262480534;6909.619970901598;7221.386182174521;7234.348908598251;7248.238934911864;7270.382017528516;25760.09839655603;25998.6100208497;26542.6018609721;26852;27150.32124196891;2881.654201495834;2883.207118042534;2911.1333049866976;2930.4432157890146;2964.8962286319875;15153.318100685496;15407.3837046518;15419.768703469457;15458.5362439127;16088.356465741357;2013.748281464817;2042.2647846775149;2053.8151566359097;2057.2182570623067;2063.473814177375;136840.31579842136;142434;162385;163755.25548795477;173874;12329.314860353008;19210;20474.897625511778;20589.38231853047;20614.969251537364;27886.442271154465;27939.301517462227;30390.84804575963;31672.366552668816;32585.674143258264;8915.73252802417;9936.453495057696;10270.486475676187;10482;10617;8427.452215605967;8649.610767515476;8674.089220631742;8833.205011548991;8847.42491738035;7312.976183334337;7481.7755467336065;9287.90712092884;9437.575309111107;9500.714978550655;3235.482322828383;3796.5383327419145;3831.50190475242;3835.520559930009;3842.3852183650483;872.9214370706667;1030.953607087683;1047.1361127070197;1048.984265236022;1070.983935240972;19151.712724309145;21109;21148.47128821792;21168.047437865334;21428.89285553562;1058.2327812336148;1069.946502674863;1092.5356723392526;1108.2796182481452;1109.944502774858;9327.041321322462;10263.127634151031;11089.667309980714;11121.27711698737;11126.388048657402;577577;674229;794688;805568;807185;142203;152751;152873.2356338211;154995;158125.62811557835;1250.8936740376987;1267.6830792301926;1314.309987256698;1324.576135636587;1325.430065072009;14900.627484312545;18056.72914906251;19493.8050619492;19520.90239548793;19531.24218820313;39794.594855227726;57860.71069644625;58289.4171058284;61908;62462.68768656128;83413;84218.57890710507;86257;86295.1370486287;86788.99995027002;11190.104791616814;11231.55073797039;11235.325880447199;11472.94263528677;11570.074394048288;12253.816192756938;12647.430865610886;12741.745165096461;12771.425285862344;12813.167144135601;10736.677899663022;10871.130309575374;10891.292066015683;10893.237473377105;11115.944420277847;8455.830883382421;10507;10620.628278010232;10697.78361664593;10958.397288149228;10095.242856785917;10786.191035672198;11121.221514494231;11236.438178091226;11324.716882077684;10974.615888443866;11014.339139651325;11153.330800152016;11154;11507.884921150682;10652.520636571218;10720.839187412352;10845.295055821347;11029.117670586173;11095 01:56:43 INFO - PROCESS | 1634 | |3;mootools.html;1515.9621009474754;1537.3235776258446;1563.7341651919173;1569.3330334607788;1572.3867691600276;10600.628977985762;11168;11178;11182.16133789965;11182.16133789965;10740.73148171296;11206.327620342785;11306;11321.773564528705;11330.603428879991;2395.2694428199393;2407.6749638798715;2422.818288628351;2424.1273141668985;2429.331933718233;2372.027468737818;2401.03958416633;2410.6986626671664;2418.9274321770376;2419.2379400488876;2373.632087026505;2390.605550084234;2396.436837343223;2403.1348714462865;2404.1345115758313;2341.4731685370825;2360.055977608953;2366.8698221597806;2370.4073981504625;2371.205646108556;2321.3964369263945;2329.173143534038;2384.9165279215144;2388.1283331583845;2393.1743548475747;11056.060234880046;11176.832347514794;11197.440127993568;11197.496112674868;11205.775884482346;5747.453991870766;5924.763009479616;5926.229590153295;5927.881442371128;5952.880942381128;3556.0931962349696;3581;3655.6161603031833;3669.633036696309;3695.4826324314618;1172.3317708905927;1172.4548085140366;1231.907606929475;1234.3766397969057;1242.6582689760298;13742.03805733599;14009.789853152211;14346.49787257441;15366.154861482613;15586.688266234612;4027.416024676464;4212.410262563244;4325.7404555726125;4329.718568293051;4357.237483440385;11635.360055197045;11784.234024788362;11821.113416493798;11824.940875295568;11842.940785296018;5836.824895253149;5840.182374467578;5851.268591426072;5863.794767183128;5882.882342353129;4395.494518130456;5065.518775716301;5221.765020574083;5300.575953923677;5355.116405793078;3397.8810741623925;3801.315763162602;3818.7326887118193;3895.5325360956867;3930.21395720857;1059.2320567588438;1059.7456610413444;1065.5844220753913;1076.9192310576582;1080.4327727942737;910.7814124610178;929.5445231836487;934.56075644447;944.7071407863584;980.7450062983676;6528;6536.869262614721;6571.737130514726;6682.866342673119;6804.76183333581;992.5607769080171;994.3039872089422;1004.1314263162312;1024.882138554061;1031.9484025798681;4077.2660921033907;4096.446979657768;4153.335466325373;4168.958310416918;4260.978695106504;13470.326483675777;13958.092723973112;13958.860411395755;13995.720085598232;14001.089929154572;12784.6803829905;13869.306534673226;13885.722285554233;13887.930560347133;13891.235982020884;8584.442011269248;9929.751756206153;10226.335288206243;10236.385816851012;10242.283040187265;5665.3201615806365;6342.746290148342;6839.213490448463;6942.271061538466;6987.624207769383;11604.593839215588;12016.137498687718;12028.338441385458;12032.578859740217;12054.75890482168;12091.39543022863;12399.380030998234;12413.75172496563;12573.93713031429;12623.87376126227;9166.266698664223;9222.492762897837;9346.813063738824;9392.67125650599;9400;10110.292279540361;10308.32995855267;10309.639162629272;10320.741981450525;10323.63867264642;8893.199612034949;8948.418352807046;8999.865002024844;9193.586288616894;9297.58262851677;7655.349295309961;8912.197902188835;8973.28213742912;8995;9034.2320902724;7521.661525231269;7830.647620857189;7951.721689740832;7966;7967.56178410193;5448.128299472065;5461.836144915659;5626.606137570495;5658.321001479684;5668.574856885668;4713.929291060568;5844.736986835517;6042.516598672184;6074.848128796815;6150.7847225346895 01:56:43 INFO - PROCESS | 1634 | |4;prototype.html;346.9210754553339;376.8304263081614;384.44255829047887;385.4738282244736;389.75250715795477;4078.306687863063;4187.560306167854;4815.542523460274;4892.3150758893735;4904.87737806555;4335.1142253119915;4691.818304488413;4697.389339385883;4962;4991.051700176964;3409.919948831217;3477.426224672926;3726.9813650931706;3796.791176485292;3823;3226.2579606690474;3671.3942199537178;3965.6430921217084;4018.97990510047;4163.68772342074;3702.426123950792;3705.610910854362;4035.616616421435;4108.85619003335;4160.812763425638;3871.8831340770666;4014;4139.730917490384;4171.436856024428;4209.85265515707;3516.5604299462566;3688.1517251032415;3763.8682646107527;3771.3211621908044;3779.714896935028;4784.976075119637;4848.945164546313;4882.41411030675;4891.315215869781;5017.422996355429;4147.875563733093;4196.265653510654;4557;4852.514748525155;4863.756812159378;4758.881027974294;4901.803927842882;5046.23381816365;5318.510816971254;5424.721616920902;3673.1918977824835;3725.913488446479;4199.958000419987;4236.216299984482;4252.829886804524;4873.512648735134;4874.878128046792;5052.368453943221;5390.625390525469;5566.443355664442;3638.8362523686496;3821.8280177392085;4028.798560071985;4089.8548406446243;4113.8971525711495;3699.72252081095;3821.8662346817728;3923.8234279457492;4307.104873855494;4336.674749393808;4253.894322310476;4499.245294335212;4604.815807367668;4730.172219861579;4769.379980602499;4576.58810707038;5083.847484575469;5227.477252274742;5250.238715386247;5353.7590808413715;1439.0142752214767;1490.3963894622696;1500.9699806003819;1513.9772903406458;1516.9533022214637;989.8366769482955;1075.0861767497565;1110.3670907582762;1132.2810015639964;1135.7728454309172;4297.261382597098;4418.690691651554;4435.401220835146;4908.754562271872;4963.429205641325;4716.8207948013;5029.44834924394;5409.56723462122;5461.672299662033;5554.583406244547;4296.474751463248;4566.383538222364;4802.903941921212;5044.344235249394;5088.898222035538;2645.3386653336665;2745.1764470659123;2796.944061118766;2843.6161118249183;2874.841883696375;4756.9286460703115;4897.534734200317;5161.9676064786445;5606.271184746039;5671.8163507050085;4653.484622334905;4845.667441453628;5190.935858149071;5372.946270537323;5378.408375078739;5277.569579773101;5406.189071639285;5421;5559.805406810742;5584.93886161628;4230.7884605770205;5030.566288607729;5093.439721630543;5176.602317374212;5215.783292100918;5157.355330583677;5199.272101905812;5331.4401987790725;5397.379301380392;5416.864578385572;5229.137192363218;5402.108652072521;5438.347398312069;5487.341519017584;5488.615796894339;3961.9603803962746;4234.7670878102;4249.3413520904305;4263.7189103829305;4265.936010959776;4844.46710861812;4854.878628034327;4985.227289770091;5173.1722924331925;5227.843164705065;4146.035584557057;4835.347228124158;4884.511548845087;5273.837726532103;5387.434319396563;4499.302608095751;5206.5314121729225;5223.224103804725;5233.816816411408;5262.97368513155;4481.843135490242;4541.704789188824;4859.3682821233015;5097.286379906742;5228.790848366175;4457.7771111444945;4989.600831933364;5041.2438134280155;5226.608004399762;5316;4346.456692913386;4459.888502787457;4496.662750293675;5074.441811400817;5102.36220472441 01:56:43 INFO - PROCESS | 1634 | |5;yui.html;739.3382922284552;762.2529920677736;774.4462709162948;832.3258160889679;848.5841937450651;12956.676083097927;14159.362828672709;14722.926385368059;14970.700585988274;15286.54140375789;14455.710885782279;14559.344829482672;14623.561293161196;15004.399824007027;15482.380704771796;943.5942544705791;966.246327864267;966.8259713251612;968.5205823117567;973.2943615878502;927.7031349967979;940.2665920581957;948.8624149498319;966.6423423333376;973.2360097323602;1004.5228516454698;1004.9598016079348;1008.349614498648;1009.5557954500033;1010.9342892711987;991.7124034030122;992.8709267795176;992.8808542974817;994.125169850527;995.4276291132592;740.5778706137504;743.2567432567432;743.4795643049887;743.7805847275067;744.326384621918;15207.61980950474;15496.457623983219;15543.98964067332;16124.516264512084;16435.1782410879;13973.23147226902;14021.929890350482;14125.152490850582;14128;14131.71736565263;10107.545160467796;11706.648800535997;11777.470013849397;11899.405029748477;12078.69803254917;3574.3566158091535;3697.0572504011575;3765.435184722286;3846.173072789336;3859.073822282632;94274.17177484618;105873;106550.46724766404;112243;112635.43682281618;10343.224258180517;10414.687559373231;10561.207909406825;10790.190735694854;10928;23021.42446438819;23229.3031209064;23258.185963491196;23269.650955235684;23272.76727232706;7676;7726.9227307726205;7729;7730.342920851791;7840.686372545034;4254.532001479834;4284.736002879095;4363.040131171138;4417.801198946056;4440.977795111004;3435.793852368866;3537.0980399997834;3537.4340105582983;3538.9469157962653;3544.7518673692593;511.36834664839625;616.1312549305458;624.4536030972898;624.519120277393;624.9312575616678;662.5097427903316;667.6127845849493;689.3761146162731;692.2523674431602;694.8992396102536;9058.109849860903;9608.951955240318;9829.852552211723;9831.935293588283;9958;541.265294207867;543.9918401223985;570.5777724483935;571.5741772379604;620.6524346365959;4508.526604706459;4766.95233047672;4796.616270698336;4849.830255941025;4953.157963146274;89281;90382;91948;93697.531512342;99205.50397247968;51073.744631277346;76329;89850.55074724584;92368;97768.04463910683;61415.38584614186;61883;67239;68510.97233541402;74173;10204.795904082026;10542.314749541256;10739.946300268448;10779.13766898662;10909.127269818237;41223;42460.78769606132;44512.10975780531;47641.5235847651;48327;56688.16559171942;56891.14663279971;57156.71421642865;62162.68918655378;63702.68148659227;13092.80360794608;13457.259850708306;13613.251271180181;13896.374663140385;14446.927765361106;14346.928265358607;14704.338304776096;14930.477433289783;15001.47494837719;15153.621159471102;12887.742245155232;13033.47866085346;13473.528426505418;13543.187408755506;13722.519711810039;11941.462634181657;13331.400086995915;14365;14560.49038283655;14580.781288280472;12918.547850825553;12982.903701066703;13045.869541304844;13189.076764626385;13198.010149239037;11127.387993660426;11325.207235493766;11407.714807129889;11413.885861141282;11957.940210298893;10899.346039237671;10931.83602245951;11050.33697978124;11055.889441105808;11085.50115244832 01:56:43 INFO - PROCESS | 1634 | __end_tp_report 01:56:43 INFO - PROCESS | 1634 | __start_cc_report 01:56:43 INFO - PROCESS | 1634 | _x_x_mozilla_cycle_collect,1417 01:56:43 INFO - PROCESS | 1634 | __end_cc_report 01:56:43 INFO - PROCESS | 1634 | __startTimestamp1489053403003__endTimestamp 01:56:43 INFO - PROCESS | 1634 | 01:56:43 INFO - PROCESS | 1634 | ------- Summary: start ------- 01:56:43 INFO - PROCESS | 1634 | Number of tests: 6 01:56:43 INFO - PROCESS | 1634 | 01:56:43 INFO - PROCESS | 1634 | [#0] dojo.html Cycles:165 Average:5841.59 Median:6056.30 stddev:651.18 (10.8%) stddev-sans-first:622.35 01:56:43 INFO - PROCESS | 1634 | Values: 3317.6 3338.4 3384.0 3430.2 3431.3 5862.1 5887.2 5895.7 5911.6 5914.8 5841.6 5920.3 5928.5 5931.8 5955.7 5282.2 5309.8 5349.4 5432.7 5444.7 5243.9 5246.5 5261.1 5321.4 5433.5 5387.9 5415.1 5420.2 5430.1 5431.9 4536.7 5405.1 5419.8 5441.8 5448.6 5164.3 5207.2 5268.6 5352.9 5371.1 5756.7 5778.8 5784.6 5788.8 5817.9 6231.5 6291.8 6297.3 6313.9 6325.3 6263.2 6297.7 6325.4 6333.0 6358.8 6048.2 6051.6 6054.3 6058.0 6058.3 6380.0 6416.2 6421.9 6424.6 6450.3 6124.5 6132.4 6135.2 6138.0 6357.7 5273.8 6285.3 6312.1 6316.8 6332.7 5568.6 5817.4 5998.8 6209.0 6373.1 6293.3 6355.0 6355.6 6364.7 6372.7 5060.5 5068.2 5072.4 5103.9 5105.7 4443.1 4488.3 4522.4 4561.7 4609.3 5677.8 5790.4 5802.1 5813.0 5818.8 6332.1 6338.1 6349.8 6350.1 6365.2 5864.9 5877.1 5935.2 5944.0 5950.3 5542.8 5552.7 5567.5 5588.0 5594.0 5433.9 6450.6 6454.2 6459.5 6460.2 5340.6 6285.0 6335.2 6345.2 6402.9 5257.3 6320.0 6335.4 6348.8 6349.4 6305.8 6311.2 6364.0 6375.0 6391.5 6269.5 6290.6 6303.2 6346.8 6352.1 6131.7 6344.6 6345.9 6353.5 6358.7 6202.8 6292.4 6302.0 6305.6 6320.8 5912.1 6000.2 6056.3 6069.2 6107.2 6219.8 6342.0 6349.5 6358.3 6372.7 6134.7 6137.4 6140.1 6148.2 6157.4 01:56:43 INFO - PROCESS | 1634 | 01:56:43 INFO - PROCESS | 1634 | [#1] ext.html Cycles:180 Average:53621.93 Median:341535.00 stddev:104672.70 (30.6%) stddev-sans-first:104891.12 01:56:43 INFO - PROCESS | 1634 | Values: 772.6 798.3 820.8 876.8 893.3 28093.7 28413.0 29186.0 29220.8 29289.9 36409.5 41976.0 43970.6 44044.6 44104.0 9094.0 9222.9 9240.1 9241.0 9244.9 7280.3 9130.0 9235.8 9236.4 9260.2 7450.0 10838.7 11086.1 11102.0 11109.5 11049.3 11090.9 11093.0 11114.5 11163.3 7197.5 10833.6 10902.1 10902.4 10909.0 27881.3 28062.7 28076.6 28111.3 38420.8 3877.3 3920.9 3928.2 3945.1 3948.3 27088.2 27093.6 27107.2 27120.6 28170.4 3034.9 3061.3 3188.9 3274.9 3288.3 340600.0 341236.0 341834.0 342118.0 342845.0 52081.0 52282.7 52441.2 52476.0 52476.5 54819.7 54901.7 54949.7 55007.7 55010.0 14749.2 14908.0 14915.0 14916.0 14956.3 12790.2 12791.6 12805.6 12811.4 12826.6 10390.8 10911.9 11205.2 12584.9 12687.9 4886.1 6021.9 6165.3 6185.5 6203.8 954.9 956.6 956.8 988.1 990.2 27393.7 28329.0 29237.4 29534.7 29584.9 977.9 994.6 1045.7 1068.0 1078.9 14668.3 15001.0 15094.3 15132.2 15268.4 360048.0 428300.0 429034.0 429851.0 430056.0 48472.3 54602.0 56715.3 56851.0 57216.7 1414.2 1454.7 1455.0 1462.5 1469.0 26310.2 27225.9 27708.5 27827.4 28004.0 42234.6 42474.0 42476.9 42524.4 42531.8 422700.0 422831.0 423440.0 424399.0 424698.0 32478.4 33028.7 33044.7 33111.8 33116.3 43750.3 44097.3 44167.6 44367.9 44634.6 32205.0 33560.0 35768.8 35859.5 37168.6 32047.0 33191.7 35572.9 36716.3 36729.7 35436.6 35800.6 35804.6 36453.5 36610.5 31034.5 32410.4 32443.0 32486.0 32578.2 23918.0 23927.0 24182.0 24362.6 24548.8 01:56:43 INFO - PROCESS | 1634 | 01:56:43 INFO - PROCESS | 1634 | [#2] jquery.html Cycles:180 Average:42051.95 Median:21171.76 stddev:123261.67 (582.2%) stddev-sans-first:123567.74 01:56:43 INFO - PROCESS | 1634 | Values: 380.2 424.5 428.9 435.2 450.8 15959.8 20423.1 21691.7 21870.6 21887.6 21175.5 21757.5 22031.9 22413.2 22701.2 6285.5 6351.9 6408.3 6538.0 6555.6 4028.1 6317.9 6449.6 6467.0 6476.6 4206.7 4246.4 4274.2 4345.7 7345.2 7343.7 7397.7 7415.2 7421.0 7431.6 6909.6 7221.4 7234.3 7248.2 7270.4 25760.1 25998.6 26542.6 26852.0 27150.3 2881.7 2883.2 2911.1 2930.4 2964.9 15153.3 15407.4 15419.8 15458.5 16088.4 2013.7 2042.3 2053.8 2057.2 2063.5 136840.3 142434.0 162385.0 163755.3 173874.0 12329.3 19210.0 20474.9 20589.4 20615.0 27886.4 27939.3 30390.8 31672.4 32585.7 8915.7 9936.5 10270.5 10482.0 10617.0 8427.5 8649.6 8674.1 8833.2 8847.4 7313.0 7481.8 9287.9 9437.6 9500.7 3235.5 3796.5 3831.5 3835.5 3842.4 872.9 1031.0 1047.1 1049.0 1071.0 19151.7 21109.0 21148.5 21168.0 21428.9 1058.2 1069.9 1092.5 1108.3 1109.9 9327.0 10263.1 11089.7 11121.3 11126.4 577577.0 674229.0 794688.0 805568.0 807185.0 142203.0 152751.0 152873.2 154995.0 158125.6 1250.9 1267.7 1314.3 1324.6 1325.4 14900.6 18056.7 19493.8 19520.9 19531.2 39794.6 57860.7 58289.4 61908.0 62462.7 83413.0 84218.6 86257.0 86295.1 86789.0 11190.1 11231.6 11235.3 11472.9 11570.1 12253.8 12647.4 12741.7 12771.4 12813.2 10736.7 10871.1 10891.3 10893.2 11115.9 8455.8 10507.0 10620.6 10697.8 10958.4 10095.2 10786.2 11121.2 11236.4 11324.7 10974.6 11014.3 11153.3 11154.0 11507.9 10652.5 10720.8 10845.3 11029.1 11095.0 01:56:43 INFO - PROCESS | 1634 | 01:56:43 INFO - PROCESS | 1634 | [#3] mootools.html Cycles:180 Average:6711.70 Median:2414.81 stddev:4208.87 (174.3%) stddev-sans-first:4202.57 01:56:43 INFO - PROCESS | 1634 | Values: 1516.0 1537.3 1563.7 1569.3 1572.4 10600.6 11168.0 11178.0 11182.2 11182.2 10740.7 11206.3 11306.0 11321.8 11330.6 2395.3 2407.7 2422.8 2424.1 2429.3 2372.0 2401.0 2410.7 2418.9 2419.2 2373.6 2390.6 2396.4 2403.1 2404.1 2341.5 2360.1 2366.9 2370.4 2371.2 2321.4 2329.2 2384.9 2388.1 2393.2 11056.1 11176.8 11197.4 11197.5 11205.8 5747.5 5924.8 5926.2 5927.9 5952.9 3556.1 3581.0 3655.6 3669.6 3695.5 1172.3 1172.5 1231.9 1234.4 1242.7 13742.0 14009.8 14346.5 15366.2 15586.7 4027.4 4212.4 4325.7 4329.7 4357.2 11635.4 11784.2 11821.1 11824.9 11842.9 5836.8 5840.2 5851.3 5863.8 5882.9 4395.5 5065.5 5221.8 5300.6 5355.1 3397.9 3801.3 3818.7 3895.5 3930.2 1059.2 1059.7 1065.6 1076.9 1080.4 910.8 929.5 934.6 944.7 980.7 6528.0 6536.9 6571.7 6682.9 6804.8 992.6 994.3 1004.1 1024.9 1031.9 4077.3 4096.4 4153.3 4169.0 4261.0 13470.3 13958.1 13958.9 13995.7 14001.1 12784.7 13869.3 13885.7 13887.9 13891.2 8584.4 9929.8 10226.3 10236.4 10242.3 5665.3 6342.7 6839.2 6942.3 6987.6 11604.6 12016.1 12028.3 12032.6 12054.8 12091.4 12399.4 12413.8 12573.9 12623.9 9166.3 9222.5 9346.8 9392.7 9400.0 10110.3 10308.3 10309.6 10320.7 10323.6 8893.2 8948.4 8999.9 9193.6 9297.6 7655.3 8912.2 8973.3 8995.0 9034.2 7521.7 7830.6 7951.7 7966.0 7967.6 5448.1 5461.8 5626.6 5658.3 5668.6 4713.9 5844.7 6042.5 6074.8 6150.8 01:56:43 INFO - PROCESS | 1634 | 01:56:43 INFO - PROCESS | 1634 | [#4] prototype.html Cycles:180 Average:4313.61 Median:4707.11 stddev:1197.52 (25.4%) stddev-sans-first:1163.28 01:56:43 INFO - PROCESS | 1634 | Values: 346.9 376.8 384.4 385.5 389.8 4078.3 4187.6 4815.5 4892.3 4904.9 4335.1 4691.8 4697.4 4962.0 4991.1 3409.9 3477.4 3727.0 3796.8 3823.0 3226.3 3671.4 3965.6 4019.0 4163.7 3702.4 3705.6 4035.6 4108.9 4160.8 3871.9 4014.0 4139.7 4171.4 4209.9 3516.6 3688.2 3763.9 3771.3 3779.7 4785.0 4848.9 4882.4 4891.3 5017.4 4147.9 4196.3 4557.0 4852.5 4863.8 4758.9 4901.8 5046.2 5318.5 5424.7 3673.2 3725.9 4200.0 4236.2 4252.8 4873.5 4874.9 5052.4 5390.6 5566.4 3638.8 3821.8 4028.8 4089.9 4113.9 3699.7 3821.9 3923.8 4307.1 4336.7 4253.9 4499.2 4604.8 4730.2 4769.4 4576.6 5083.8 5227.5 5250.2 5353.8 1439.0 1490.4 1501.0 1514.0 1517.0 989.8 1075.1 1110.4 1132.3 1135.8 4297.3 4418.7 4435.4 4908.8 4963.4 4716.8 5029.4 5409.6 5461.7 5554.6 4296.5 4566.4 4802.9 5044.3 5088.9 2645.3 2745.2 2796.9 2843.6 2874.8 4756.9 4897.5 5162.0 5606.3 5671.8 4653.5 4845.7 5190.9 5372.9 5378.4 5277.6 5406.2 5421.0 5559.8 5584.9 4230.8 5030.6 5093.4 5176.6 5215.8 5157.4 5199.3 5331.4 5397.4 5416.9 5229.1 5402.1 5438.3 5487.3 5488.6 3962.0 4234.8 4249.3 4263.7 4265.9 4844.5 4854.9 4985.2 5173.2 5227.8 4146.0 4835.3 4884.5 5273.8 5387.4 4499.3 5206.5 5223.2 5233.8 5263.0 4481.8 4541.7 4859.4 5097.3 5228.8 4457.8 4989.6 5041.2 5226.6 5316.0 4346.5 4459.9 4496.7 5074.4 5102.4 01:56:43 INFO - PROCESS | 1634 | 01:56:43 INFO - PROCESS | 1634 | [#5] yui.html Cycles:180 Average:19410.30 Median:3731.25 stddev:27235.24 (729.9%) stddev-sans-first:27275.56 01:56:43 INFO - PROCESS | 1634 | Values: 739.3 762.3 774.4 832.3 848.6 12956.7 14159.4 14722.9 14970.7 15286.5 14455.7 14559.3 14623.6 15004.4 15482.4 943.6 966.2 966.8 968.5 973.3 927.7 940.3 948.9 966.6 973.2 1004.5 1005.0 1008.3 1009.6 1010.9 991.7 992.9 992.9 994.1 995.4 740.6 743.3 743.5 743.8 744.3 15207.6 15496.5 15544.0 16124.5 16435.2 13973.2 14021.9 14125.2 14128.0 14131.7 10107.5 11706.6 11777.5 11899.4 12078.7 3574.4 3697.1 3765.4 3846.2 3859.1 94274.2 105873.0 106550.5 112243.0 112635.4 10343.2 10414.7 10561.2 10790.2 10928.0 23021.4 23229.3 23258.2 23269.7 23272.8 7676.0 7726.9 7729.0 7730.3 7840.7 4254.5 4284.7 4363.0 4417.8 4441.0 3435.8 3537.1 3537.4 3538.9 3544.8 511.4 616.1 624.5 624.5 624.9 662.5 667.6 689.4 692.3 694.9 9058.1 9609.0 9829.9 9831.9 9958.0 541.3 544.0 570.6 571.6 620.7 4508.5 4767.0 4796.6 4849.8 4953.2 89281.0 90382.0 91948.0 93697.5 99205.5 51073.7 76329.0 89850.6 92368.0 97768.0 61415.4 61883.0 67239.0 68511.0 74173.0 10204.8 10542.3 10739.9 10779.1 10909.1 41223.0 42460.8 44512.1 47641.5 48327.0 56688.2 56891.1 57156.7 62162.7 63702.7 13092.8 13457.3 13613.3 13896.4 14446.9 14346.9 14704.3 14930.5 15001.5 15153.6 12887.7 13033.5 13473.5 13543.2 13722.5 11941.5 13331.4 14365.0 14560.5 14580.8 12918.5 12982.9 13045.9 13189.1 13198.0 11127.4 11325.2 11407.7 11413.9 11957.9 10899.3 10931.8 11050.3 11055.9 11085.5 01:56:43 INFO - PROCESS | 1634 | -------- Summary: end -------- 01:56:43 INFO - PROCESS | 1634 | 01:56:43 INFO - TEST-INFO | 1634: exit 0 01:56:43 INFO - TEST-OK | dromaeo_css | took 1121027ms 01:56:43 INFO - TEST-START | kraken 01:56:43 INFO - operating with platform_type : mac_ 01:56:43 INFO - Initialising browser for kraken test... 01:56:43 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/tmpHi91Ss/profile http://localhost:49241/getInfo.html) 01:56:46 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 01:56:46 INFO - PROCESS | 1644 | colorDepth:24 01:56:46 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 01:56:46 INFO - PROCESS | 1644 | __metrics 01:56:46 INFO - PROCESS | 1644 | 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" 01:56:46 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:56:46 INFO - TEST-INFO | 1644: exit 0 01:56:46 INFO - Browser initialized. 01:56:46 INFO - Running cycle 1/1 for kraken test... 01:56:46 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/tmpHi91Ss/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:56:59 INFO - PROCESS | 1646 | RSS: Main: 215666688 01:56:59 INFO - PROCESS | 1646 | 01:57:01 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 01:57:02 INFO - PROCESS | 1646 | RSS: Main: 267382784 01:57:02 INFO - PROCESS | 1646 | 01:57:05 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 01:57:06 INFO - PROCESS | 1646 | RSS: Main: 278773760 01:57:06 INFO - PROCESS | 1646 | 01:57:09 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 01:57:09 INFO - PROCESS | 1646 | RSS: Main: 375549952 01:57:09 INFO - PROCESS | 1646 | 01:57:11 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 01:57:12 INFO - PROCESS | 1646 | RSS: Main: 278196224 01:57:12 INFO - PROCESS | 1646 | 01:57:14 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:57:15 INFO - PROCESS | 1646 | RSS: Main: 280731648 01:57:15 INFO - PROCESS | 1646 | 01:57:18 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 01:57:18 INFO - PROCESS | 1646 | RSS: Main: 321638400 01:57:18 INFO - PROCESS | 1646 | 01:57:22 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 01:57:22 INFO - PROCESS | 1646 | RSS: Main: 322752512 01:57:22 INFO - PROCESS | 1646 | 01:57:25 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 01:57:26 INFO - PROCESS | 1646 | RSS: Main: 320155648 01:57:26 INFO - PROCESS | 1646 | 01:57:27 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:57:28 INFO - PROCESS | 1646 | RSS: Main: 295870464 01:57:28 INFO - PROCESS | 1646 | 01:57:30 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:57:31 INFO - PROCESS | 1646 | RSS: Main: 302301184 01:57:31 INFO - PROCESS | 1646 | 01:57:33 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:57:33 INFO - PROCESS | 1646 | RSS: Main: 307335168 01:57:33 INFO - PROCESS | 1646 | 01:57:36 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:57:37 INFO - PROCESS | 1646 | RSS: Main: 320532480 01:57:37 INFO - PROCESS | 1646 | 01:57:40 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:57:40 INFO - PROCESS | 1646 | RSS: Main: 314322944 01:57:40 INFO - PROCESS | 1646 | 01:57:42 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 01:57:42 INFO - PROCESS | 1646 | RSS: Main: 359178240 01:57:42 INFO - PROCESS | 1646 | 01:57:42 INFO - PROCESS | 1646 | __start_tp_report 01:57:42 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 01:57:42 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 01:57:42 INFO - PROCESS | 1646 | |i|pagename|runs| 01:57:42 INFO - PROCESS | 1646 | |0;ai-astar;117;115;116;117;115;116;116;117;115;118 01:57:42 INFO - PROCESS | 1646 | |1;audio-beat-detection;132;111;106;133;111;106;106;110;125;109 01:57:42 INFO - PROCESS | 1646 | |2;audio-dft;182;184;186;184;184;185;182;184;183;184 01:57:42 INFO - PROCESS | 1646 | |3;audio-fft;81;58;60;90;61;61;61;58;86;79 01:57:42 INFO - PROCESS | 1646 | |4;audio-oscillator;88;97;111;68;69;69;107;88;68;84 01:57:42 INFO - PROCESS | 1646 | |5;imaging-gaussian-blur;86;86;87;86;86;91;134;89;92;86 01:57:42 INFO - PROCESS | 1646 | |6;imaging-darkroom;94;94;93;94;93;94;94;94;93;93 01:57:42 INFO - PROCESS | 1646 | |7;imaging-desaturate;86;83;83;84;83;82;82;84;86;83 01:57:42 INFO - PROCESS | 1646 | |8;json-parse-financial;63;64;62;63;65;65;64;64;63;62 01:57:42 INFO - PROCESS | 1646 | |9;json-stringify-tinderbox;55;66;66;63;60;59;57;59;59;59 01:57:42 INFO - PROCESS | 1646 | |10;stanford-crypto-aes;83;82;85;86;86;85;81;83;86;88 01:57:42 INFO - PROCESS | 1646 | |11;stanford-crypto-ccm;137;133;138;136;136;136;146;141;185;138 01:57:42 INFO - PROCESS | 1646 | |12;stanford-crypto-pbkdf2;166;163;164;159;161;165;164;159;161;162 01:57:42 INFO - PROCESS | 1646 | |13;stanford-crypto-sha256-iterative;65;65;65;65;64;63;64;65;64;62 01:57:42 INFO - PROCESS | 1646 | __end_tp_report 01:57:42 INFO - PROCESS | 1646 | __start_cc_report 01:57:42 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,2135 01:57:42 INFO - PROCESS | 1646 | __end_cc_report 01:57:42 INFO - PROCESS | 1646 | __startTimestamp1489053462848__endTimestamp 01:57:42 INFO - PROCESS | 1646 | 01:57:42 INFO - PROCESS | 1646 | ------- Summary: start ------- 01:57:42 INFO - PROCESS | 1646 | Number of tests: 14 01:57:42 INFO - PROCESS | 1646 | 01:57:42 INFO - PROCESS | 1646 | [#0] ai-astar Cycles:10 Average:116.20 Median:116.50 stddev:1.03 (0.9%) stddev-sans-first:1.05 01:57:42 INFO - PROCESS | 1646 | Values: 117.0 115.0 116.0 117.0 115.0 116.0 116.0 117.0 115.0 118.0 01:57:42 INFO - PROCESS | 1646 | 01:57:42 INFO - PROCESS | 1646 | [#1] audio-beat-detection Cycles:10 Average:114.90 Median:111.00 stddev:10.80 (9.7%) stddev-sans-first:9.51 01:57:42 INFO - PROCESS | 1646 | Values: 132.0 111.0 106.0 133.0 111.0 106.0 106.0 110.0 125.0 109.0 01:57:42 INFO - PROCESS | 1646 | 01:57:42 INFO - PROCESS | 1646 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.23 (0.7%) stddev-sans-first:1.12 01:57:42 INFO - PROCESS | 1646 | Values: 182.0 184.0 186.0 184.0 184.0 185.0 182.0 184.0 183.0 184.0 01:57:42 INFO - PROCESS | 1646 | 01:57:42 INFO - PROCESS | 1646 | [#3] audio-fft Cycles:10 Average:69.50 Median:70.00 stddev:12.85 (18.4%) stddev-sans-first:12.94 01:57:42 INFO - PROCESS | 1646 | Values: 81.0 58.0 60.0 90.0 61.0 61.0 61.0 58.0 86.0 79.0 01:57:42 INFO - PROCESS | 1646 | 01:57:42 INFO - PROCESS | 1646 | [#4] audio-oscillator Cycles:10 Average:84.90 Median:76.50 stddev:16.37 (21.4%) stddev-sans-first:17.33 01:57:42 INFO - PROCESS | 1646 | Values: 88.0 97.0 111.0 68.0 69.0 69.0 107.0 88.0 68.0 84.0 01:57:42 INFO - PROCESS | 1646 | 01:57:42 INFO - PROCESS | 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:92.30 Median:86.50 stddev:14.83 (17.1%) stddev-sans-first:15.55 01:57:42 INFO - PROCESS | 1646 | Values: 86.0 86.0 87.0 86.0 86.0 91.0 134.0 89.0 92.0 86.0 01:57:42 INFO - PROCESS | 1646 | 01:57:42 INFO - PROCESS | 1646 | [#6] imaging-darkroom Cycles:10 Average:93.60 Median:94.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 01:57:42 INFO - PROCESS | 1646 | Values: 94.0 94.0 93.0 94.0 93.0 94.0 94.0 94.0 93.0 93.0 01:57:42 INFO - PROCESS | 1646 | 01:57:42 INFO - PROCESS | 1646 | [#7] imaging-desaturate Cycles:10 Average:83.60 Median:83.50 stddev:1.43 (1.7%) stddev-sans-first:1.22 01:57:42 INFO - PROCESS | 1646 | Values: 86.0 83.0 83.0 84.0 83.0 82.0 82.0 84.0 86.0 83.0 01:57:42 INFO - PROCESS | 1646 | 01:57:42 INFO - PROCESS | 1646 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:64.00 stddev:1.08 (1.7%) stddev-sans-first:1.13 01:57:42 INFO - PROCESS | 1646 | Values: 63.0 64.0 62.0 63.0 65.0 65.0 64.0 64.0 63.0 62.0 01:57:42 INFO - PROCESS | 1646 | 01:57:42 INFO - PROCESS | 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:59.50 stddev:3.62 (6.1%) stddev-sans-first:3.30 01:57:42 INFO - PROCESS | 1646 | Values: 55.0 66.0 66.0 63.0 60.0 59.0 57.0 59.0 59.0 59.0 01:57:42 INFO - PROCESS | 1646 | 01:57:42 INFO - PROCESS | 1646 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:85.50 stddev:2.17 (2.5%) stddev-sans-first:2.24 01:57:42 INFO - PROCESS | 1646 | Values: 83.0 82.0 85.0 86.0 86.0 85.0 81.0 83.0 86.0 88.0 01:57:42 INFO - PROCESS | 1646 | 01:57:42 INFO - PROCESS | 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:142.60 Median:138.00 stddev:15.31 (11.1%) stddev-sans-first:16.10 01:57:42 INFO - PROCESS | 1646 | Values: 137.0 133.0 138.0 136.0 136.0 136.0 146.0 141.0 185.0 138.0 01:57:42 INFO - PROCESS | 1646 | 01:57:42 INFO - PROCESS | 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:163.50 stddev:2.41 (1.5%) stddev-sans-first:2.18 01:57:42 INFO - PROCESS | 1646 | Values: 166.0 163.0 164.0 159.0 161.0 165.0 164.0 159.0 161.0 162.0 01:57:42 INFO - PROCESS | 1646 | 01:57:42 INFO - PROCESS | 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:65.00 stddev:1.03 (1.6%) stddev-sans-first:1.05 01:57:42 INFO - PROCESS | 1646 | Values: 65.0 65.0 65.0 65.0 64.0 63.0 64.0 65.0 64.0 62.0 01:57:42 INFO - PROCESS | 1646 | -------- Summary: end -------- 01:57:42 INFO - PROCESS | 1646 | 01:57:43 INFO - TEST-INFO | 1646: exit 0 01:57:43 INFO - TEST-OK | kraken | took 60168ms 01:57:43 INFO - SUITE-END | took 1181s 01:57:44 INFO - Completed test suite (00:19:41) 01:57:44 INFO - javascript benchmark 01:57:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7547.881570720098, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3317.6018877734673, 3338.449155889277, 3384.0, 3430.228198655303, 3431.330890476358, 5862.06207006879, 5887.175795388649, 5895.734691938862, 5911.5861889667685, 5914.763409463627, 5841.620294680843, 5920.289565252176, 5928.525717942565, 5931.792387266447, 5955.731992060357, 5282.154855223174, 5309.761060752276, 5349.411564727877, 5432.728363581825, 5444.700541470217, 5243.947560524384, 5246.475352464742, 5261.1319132343115, 5321.388040375348, 5433.483819037205, 5387.865303367408, 5415.0523658359825, 5420.214068960018, 5430.131179011359, 5431.864203394927, 4536.72779633223, 5405.135178371442, 5419.83740487786, 5441.782328706847, 5448.618596698233, 5164.32863727713, 5207.244949482304, 5268.5521730652945, 5352.91970620441, 5371.060064488699, 5756.712164391805, 5778.797742079049, 5784.595078344518, 5788.82633520995, 5817.941820581825, 6231.532635052344, 6291.779787707408, 6297.33877942814, 6313.873722525524, 6325.304216536178, 6263.24841019076, 6297.716602752887, 6325.367463253684, 6333.0, 6358.80923572289, 6048.1834952281315, 6051.636901785819, 6054.273487181566, 6057.969710151465, 6058.273007239115, 6379.96810015947, 6416.230052393649, 6421.903671444932, 6424.582402143939, 6450.322716114741, 6124.5100391968535, 6132.397922269778, 6135.232666670055, 6137.959273351923, 6357.745690172434, 5273.841784746463, 6285.340039295899, 6312.0531920211415, 6316.810495685137, 6332.715027823759, 5568.638038527563, 5817.418258174233, 5998.790042348497, 6208.9689551551955, 6373.139626150503, 6293.30773614902, 6355.046742988497, 6355.618662880242, 6364.681765911686, 6372.745090196433, 5060.468650791614, 5068.189089745623, 5072.391313042384, 5103.923441148386, 5105.693658380509, 4443.111377724404, 4488.281874900001, 4522.412086428809, 4561.68068235227, 4609.331646911246, 5677.80127695537, 5790.392008839095, 5802.129680547867, 5812.9536683396545, 5818.8254352369495, 6332.145160403379, 6338.112664227012, 6349.841253968688, 6350.142730731384, 6365.172527571386, 5864.941350586525, 5877.059670452707, 5935.228420305419, 5944.0, 5950.315713692894, 5542.75057622408, 5552.694601796859, 5567.49892509668, 5588.0, 5593.972030139823, 5433.945660543423, 6450.580712253689, 6454.19322584677, 6459.483241340681, 6460.160179176677, 5340.599455040965, 6285.025820997753, 6335.176427064452, 6345.238571371465, 6402.87194256103, 5257.263983042453, 6319.968400158154, 6335.429811317003, 6348.841278967878, 6349.396807303298, 6305.8108256752375, 6311.2426508819235, 6363.968180159255, 6375.0, 6391.520635952229, 6269.467095296951, 6290.559660823698, 6303.243610766737, 6346.841328966812, 6352.110704501281, 6131.662758548323, 6344.619322840645, 6345.904811427925, 6353.491720662429, 6358.713857876314, 6202.751889924352, 6292.370762923671, 6301.968490157703, 6305.621662700252, 6320.810375688737, 5912.054071348563, 6000.159977603052, 6056.3035250946705, 6069.241344831896, 6107.206063211754, 6219.782307619212, 6342.0, 6349.523785715997, 6358.268799088164, 6372.713227904848, 6134.6625935573975, 6137.41694539018, 6140.140380346845, 6148.231471066117, 6157.4458298753325], "value": 5800.80857388406, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.64072206424, 798.2855344466701, 820.7948012996749, 876.7720392697901, 893.3300024981264, 28093.719062809392, 28413.005544805936, 29185.978490752826, 29220.831166753356, 29289.853550732216, 36409.45385819215, 41976.0, 43970.560294397044, 44044.55955440445, 44104.0, 9093.95453022734, 9222.861657075116, 9240.122188392092, 9241.0, 9244.8613270801, 7280.308370704801, 9130.04134565871, 9235.769105772342, 9236.445813251226, 9260.212881905012, 7449.9627501862415, 10838.72903177419, 11086.113110951144, 11102.0, 11109.500072496716, 11049.337039777598, 11090.889091109066, 11093.0, 11114.499847506882, 11163.274387164849, 7197.532160409609, 10833.620823271227, 10902.073323767489, 10902.400367979759, 10909.0, 27881.302967425774, 28062.719372806216, 28076.57885131725, 28111.29721756952, 38420.80789596062, 3877.263319969197, 3920.941185882214, 3928.175083232496, 3945.1123497213184, 3948.269570129535, 27088.1873543794, 27093.593596095878, 27107.1867843965, 27120.59319110215, 28170.43659126806, 3034.908952731422, 3061.311204978862, 3188.85650145744, 3274.8690052397874, 3288.2765791525826, 340600.0, 341236.0, 341834.0, 342118.0, 342845.0, 52081.0, 52282.69293267699, 52441.16455924024, 52476.0, 52476.47523524792, 54819.725901370235, 54901.725491372286, 54949.725251374286, 55007.72496137574, 55010.0, 14749.188794616399, 14908.0, 14915.030523015968, 14916.0, 14956.326965286587, 12790.232586044867, 12791.552295669608, 12805.615831525069, 12811.359432028361, 12826.61520154397, 10390.792184156275, 10911.890881091087, 11205.215634905479, 12584.874151258553, 12687.936560317139, 4886.098726035531, 6021.909671354933, 6165.32181460039, 6185.536084793658, 6203.8138855833495, 954.8663187153666, 956.6412595276771, 956.7512446763892, 988.0712130597216, 990.2276224544867, 27393.726062739515, 28329.0, 29237.415251694845, 29534.704652953624, 29584.852075739484, 977.8510250455686, 994.6319861651091, 1045.7385653586603, 1068.0, 1078.8543546621263, 14668.339924703414, 15001.024933379296, 15094.283267955663, 15132.243387830784, 15268.389264429521, 360048.0, 428300.0, 429034.0, 429851.0, 430056.0, 48472.27291590629, 54602.0, 56715.298541043834, 56851.0, 57216.71391643015, 1414.1727089652463, 1454.6654269517858, 1454.985450145485, 1462.5246794791735, 1469.0304399096544, 26310.21069367922, 27225.910963561237, 27708.450514935495, 27827.44345113127, 28004.019859304826, 42234.57765422307, 42474.0, 42476.93807654834, 42524.36213456739, 42531.7873410631, 422700.0, 422831.0, 423440.0, 424399.0, 424698.0, 32478.35043299168, 33028.66971330256, 33044.66955330416, 33111.83444082764, 33116.337673245915, 43750.34374484449, 44097.338539921286, 44167.55832441634, 44367.89080273019, 44634.55365446304, 32205.033848984567, 33560.0, 35768.82115589405, 35859.462108068925, 37168.6283137176, 32047.038588842373, 33191.66808331886, 35572.93281201568, 36716.26567468689, 36729.714459993775, 35436.645633544365, 35800.64199357973, 35804.64195358013, 36453.45319820152, 36610.45084323684, 31034.53448198324, 32410.35179296448, 32443.0, 32486.0, 32578.185545361557, 23918.043278268673, 23927.0, 24182.032718691054, 24362.634560481252, 24548.772561372218], "value": 18529.194263088928, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.16363999201764, 424.5413522357588, 428.89920868595885, 435.18185810675925, 450.80390030336804, 15959.760603590956, 20423.072892495173, 21691.67462488064, 21870.562588748217, 21887.562248755035, 21175.470613234676, 21757.456063598416, 22031.889840550815, 22413.21553745619, 22701.20545780898, 6285.465735412496, 6351.904721429194, 6408.295087540367, 6538.0, 6555.6394398308075, 4028.053407449247, 6317.873642527146, 6449.6130232186215, 6467.0, 6476.579022363531, 4206.684498662613, 4246.384274280227, 4274.187904298189, 4345.69580129391, 7345.19202887682, 7343.7062517499235, 7397.70409183632, 7415.221401752792, 7421.035265415516, 7431.591262480534, 6909.619970901598, 7221.386182174521, 7234.348908598251, 7248.238934911864, 7270.382017528516, 25760.09839655603, 25998.6100208497, 26542.6018609721, 26852.0, 27150.32124196891, 2881.654201495834, 2883.207118042534, 2911.1333049866976, 2930.4432157890146, 2964.8962286319875, 15153.318100685496, 15407.3837046518, 15419.768703469457, 15458.5362439127, 16088.356465741357, 2013.748281464817, 2042.2647846775149, 2053.8151566359097, 2057.2182570623067, 2063.473814177375, 136840.31579842136, 142434.0, 162385.0, 163755.25548795477, 173874.0, 12329.314860353008, 19210.0, 20474.897625511778, 20589.38231853047, 20614.969251537364, 27886.442271154465, 27939.301517462227, 30390.84804575963, 31672.366552668816, 32585.674143258264, 8915.73252802417, 9936.453495057696, 10270.486475676187, 10482.0, 10617.0, 8427.452215605967, 8649.610767515476, 8674.089220631742, 8833.205011548991, 8847.42491738035, 7312.976183334337, 7481.7755467336065, 9287.90712092884, 9437.575309111107, 9500.714978550655, 3235.482322828383, 3796.5383327419145, 3831.50190475242, 3835.520559930009, 3842.3852183650483, 872.9214370706667, 1030.953607087683, 1047.1361127070197, 1048.984265236022, 1070.983935240972, 19151.712724309145, 21109.0, 21148.47128821792, 21168.047437865334, 21428.89285553562, 1058.2327812336148, 1069.946502674863, 1092.5356723392526, 1108.2796182481452, 1109.944502774858, 9327.041321322462, 10263.127634151031, 11089.667309980714, 11121.27711698737, 11126.388048657402, 577577.0, 674229.0, 794688.0, 805568.0, 807185.0, 142203.0, 152751.0, 152873.2356338211, 154995.0, 158125.62811557835, 1250.8936740376987, 1267.6830792301926, 1314.309987256698, 1324.576135636587, 1325.430065072009, 14900.627484312545, 18056.72914906251, 19493.8050619492, 19520.90239548793, 19531.24218820313, 39794.594855227726, 57860.71069644625, 58289.4171058284, 61908.0, 62462.68768656128, 83413.0, 84218.57890710507, 86257.0, 86295.1370486287, 86788.99995027002, 11190.104791616814, 11231.55073797039, 11235.325880447199, 11472.94263528677, 11570.074394048288, 12253.816192756938, 12647.430865610886, 12741.745165096461, 12771.425285862344, 12813.167144135601, 10736.677899663022, 10871.130309575374, 10891.292066015683, 10893.237473377105, 11115.944420277847, 8455.830883382421, 10507.0, 10620.628278010232, 10697.78361664593, 10958.397288149228, 10095.242856785917, 10786.191035672198, 11121.221514494231, 11236.438178091226, 11324.716882077684, 10974.615888443866, 11014.339139651325, 11153.330800152016, 11154.0, 11507.884921150682, 10652.520636571218, 10720.839187412352, 10845.295055821347, 11029.117670586173, 11095.0], "value": 11268.160541103152, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1515.9621009474754, 1537.3235776258446, 1563.7341651919173, 1569.3330334607788, 1572.3867691600276, 10600.628977985762, 11168.0, 11178.0, 11182.16133789965, 11182.16133789965, 10740.73148171296, 11206.327620342785, 11306.0, 11321.773564528705, 11330.603428879991, 2395.2694428199393, 2407.6749638798715, 2422.818288628351, 2424.1273141668985, 2429.331933718233, 2372.027468737818, 2401.03958416633, 2410.6986626671664, 2418.9274321770376, 2419.2379400488876, 2373.632087026505, 2390.605550084234, 2396.436837343223, 2403.1348714462865, 2404.1345115758313, 2341.4731685370825, 2360.055977608953, 2366.8698221597806, 2370.4073981504625, 2371.205646108556, 2321.3964369263945, 2329.173143534038, 2384.9165279215144, 2388.1283331583845, 2393.1743548475747, 11056.060234880046, 11176.832347514794, 11197.440127993568, 11197.496112674868, 11205.775884482346, 5747.453991870766, 5924.763009479616, 5926.229590153295, 5927.881442371128, 5952.880942381128, 3556.0931962349696, 3581.0, 3655.6161603031833, 3669.633036696309, 3695.4826324314618, 1172.3317708905927, 1172.4548085140366, 1231.907606929475, 1234.3766397969057, 1242.6582689760298, 13742.03805733599, 14009.789853152211, 14346.49787257441, 15366.154861482613, 15586.688266234612, 4027.416024676464, 4212.410262563244, 4325.7404555726125, 4329.718568293051, 4357.237483440385, 11635.360055197045, 11784.234024788362, 11821.113416493798, 11824.940875295568, 11842.940785296018, 5836.824895253149, 5840.182374467578, 5851.268591426072, 5863.794767183128, 5882.882342353129, 4395.494518130456, 5065.518775716301, 5221.765020574083, 5300.575953923677, 5355.116405793078, 3397.8810741623925, 3801.315763162602, 3818.7326887118193, 3895.5325360956867, 3930.21395720857, 1059.2320567588438, 1059.7456610413444, 1065.5844220753913, 1076.9192310576582, 1080.4327727942737, 910.7814124610178, 929.5445231836487, 934.56075644447, 944.7071407863584, 980.7450062983676, 6528.0, 6536.869262614721, 6571.737130514726, 6682.866342673119, 6804.76183333581, 992.5607769080171, 994.3039872089422, 1004.1314263162312, 1024.882138554061, 1031.9484025798681, 4077.2660921033907, 4096.446979657768, 4153.335466325373, 4168.958310416918, 4260.978695106504, 13470.326483675777, 13958.092723973112, 13958.860411395755, 13995.720085598232, 14001.089929154572, 12784.6803829905, 13869.306534673226, 13885.722285554233, 13887.930560347133, 13891.235982020884, 8584.442011269248, 9929.751756206153, 10226.335288206243, 10236.385816851012, 10242.283040187265, 5665.3201615806365, 6342.746290148342, 6839.213490448463, 6942.271061538466, 6987.624207769383, 11604.593839215588, 12016.137498687718, 12028.338441385458, 12032.578859740217, 12054.75890482168, 12091.39543022863, 12399.380030998234, 12413.75172496563, 12573.93713031429, 12623.87376126227, 9166.266698664223, 9222.492762897837, 9346.813063738824, 9392.67125650599, 9400.0, 10110.292279540361, 10308.32995855267, 10309.639162629272, 10320.741981450525, 10323.63867264642, 8893.199612034949, 8948.418352807046, 8999.865002024844, 9193.586288616894, 9297.58262851677, 7655.349295309961, 8912.197902188835, 8973.28213742912, 8995.0, 9034.2320902724, 7521.661525231269, 7830.647620857189, 7951.721689740832, 7966.0, 7967.56178410193, 5448.128299472065, 5461.836144915659, 5626.606137570495, 5658.321001479684, 5668.574856885668, 4713.929291060568, 5844.736986835517, 6042.516598672184, 6074.848128796815, 6150.7847225346895], "value": 5119.800150737982, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.9210754553339, 376.8304263081614, 384.44255829047887, 385.4738282244736, 389.75250715795477, 4078.306687863063, 4187.560306167854, 4815.542523460274, 4892.3150758893735, 4904.87737806555, 4335.1142253119915, 4691.818304488413, 4697.389339385883, 4962.0, 4991.051700176964, 3409.919948831217, 3477.426224672926, 3726.9813650931706, 3796.791176485292, 3823.0, 3226.2579606690474, 3671.3942199537178, 3965.6430921217084, 4018.97990510047, 4163.68772342074, 3702.426123950792, 3705.610910854362, 4035.616616421435, 4108.85619003335, 4160.812763425638, 3871.8831340770666, 4014.0, 4139.730917490384, 4171.436856024428, 4209.85265515707, 3516.5604299462566, 3688.1517251032415, 3763.8682646107527, 3771.3211621908044, 3779.714896935028, 4784.976075119637, 4848.945164546313, 4882.41411030675, 4891.315215869781, 5017.422996355429, 4147.875563733093, 4196.265653510654, 4557.0, 4852.514748525155, 4863.756812159378, 4758.881027974294, 4901.803927842882, 5046.23381816365, 5318.510816971254, 5424.721616920902, 3673.1918977824835, 3725.913488446479, 4199.958000419987, 4236.216299984482, 4252.829886804524, 4873.512648735134, 4874.878128046792, 5052.368453943221, 5390.625390525469, 5566.443355664442, 3638.8362523686496, 3821.8280177392085, 4028.798560071985, 4089.8548406446243, 4113.8971525711495, 3699.72252081095, 3821.8662346817728, 3923.8234279457492, 4307.104873855494, 4336.674749393808, 4253.894322310476, 4499.245294335212, 4604.815807367668, 4730.172219861579, 4769.379980602499, 4576.58810707038, 5083.847484575469, 5227.477252274742, 5250.238715386247, 5353.7590808413715, 1439.0142752214767, 1490.3963894622696, 1500.9699806003819, 1513.9772903406458, 1516.9533022214637, 989.8366769482955, 1075.0861767497565, 1110.3670907582762, 1132.2810015639964, 1135.7728454309172, 4297.261382597098, 4418.690691651554, 4435.401220835146, 4908.754562271872, 4963.429205641325, 4716.8207948013, 5029.44834924394, 5409.56723462122, 5461.672299662033, 5554.583406244547, 4296.474751463248, 4566.383538222364, 4802.903941921212, 5044.344235249394, 5088.898222035538, 2645.3386653336665, 2745.1764470659123, 2796.944061118766, 2843.6161118249183, 2874.841883696375, 4756.9286460703115, 4897.534734200317, 5161.9676064786445, 5606.271184746039, 5671.8163507050085, 4653.484622334905, 4845.667441453628, 5190.935858149071, 5372.946270537323, 5378.408375078739, 5277.569579773101, 5406.189071639285, 5421.0, 5559.805406810742, 5584.93886161628, 4230.7884605770205, 5030.566288607729, 5093.439721630543, 5176.602317374212, 5215.783292100918, 5157.355330583677, 5199.272101905812, 5331.4401987790725, 5397.379301380392, 5416.864578385572, 5229.137192363218, 5402.108652072521, 5438.347398312069, 5487.341519017584, 5488.615796894339, 3961.9603803962746, 4234.7670878102, 4249.3413520904305, 4263.7189103829305, 4265.936010959776, 4844.46710861812, 4854.878628034327, 4985.227289770091, 5173.1722924331925, 5227.843164705065, 4146.035584557057, 4835.347228124158, 4884.511548845087, 5273.837726532103, 5387.434319396563, 4499.302608095751, 5206.5314121729225, 5223.224103804725, 5233.816816411408, 5262.97368513155, 4481.843135490242, 4541.704789188824, 4859.3682821233015, 5097.286379906742, 5228.790848366175, 4457.7771111444945, 4989.600831933364, 5041.2438134280155, 5226.608004399762, 5316.0, 4346.456692913386, 4459.888502787457, 4496.662750293675, 5074.441811400817, 5102.36220472441], "value": 3973.001318465544, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.3382922284552, 762.2529920677736, 774.4462709162948, 832.3258160889679, 848.5841937450651, 12956.676083097927, 14159.362828672709, 14722.926385368059, 14970.700585988274, 15286.54140375789, 14455.710885782279, 14559.344829482672, 14623.561293161196, 15004.399824007027, 15482.380704771796, 943.5942544705791, 966.246327864267, 966.8259713251612, 968.5205823117567, 973.2943615878502, 927.7031349967979, 940.2665920581957, 948.8624149498319, 966.6423423333376, 973.2360097323602, 1004.5228516454698, 1004.9598016079348, 1008.349614498648, 1009.5557954500033, 1010.9342892711987, 991.7124034030122, 992.8709267795176, 992.8808542974817, 994.125169850527, 995.4276291132592, 740.5778706137504, 743.2567432567432, 743.4795643049887, 743.7805847275067, 744.326384621918, 15207.61980950474, 15496.457623983219, 15543.98964067332, 16124.516264512084, 16435.1782410879, 13973.23147226902, 14021.929890350482, 14125.152490850582, 14128.0, 14131.71736565263, 10107.545160467796, 11706.648800535997, 11777.470013849397, 11899.405029748477, 12078.69803254917, 3574.3566158091535, 3697.0572504011575, 3765.435184722286, 3846.173072789336, 3859.073822282632, 94274.17177484618, 105873.0, 106550.46724766404, 112243.0, 112635.43682281618, 10343.224258180517, 10414.687559373231, 10561.207909406825, 10790.190735694854, 10928.0, 23021.42446438819, 23229.3031209064, 23258.185963491196, 23269.650955235684, 23272.76727232706, 7676.0, 7726.9227307726205, 7729.0, 7730.342920851791, 7840.686372545034, 4254.532001479834, 4284.736002879095, 4363.040131171138, 4417.801198946056, 4440.977795111004, 3435.793852368866, 3537.0980399997834, 3537.4340105582983, 3538.9469157962653, 3544.7518673692593, 511.36834664839625, 616.1312549305458, 624.4536030972898, 624.519120277393, 624.9312575616678, 662.5097427903316, 667.6127845849493, 689.3761146162731, 692.2523674431602, 694.8992396102536, 9058.109849860903, 9608.951955240318, 9829.852552211723, 9831.935293588283, 9958.0, 541.265294207867, 543.9918401223985, 570.5777724483935, 571.5741772379604, 620.6524346365959, 4508.526604706459, 4766.95233047672, 4796.616270698336, 4849.830255941025, 4953.157963146274, 89281.0, 90382.0, 91948.0, 93697.531512342, 99205.50397247968, 51073.744631277346, 76329.0, 89850.55074724584, 92368.0, 97768.04463910683, 61415.38584614186, 61883.0, 67239.0, 68510.97233541402, 74173.0, 10204.795904082026, 10542.314749541256, 10739.946300268448, 10779.13766898662, 10909.127269818237, 41223.0, 42460.78769606132, 44512.10975780531, 47641.5235847651, 48327.0, 56688.16559171942, 56891.14663279971, 57156.71421642865, 62162.68918655378, 63702.68148659227, 13092.80360794608, 13457.259850708306, 13613.251271180181, 13896.374663140385, 14446.927765361106, 14346.928265358607, 14704.338304776096, 14930.477433289783, 15001.47494837719, 15153.621159471102, 12887.742245155232, 13033.47866085346, 13473.528426505418, 13543.187408755506, 13722.519711810039, 11941.462634181657, 13331.400086995915, 14365.0, 14560.49038283655, 14580.781288280472, 12918.547850825553, 12982.903701066703, 13045.869541304844, 13189.076764626385, 13198.010149239037, 11127.387993660426, 11325.207235493766, 11407.714807129889, 11413.885861141282, 11957.940210298893, 10899.346039237671, 10931.83602245951, 11050.33697978124, 11055.889441105808, 11085.50115244832], "value": 7504.763998187878, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1416.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 116.0, 117.0, 115.0, 116.0, 116.0, 117.0, 115.0, 118.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 111.0, 106.0, 133.0, 111.0, 106.0, 106.0, 110.0, 125.0, 109.0], "value": 114.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 186.0, 184.0, 184.0, 185.0, 182.0, 184.0, 183.0, 184.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 60.0, 90.0, 61.0, 61.0, 61.0, 58.0, 86.0, 79.0], "value": 69.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 97.0, 111.0, 68.0, 69.0, 69.0, 107.0, 88.0, 68.0, 84.0], "value": 84.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 86.0, 86.0, 91.0, 134.0, 89.0, 92.0, 86.0], "value": 92.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 94.0, 93.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 83.0, 84.0, 83.0, 82.0, 82.0, 84.0, 86.0, 83.0], "value": 83.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 63.0, 65.0, 65.0, 64.0, 64.0, 63.0, 62.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 66.0, 66.0, 63.0, 60.0, 59.0, 57.0, 59.0, 59.0, 59.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 85.0, 86.0, 86.0, 85.0, 81.0, 83.0, 86.0, 88.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 133.0, 138.0, 136.0, 136.0, 136.0, 146.0, 141.0, 185.0, 138.0], "value": 142.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 164.0, 159.0, 161.0, 165.0, 164.0, 159.0, 161.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 63.0, 64.0, 65.0, 64.0, 62.0], "value": 64.2, "unit": "score"}]}]} 01:57:44 INFO - Return code: 0 01:57:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:57:44 ERROR - # TBPL SUCCESS # 01:57:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:57:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:57:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:57:44 INFO - 2017-03-09 01:57:44.191 screenresolution[1650:10110] starting screenresolution argv=screenresolution get 01:57:44 INFO - 2017-03-09 01:57:44.194 screenresolution[1650:10110] Display 0: 1600x1200x32@60 01:57:44 INFO - 2017-03-09 01:57:44.200 screenresolution[1651:10113] starting screenresolution argv=screenresolution list 01:57:44 INFO - Available Modes on Display 0 01:57:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:57:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:57:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:57:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:57:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:57:44 INFO - Intel Iris: 01:57:44 INFO - Chipset Model: Intel Iris 01:57:44 INFO - Type: GPU 01:57:44 INFO - Bus: Built-In 01:57:44 INFO - VRAM (Dynamic, Max): 1536 MB 01:57:44 INFO - Vendor: Intel (0x8086) 01:57:44 INFO - Device ID: 0x0a2e 01:57:44 INFO - Revision ID: 0x0009 01:57:44 INFO - Displays: 01:57:44 INFO - Display: 01:57:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:57:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:57:44 INFO - Display Serial Number: 1600x1200 60 01:57:44 INFO - Main Display: Yes 01:57:44 INFO - Mirror: Off 01:57:44 INFO - Online: Yes 01:57:44 INFO - Rotation: Supported 01:57:44 INFO - Return code: 0 01:57:44 INFO - Running post-action listener: _resource_record_post_action 01:57:44 INFO - [mozharness: 2017-03-09 09:57:44.437674Z] Finished run-tests step (success) 01:57:44 INFO - Running post-run listener: _resource_record_post_run 01:57:44 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 37811200; Write bytes: 510394880; Read time: 239; Write time: 1610 01:57:44 INFO - TinderboxPrint: CPU usage
54.1% 01:57:44 INFO - TinderboxPrint: I/O read bytes / time
37,811,200 / 239 01:57:44 INFO - TinderboxPrint: I/O write bytes / time
510,394,880 / 1,610 01:57:44 INFO - TinderboxPrint: CPU idle
2,205.7 (45.9%) 01:57:44 INFO - TinderboxPrint: CPU system
961.0 (20.0%) 01:57:44 INFO - TinderboxPrint: CPU user
1,642.9 (34.2%) 01:57:44 INFO - TinderboxPrint: Swap in / out
246,480,896 / 0 01:57:44 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208296448; Write bytes: 202851840; Read time: 15919; Write time: 456 01:57:44 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 35615744; Write bytes: 297430016; Read time: 215; Write time: 1124 01:57:44 INFO - Running post-run listener: _upload_blobber_files 01:57:44 INFO - Blob upload gear active. 01:57:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:57:44 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 01:57:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:57:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:57:45 INFO - (blobuploader) - INFO - Open directory for files ... 01:57:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:57:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:57:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:57:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:57:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:57:46 INFO - (blobuploader) - INFO - Done attempting. 01:57:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:57:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:57:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:57:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:57:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:57:47 INFO - (blobuploader) - INFO - Done attempting. 01:57:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:57:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:57:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:57:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:57:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:57:48 INFO - (blobuploader) - INFO - Done attempting. 01:57:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:57:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:57:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:57:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:57:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:57:50 INFO - (blobuploader) - INFO - Done attempting. 01:57:50 INFO - (blobuploader) - INFO - Iteration through files over. 01:57:50 INFO - Return code: 0 01:57:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:57:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:57:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e19df0218c98867c9a3de350646425c54187cfb145160d88331327175336c2ab6003825e8848d535b221718e7473e951c784de7f6eff8f998878326580a6027f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c70c91b493faeac2d5f1dd9cedd9fd83c53b4094c1507b504a65ec7ade08d584b299b30c411b8745822459cf280ef8cb02a78b3a79011acb228de515800cc89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a60d6714d8e9d65b3ba5c950a9d5f56f718d0afba45baae41d7cebafc6ede90bd801ff261d069faa8ab78e7b754ef84be2add6afeeb5b078dc982064ad4595a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f7a3034e27b9acb068f7c03b25e5d510728a260a1925ce796201460f2646aa851db1c91eb1269425602f900577dad01353efa11cf4070495849f5aa02cdd80e"} 01:57:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:57:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:57:50 INFO - Contents: 01:57:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e19df0218c98867c9a3de350646425c54187cfb145160d88331327175336c2ab6003825e8848d535b221718e7473e951c784de7f6eff8f998878326580a6027f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c70c91b493faeac2d5f1dd9cedd9fd83c53b4094c1507b504a65ec7ade08d584b299b30c411b8745822459cf280ef8cb02a78b3a79011acb228de515800cc89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a60d6714d8e9d65b3ba5c950a9d5f56f718d0afba45baae41d7cebafc6ede90bd801ff261d069faa8ab78e7b754ef84be2add6afeeb5b078dc982064ad4595a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f7a3034e27b9acb068f7c03b25e5d510728a260a1925ce796201460f2646aa851db1c91eb1269425602f900577dad01353efa11cf4070495849f5aa02cdd80e"} 01:57:50 INFO - Running post-run listener: copy_logs_to_upload_dir 01:57:50 INFO - Copying logs to upload dir... 01:57:50 INFO - mkdir: /builds/slave/test/build/upload/logs 01:57:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.318861 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-09 01:57:50.611679) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-09 01:57:50.615201) ========= 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.B0khhA6xE8/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.W8TU98hJ6b/Listeners TMPDIR=/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e19df0218c98867c9a3de350646425c54187cfb145160d88331327175336c2ab6003825e8848d535b221718e7473e951c784de7f6eff8f998878326580a6027f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c70c91b493faeac2d5f1dd9cedd9fd83c53b4094c1507b504a65ec7ade08d584b299b30c411b8745822459cf280ef8cb02a78b3a79011acb228de515800cc89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a60d6714d8e9d65b3ba5c950a9d5f56f718d0afba45baae41d7cebafc6ede90bd801ff261d069faa8ab78e7b754ef84be2add6afeeb5b078dc982064ad4595a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f7a3034e27b9acb068f7c03b25e5d510728a260a1925ce796201460f2646aa851db1c91eb1269425602f900577dad01353efa11cf4070495849f5aa02cdd80e"} build_url:https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011149 build_url: 'https://queue.taskcluster.net/v1/task/MO5CmCWzSaGxY8fTvdK35Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e19df0218c98867c9a3de350646425c54187cfb145160d88331327175336c2ab6003825e8848d535b221718e7473e951c784de7f6eff8f998878326580a6027f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c70c91b493faeac2d5f1dd9cedd9fd83c53b4094c1507b504a65ec7ade08d584b299b30c411b8745822459cf280ef8cb02a78b3a79011acb228de515800cc89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a60d6714d8e9d65b3ba5c950a9d5f56f718d0afba45baae41d7cebafc6ede90bd801ff261d069faa8ab78e7b754ef84be2add6afeeb5b078dc982064ad4595a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f7a3034e27b9acb068f7c03b25e5d510728a260a1925ce796201460f2646aa851db1c91eb1269425602f900577dad01353efa11cf4070495849f5aa02cdd80e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-09 01:57:50.650724) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 01:57:50.651140) ========= 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.B0khhA6xE8/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.W8TU98hJ6b/Listeners TMPDIR=/var/folders/j2/21n1zhy52bldgl85sg0cdxlc00000w/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.005209 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 01:57:50.702690) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-09 01:57:50.703636) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-09 01:57:50.704394) ========= ========= Total master_lag: 0.19 =========