builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0119 starttime: 1490061759.93 results: success (0) buildid: 20170320175028 builduid: 9f594cd99a624b22956a2b30b6f8ee0f revision: f897fc6fb17f13251963aa4236e541064e9881d3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 19:02:39.928119) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 19:02:39.928597) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 19:02:39.928900) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 19:02:39.955335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 19:02:39.955742) ========= 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.iGmZmIEg44/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.LLXsRUemFo/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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-20 19:02:39-- 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% 15.8M=0.001s 2017-03-20 19:02:40 (15.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.163952 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 19:02:40.143350) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 19:02:40.143671) ========= 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.iGmZmIEg44/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.LLXsRUemFo/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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.020858 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 19:02:40.192129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-20 19:02:40.192493) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f897fc6fb17f13251963aa4236e541064e9881d3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f897fc6fb17f13251963aa4236e541064e9881d3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iGmZmIEg44/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.LLXsRUemFo/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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-20 19:02:40,274 truncating revision to first 12 chars 2017-03-20 19:02:40,274 Setting DEBUG logging. 2017-03-20 19:02:40,274 attempt 1/10 2017-03-20 19:02:40,274 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f897fc6fb17f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-20 19:02:42,595 unpacking tar archive at: mozilla-central-f897fc6fb17f/testing/mozharness/ program finished with exit code 0 elapsedTime=2.585482 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-20 19:02:42.802101) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 19:02:42.802431) ========= script_repo_revision: f897fc6fb17f13251963aa4236e541064e9881d3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 19:02:42.802846) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 19:02:42.803118) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 19:02:42.822837) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-03-20 19:02:42.823191) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iGmZmIEg44/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.LLXsRUemFo/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 19:02:43 INFO - MultiFileLogger online at 20170320 19:02:43 in /builds/slave/test 19:02:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:02:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:02:43 INFO - {'append_to_log': False, 19:02:43 INFO - 'base_work_dir': '/builds/slave/test', 19:02:43 INFO - 'blob_upload_branch': 'Firefox', 19:02:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:02:43 INFO - 'branch': 'Firefox', 19:02:43 INFO - 'buildbot_json_path': 'buildprops.json', 19:02:43 INFO - 'config_files': ('talos/mac_config.py',), 19:02:43 INFO - 'default_actions': ('clobber', 19:02:43 INFO - 'read-buildbot-config', 19:02:43 INFO - 'download-and-extract', 19:02:43 INFO - 'populate-webroot', 19:02:43 INFO - 'create-virtualenv', 19:02:43 INFO - 'install', 19:02:43 INFO - 'run-tests'), 19:02:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:02:43 INFO - 'download_minidump_stackwalk': True, 19:02:43 INFO - 'download_symbols': 'ondemand', 19:02:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:02:43 INFO - 'tooltool.py': '/tools/tooltool.py', 19:02:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:02:43 INFO - '/tools/misc-python/virtualenv.py')}, 19:02:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:02:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:02:43 INFO - 'gecko_profile': False, 19:02:43 INFO - 'gecko_profile_interval': 0, 19:02:43 INFO - 'installer_path': 'installer.exe', 19:02:43 INFO - 'log_level': 'info', 19:02:43 INFO - 'log_name': 'talos', 19:02:43 INFO - 'log_to_console': True, 19:02:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:02:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:02:43 INFO - 'opt_config_files': (), 19:02:43 INFO - 'pip_index': False, 19:02:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:02:43 INFO - 'cmd': ('bash', 19:02:43 INFO - '-c', 19:02:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:02:43 INFO - 'enabled': True, 19:02:43 INFO - 'halt_on_failure': False, 19:02:43 INFO - 'name': 'check_screen_resolution'},), 19:02:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:02:43 INFO - 'cmd': ('bash', 19:02:43 INFO - '-c', 19:02:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:02:43 INFO - 'enabled': True, 19:02:43 INFO - 'halt_on_failure': False, 19:02:43 INFO - 'name': 'check_screen_resolution'},), 19:02:43 INFO - 'run_cmd_checks_enabled': True, 19:02:43 INFO - 'suite': 'dromaeojs', 19:02:43 INFO - 'system_bits': '32', 19:02:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:02:43 INFO - 'title': 't-yosemite-r7-0119', 19:02:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:02:43 INFO - 'use_talos_json': True, 19:02:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:02:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:02:43 INFO - 'work_dir': 'build'} 19:02:43 INFO - [mozharness: 2017-03-21 02:02:43.034986Z] Running clobber step. 19:02:43 INFO - Running pre-action listener: _resource_record_pre_action 19:02:43 INFO - Running main action method: clobber 19:02:43 INFO - rmtree: /builds/slave/test/build 19:02:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:02:44 INFO - Running post-action listener: _resource_record_post_action 19:02:44 INFO - [mozharness: 2017-03-21 02:02:44.790756Z] Finished clobber step (success) 19:02:44 INFO - [mozharness: 2017-03-21 02:02:44.790901Z] Running read-buildbot-config step. 19:02:44 INFO - Running pre-action listener: _resource_record_pre_action 19:02:44 INFO - Running main action method: read_buildbot_config 19:02:44 INFO - Using buildbot properties: 19:02:44 INFO - { 19:02:44 INFO - "project": "", 19:02:44 INFO - "product": "firefox", 19:02:44 INFO - "script_repo_revision": "production", 19:02:44 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 19:02:44 INFO - "repository": "", 19:02:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 19:02:44 INFO - "buildid": "20170320175028", 19:02:44 INFO - "pgo_build": "False", 19:02:44 INFO - "basedir": "/builds/slave/test", 19:02:44 INFO - "buildnumber": 51, 19:02:44 INFO - "slavename": "t-yosemite-r7-0119", 19:02:44 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 19:02:44 INFO - "platform": "yosemite_r7", 19:02:44 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:02:44 INFO - "branch": "mozilla-central", 19:02:44 INFO - "repo_path": "mozilla-central", 19:02:44 INFO - "revision": "f897fc6fb17f13251963aa4236e541064e9881d3", 19:02:44 INFO - "stage_platform": "macosx64", 19:02:44 INFO - "builduid": "9f594cd99a624b22956a2b30b6f8ee0f", 19:02:44 INFO - "slavebuilddir": "test" 19:02:44 INFO - } 19:02:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 19:02:44 INFO - Running post-action listener: _resource_record_post_action 19:02:44 INFO - [mozharness: 2017-03-21 02:02:44.794508Z] Finished read-buildbot-config step (success) 19:02:44 INFO - [mozharness: 2017-03-21 02:02:44.794640Z] Running download-and-extract step. 19:02:44 INFO - Running pre-action listener: _resource_record_pre_action 19:02:44 INFO - Running main action method: download_and_extract 19:02:44 INFO - mkdir: /builds/slave/test/build/tests 19:02:44 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')]} 19:02:44 INFO - trying https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 19:02:44 INFO - Downloading https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 19:02:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 19:02:45 INFO - Downloaded 1325 bytes. 19:02:45 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 19:02:45 INFO - Using the following test package requirements: 19:02:45 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:02:45 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 19:02:45 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 19:02:45 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:02:45 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 19:02:45 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:02:45 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 19:02:45 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:02:45 INFO - u'jsshell-mac.zip'], 19:02:45 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:02:45 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 19:02:45 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 19:02:45 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:02:45 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 19:02:45 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:02:45 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 19:02:45 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:02:45 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 19:02:45 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:02:45 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 19:02:45 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:02:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 19:02:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:02:45 INFO - Fetch https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 19:02:47 INFO - Expected file size: 52476628 19:02:47 INFO - Obtained file size: 52476628 19:03:03 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:03:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 19:03:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:03:03 INFO - Fetch https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 19:03:05 INFO - Expected file size: 52476628 19:03:05 INFO - Obtained file size: 52476628 19:03:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 19:03:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:03:20 INFO - Fetch https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 19:03:23 INFO - Expected file size: 14404171 19:03:23 INFO - Obtained file size: 14404171 19:03:23 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')]} 19:03:23 INFO - trying https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:03:23 INFO - Downloading https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 19:03:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 19:03:26 INFO - Downloaded 75183407 bytes. 19:03:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:03:26 INFO - mkdir: /builds/slave/test/properties 19:03:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:03:26 INFO - Writing to file /builds/slave/test/properties/build_url 19:03:26 INFO - Contents: 19:03:26 INFO - build_url:https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:03:26 INFO - Running post-action listener: _resource_record_post_action 19:03:26 INFO - Running post-action listener: set_extra_try_arguments 19:03:26 INFO - [mozharness: 2017-03-21 02:03:26.775398Z] Finished download-and-extract step (success) 19:03:26 INFO - [mozharness: 2017-03-21 02:03:26.775540Z] Running populate-webroot step. 19:03:26 INFO - Running pre-action listener: _resource_record_pre_action 19:03:26 INFO - Running main action method: populate_webroot 19:03:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:03:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:03:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:03:26 INFO - '--tppagecycles', 19:03:26 INFO - '7'], 19:03:26 INFO - 'tests': ['tsvgm']}}, 19:03:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:03:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:03:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:03:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:03:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:03:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:03:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:03:26 INFO - 'talos_options': ['--disable-e10s'], 19:03:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:03:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:03:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:03:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:03:26 INFO - 'talos_options': ['--disable-e10s'], 19:03:26 INFO - 'tests': ['damp', 'tps']}, 19:03:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:03:26 INFO - 'tests': ['damp', 'tps']}, 19:03:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:03:26 INFO - 'tests': ['dromaeo_dom']}, 19:03:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:03:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:03:26 INFO - 'tests': ['basic_compositor_video']}, 19:03:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:03:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:03:26 INFO - 'tests': ['a11yr', 19:03:26 INFO - 'ts_paint', 19:03:26 INFO - 'tpaint', 19:03:26 INFO - 'sessionrestore', 19:03:26 INFO - 'sessionrestore_no_auto_restore', 19:03:26 INFO - 'tabpaint']}, 19:03:26 INFO - 'other-e10s': {'tests': ['a11yr', 19:03:26 INFO - 'ts_paint', 19:03:26 INFO - 'tpaint', 19:03:26 INFO - 'sessionrestore', 19:03:26 INFO - 'sessionrestore_no_auto_restore', 19:03:26 INFO - 'tabpaint']}, 19:03:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:03:26 INFO - 'ts_paint', 19:03:26 INFO - 'tpaint', 19:03:26 INFO - 'sessionrestore', 19:03:26 INFO - 'sessionrestore_no_auto_restore', 19:03:26 INFO - 'tabpaint']}, 19:03:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:03:26 INFO - 'ts_paint', 19:03:26 INFO - 'tpaint', 19:03:26 INFO - 'sessionrestore', 19:03:26 INFO - 'sessionrestore_no_auto_restore', 19:03:26 INFO - 'tabpaint']}, 19:03:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:03:26 INFO - 'tests': ['a11yr', 19:03:26 INFO - 'ts_paint', 19:03:26 INFO - 'tpaint', 19:03:26 INFO - 'sessionrestore', 19:03:26 INFO - 'sessionrestore_no_auto_restore', 19:03:26 INFO - 'tabpaint']}, 19:03:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:03:26 INFO - 'tests': ['a11yr', 19:03:26 INFO - 'ts_paint', 19:03:26 INFO - 'tpaint', 19:03:26 INFO - 'sessionrestore', 19:03:26 INFO - 'sessionrestore_no_auto_restore', 19:03:26 INFO - 'tabpaint']}, 19:03:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:03:26 INFO - 'tests': ['tsvgx', 19:03:26 INFO - 'tsvgr_opacity', 19:03:26 INFO - 'tart', 19:03:26 INFO - 'tscrollx', 19:03:26 INFO - 'cart', 19:03:26 INFO - 'tsvg_static']}, 19:03:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:03:26 INFO - 'tsvgr_opacity', 19:03:26 INFO - 'tart', 19:03:26 INFO - 'tscrollx', 19:03:26 INFO - 'cart', 19:03:26 INFO - 'tsvg_static']}, 19:03:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:03:26 INFO - 'talos_options': ['--disable-e10s'], 19:03:26 INFO - 'tests': ['tp5o']}, 19:03:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:03:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:03:26 INFO - 'talos_options': ['--disable-e10s', 19:03:26 INFO - '--xperf_path', 19:03:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:03:26 INFO - 'tests': ['tp5n']}, 19:03:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:03:26 INFO - 'talos_options': ['--xperf_path', 19:03:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:03:26 INFO - 'tests': ['tp5n']}}, 19:03:26 INFO - 'talos.zip': {'path': '', 19:03:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:03:26 INFO - Running post-action listener: _resource_record_post_action 19:03:26 INFO - [mozharness: 2017-03-21 02:03:26.793947Z] Finished populate-webroot step (success) 19:03:26 INFO - [mozharness: 2017-03-21 02:03:26.794079Z] Running create-virtualenv step. 19:03:26 INFO - Running pre-action listener: _resource_record_pre_action 19:03:26 INFO - Running main action method: create_virtualenv 19:03:26 INFO - Creating virtualenv /builds/slave/test/build/venv 19:03:26 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 19:03:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:03:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:03:26 INFO - Using real prefix '/tools/python27' 19:03:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:03:27 INFO - Installing distribute.............................................................................................................................................................................................done. 19:03:30 INFO - Installing pip.................done. 19:03:30 INFO - Return code: 0 19:03:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:03:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:03:30 INFO - Reading from file tmpfile_stdout 19:03:30 INFO - Output received: 19:03:30 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) 19:03:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03: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')]} 19:03:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:31 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 0x106d93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3784bb5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b71d30>, '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 0x106a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b66be8>, '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.iGmZmIEg44/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.LLXsRUemFo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 19:03:31 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 19:03:31 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 19:03:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iGmZmIEg44/Render', 19:03:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:31 INFO - 'HOME': '/Users/cltbld', 19:03:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:31 INFO - 'LOGNAME': 'cltbld', 19:03:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:31 INFO - 'MOZ_NO_REMOTE': '1', 19:03:31 INFO - 'NO_EM_RESTART': '1', 19:03:31 INFO - 'PAGER': '/bin/cat', 19:03:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:31 INFO - 'PWD': '/builds/slave/test', 19:03:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:31 INFO - 'SHELL': '/bin/bash', 19:03:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LLXsRUemFo/Listeners', 19:03:31 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 19:03:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:31 INFO - 'USER': 'cltbld', 19:03:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:31 INFO - 'XPC_FLAGS': '0x0', 19:03:31 INFO - 'XPC_SERVICE_NAME': '0', 19:03:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:31 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 19:03:31 INFO - Cleaning up... 19:03:31 INFO - Return code: 0 19:03:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:03: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')]} 19:03:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03: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')]} 19:03:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:32 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 0x106d93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3784bb5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b71d30>, '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 0x106a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b66be8>, '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.iGmZmIEg44/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.LLXsRUemFo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 19:03:32 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 19:03:32 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 19:03:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iGmZmIEg44/Render', 19:03:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:32 INFO - 'HOME': '/Users/cltbld', 19:03:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:32 INFO - 'LOGNAME': 'cltbld', 19:03:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:32 INFO - 'MOZ_NO_REMOTE': '1', 19:03:32 INFO - 'NO_EM_RESTART': '1', 19:03:32 INFO - 'PAGER': '/bin/cat', 19:03:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:32 INFO - 'PWD': '/builds/slave/test', 19:03:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:32 INFO - 'SHELL': '/bin/bash', 19:03:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LLXsRUemFo/Listeners', 19:03:32 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 19:03:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:32 INFO - 'USER': 'cltbld', 19:03:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:32 INFO - 'XPC_FLAGS': '0x0', 19:03:32 INFO - 'XPC_SERVICE_NAME': '0', 19:03:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:32 INFO - Downloading/unpacking psutil>=3.1.1 19:03:32 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 19:03:32 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 19:03:32 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 19:03:32 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 19:03:32 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 19:03:32 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 19:03:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:03:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:03:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:03:37 INFO - Installing collected packages: psutil 19:03:37 INFO - Running setup.py install for psutil 19:03:37 INFO - building 'psutil._psutil_osx' extension 19:03:37 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 19:03:37 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 19:03:37 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 19:03:38 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 19:03:38 INFO - building 'psutil._psutil_posix' extension 19:03:38 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 19:03:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:03:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:03:38 INFO - ^ 19:03:38 INFO - 1 warning generated. 19:03:38 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 19:03:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:03:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:03:38 INFO - Successfully installed psutil 19:03:38 INFO - Cleaning up... 19:03:38 INFO - Return code: 0 19:03:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:03:38 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')]} 19:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:38 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')]} 19:03:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:38 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 0x106d93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3784bb5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b71d30>, '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 0x106a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b66be8>, '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.iGmZmIEg44/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.LLXsRUemFo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 19:03:38 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 19:03:38 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 19:03:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iGmZmIEg44/Render', 19:03:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:38 INFO - 'HOME': '/Users/cltbld', 19:03:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:38 INFO - 'LOGNAME': 'cltbld', 19:03:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:38 INFO - 'MOZ_NO_REMOTE': '1', 19:03:38 INFO - 'NO_EM_RESTART': '1', 19:03:38 INFO - 'PAGER': '/bin/cat', 19:03:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:38 INFO - 'PWD': '/builds/slave/test', 19:03:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:38 INFO - 'SHELL': '/bin/bash', 19:03:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LLXsRUemFo/Listeners', 19:03:38 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 19:03:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:38 INFO - 'USER': 'cltbld', 19:03:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:38 INFO - 'XPC_FLAGS': '0x0', 19:03:38 INFO - 'XPC_SERVICE_NAME': '0', 19:03:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:03: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 19:03: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 19:03: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 19:03: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 19:03: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 19:03: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 19:03:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:03:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:03:41 INFO - Installing collected packages: mozsystemmonitor 19:03:41 INFO - Running setup.py install for mozsystemmonitor 19:03:41 INFO - Successfully installed mozsystemmonitor 19:03:41 INFO - Cleaning up... 19:03:41 INFO - Return code: 0 19:03:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:03: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')]} 19:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03: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')]} 19:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3784bb5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b71d30>, '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 0x106a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b66be8>, '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.iGmZmIEg44/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.LLXsRUemFo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 19:03: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==2.5.1'] in /builds/slave/test/build 19:03: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==2.5.1 19:03:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iGmZmIEg44/Render', 19:03:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:41 INFO - 'HOME': '/Users/cltbld', 19:03:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:41 INFO - 'LOGNAME': 'cltbld', 19:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:41 INFO - 'MOZ_NO_REMOTE': '1', 19:03:41 INFO - 'NO_EM_RESTART': '1', 19:03:41 INFO - 'PAGER': '/bin/cat', 19:03:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:41 INFO - 'PWD': '/builds/slave/test', 19:03:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:41 INFO - 'SHELL': '/bin/bash', 19:03:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LLXsRUemFo/Listeners', 19:03:41 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 19:03:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:41 INFO - 'USER': 'cltbld', 19:03:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:41 INFO - 'XPC_FLAGS': '0x0', 19:03:41 INFO - 'XPC_SERVICE_NAME': '0', 19:03:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:41 INFO - Downloading/unpacking jsonschema==2.5.1 19:03:41 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 19:03:41 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 19:03:41 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 19:03:41 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 19:03:41 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 19:03:41 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 19:03:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:03:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:03:44 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 19:03:44 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 19:03:44 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 19:03:44 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 19:03:44 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 19:03:44 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 19:03:44 INFO - Downloading functools32-3.2.3-2.tar.gz 19:03:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:03:44 INFO - warning: no files found matching '*.txt' 19:03:44 INFO - no previously-included directories found matching 'build' 19:03:44 INFO - no previously-included directories found matching 'dist' 19:03:44 INFO - no previously-included directories found matching '.git*' 19:03:44 INFO - Installing collected packages: jsonschema, functools32 19:03:45 INFO - Running setup.py install for functools32 19:03:45 INFO - warning: no files found matching '*.txt' 19:03:45 INFO - no previously-included directories found matching 'build' 19:03:45 INFO - no previously-included directories found matching 'dist' 19:03:45 INFO - no previously-included directories found matching '.git*' 19:03:45 INFO - Successfully installed jsonschema functools32 19:03:45 INFO - Cleaning up... 19:03:45 INFO - Return code: 0 19:03:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106d93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3784bb5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b71d30>, '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 0x106a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b66be8>, '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.iGmZmIEg44/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.LLXsRUemFo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 19:03:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:03:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iGmZmIEg44/Render', 19:03:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:45 INFO - 'HOME': '/Users/cltbld', 19:03:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:45 INFO - 'LOGNAME': 'cltbld', 19:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:45 INFO - 'MOZ_NO_REMOTE': '1', 19:03:45 INFO - 'NO_EM_RESTART': '1', 19:03:45 INFO - 'PAGER': '/bin/cat', 19:03:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:45 INFO - 'PWD': '/builds/slave/test', 19:03:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:45 INFO - 'SHELL': '/bin/bash', 19:03:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LLXsRUemFo/Listeners', 19:03:45 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 19:03:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:45 INFO - 'USER': 'cltbld', 19:03:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:45 INFO - 'XPC_FLAGS': '0x0', 19:03:45 INFO - 'XPC_SERVICE_NAME': '0', 19:03:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:03:45 INFO - Cleaning up... 19:03:45 INFO - Return code: 0 19:03:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3784bb5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b71d30>, '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 0x106a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b66be8>, '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.iGmZmIEg44/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.LLXsRUemFo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 19:03:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:03:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iGmZmIEg44/Render', 19:03:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:45 INFO - 'HOME': '/Users/cltbld', 19:03:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:45 INFO - 'LOGNAME': 'cltbld', 19:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:45 INFO - 'MOZ_NO_REMOTE': '1', 19:03:45 INFO - 'NO_EM_RESTART': '1', 19:03:45 INFO - 'PAGER': '/bin/cat', 19:03:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:45 INFO - 'PWD': '/builds/slave/test', 19:03:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:45 INFO - 'SHELL': '/bin/bash', 19:03:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LLXsRUemFo/Listeners', 19:03:45 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 19:03:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:45 INFO - 'USER': 'cltbld', 19:03:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:45 INFO - 'XPC_FLAGS': '0x0', 19:03:45 INFO - 'XPC_SERVICE_NAME': '0', 19:03:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:45 INFO - Downloading/unpacking blobuploader==1.2.4 19:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:48 INFO - Downloading blobuploader-1.2.4.tar.gz 19:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:03:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:03:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:03:49 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 19:03:49 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 19:03:49 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 19:03:49 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 19:03:49 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 19:03:49 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 19:03:49 INFO - Downloading docopt-0.6.1.tar.gz 19:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:03:49 INFO - Installing collected packages: blobuploader, requests, docopt 19:03:49 INFO - Running setup.py install for blobuploader 19:03:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:03:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:03:49 INFO - Running setup.py install for requests 19:03:50 INFO - Running setup.py install for docopt 19:03:50 INFO - Successfully installed blobuploader requests docopt 19:03:50 INFO - Cleaning up... 19:03:50 INFO - Return code: 0 19:03:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:50 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 0x106d93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3784bb5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b71d30>, '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 0x106a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b66be8>, '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.iGmZmIEg44/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.LLXsRUemFo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 19:03:50 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 19:03:50 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 19:03:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iGmZmIEg44/Render', 19:03:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:50 INFO - 'HOME': '/Users/cltbld', 19:03:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:50 INFO - 'LOGNAME': 'cltbld', 19:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:50 INFO - 'MOZ_NO_REMOTE': '1', 19:03:50 INFO - 'NO_EM_RESTART': '1', 19:03:50 INFO - 'PAGER': '/bin/cat', 19:03:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:50 INFO - 'PWD': '/builds/slave/test', 19:03:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:50 INFO - 'SHELL': '/bin/bash', 19:03:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LLXsRUemFo/Listeners', 19:03:50 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 19:03:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:50 INFO - 'USER': 'cltbld', 19:03:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:50 INFO - 'XPC_FLAGS': '0x0', 19:03:50 INFO - 'XPC_SERVICE_NAME': '0', 19:03:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:03:50 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-qOyREC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:03:51 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-Isf3rU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:03:51 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-c4LWJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:03:51 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-zP7YhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:03:51 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-zPL6xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:03:51 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-LBdbCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:03:51 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-zL_FWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:03:51 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-Ss7Vsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:03:51 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-luQYyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:03:51 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-mln4pG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:03:51 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-NZoDnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:03:52 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-ebQntY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:03:52 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-46pCWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:03:52 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-XJIC4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:52 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-2XoCbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:03:52 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-0NsQIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:03:52 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-s5B5O8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:03:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:03:52 INFO - Running setup.py install for manifestparser 19:03:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:03:52 INFO - Running setup.py install for mozcrash 19:03:52 INFO - Running setup.py install for mozdebug 19:03:53 INFO - Running setup.py install for mozdevice 19:03:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:03:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:03:53 INFO - Running setup.py install for mozfile 19:03:53 INFO - Running setup.py install for mozhttpd 19:03:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:03:53 INFO - Running setup.py install for mozinfo 19:03:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:03:53 INFO - Running setup.py install for mozInstall 19:03:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:03:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:03:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:03:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:03:53 INFO - Running setup.py install for mozleak 19:03:54 INFO - Running setup.py install for mozlog 19:03:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:03:54 INFO - Running setup.py install for moznetwork 19:03:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:03:54 INFO - Running setup.py install for mozprocess 19:03:54 INFO - Running setup.py install for mozprofile 19:03:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:03:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:03:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:03:54 INFO - Running setup.py install for mozrunner 19:03:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:03:54 INFO - Running setup.py install for mozscreenshot 19:03:54 INFO - Running setup.py install for moztest 19:03:55 INFO - Running setup.py install for mozversion 19:03:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:03:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:03:55 INFO - Cleaning up... 19:03:55 INFO - Return code: 0 19:03:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:03:55 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')]} 19:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:55 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')]} 19:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:55 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 0x106d93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3784bb5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b71d30>, '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 0x106a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b66be8>, '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.iGmZmIEg44/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.LLXsRUemFo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 19:03:55 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 19:03:55 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 19:03:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iGmZmIEg44/Render', 19:03:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:55 INFO - 'HOME': '/Users/cltbld', 19:03:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:55 INFO - 'LOGNAME': 'cltbld', 19:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:55 INFO - 'MOZ_NO_REMOTE': '1', 19:03:55 INFO - 'NO_EM_RESTART': '1', 19:03:55 INFO - 'PAGER': '/bin/cat', 19:03:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:55 INFO - 'PWD': '/builds/slave/test', 19:03:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:55 INFO - 'SHELL': '/bin/bash', 19:03:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LLXsRUemFo/Listeners', 19:03:55 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 19:03:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:55 INFO - 'USER': 'cltbld', 19:03:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:55 INFO - 'XPC_FLAGS': '0x0', 19:03:55 INFO - 'XPC_SERVICE_NAME': '0', 19:03:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:03:55 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-Z_zxwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:03:55 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)) 19:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:03:55 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-f8runF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:03:55 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)) 19:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:03:55 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-f13j8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:03:55 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)) 19:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:03:55 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-FE0uAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:03:56 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)) 19:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:03:56 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-os9mqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:03:56 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)) 19:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:03:56 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-qJTZDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:03:56 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)) 19:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:03:56 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-no6zWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:03:56 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)) 19:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:03:56 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-wzSWH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:03:56 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)) 19:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:03:56 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-vLMQsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:03:56 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)) 19:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:03:56 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-SFujBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:03:56 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)) 19:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:03:56 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-SDKl6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:03:56 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)) 19:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:03:56 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-Rqq1gn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:03:56 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)) 19:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:03:56 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-ieltiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:03:56 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)) 19:03:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:03:56 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-wLnOPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:03:57 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)) 19:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:57 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-2Kd0Lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:57 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)) 19:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:03:57 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-upmbT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:03:57 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)) 19:03:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:03:57 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-WXCHDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:03:57 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)) 19:03:57 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)) 19:03:57 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)) 19:03:57 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)) 19:03:57 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)) 19:03:57 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)) 19:03:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:00 INFO - Downloading blessings-1.6.tar.gz 19:04:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:04:00 INFO - Installing collected packages: blessings 19:04:00 INFO - Running setup.py install for blessings 19:04:00 INFO - Successfully installed blessings 19:04:00 INFO - Cleaning up... 19:04:00 INFO - Return code: 0 19:04:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:04:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:04:00 INFO - Reading from file tmpfile_stdout 19:04:00 INFO - Current package versions: 19:04:00 INFO - blessings == 1.6 19:04:00 INFO - blobuploader == 1.2.4 19:04:00 INFO - docopt == 0.6.1 19:04:00 INFO - functools32 == 3.2.3-2 19:04:00 INFO - jsonschema == 2.5.1 19:04:00 INFO - manifestparser == 1.1 19:04:00 INFO - mozInstall == 1.12 19:04:00 INFO - mozcrash == 1.0 19:04:00 INFO - mozdebug == 0.1 19:04:00 INFO - mozdevice == 0.49 19:04:00 INFO - mozfile == 1.2 19:04:00 INFO - mozhttpd == 0.7 19:04:00 INFO - mozinfo == 0.9 19:04:00 INFO - mozleak == 0.1 19:04:00 INFO - mozlog == 3.4 19:04:00 INFO - moznetwork == 0.27 19:04:00 INFO - mozprocess == 0.25 19:04:00 INFO - mozprofile == 0.28 19:04:00 INFO - mozrunner == 6.13 19:04:00 INFO - mozscreenshot == 0.1 19:04:00 INFO - mozsystemmonitor == 0.3 19:04:00 INFO - moztest == 0.8 19:04:00 INFO - mozversion == 1.4 19:04:00 INFO - psutil == 3.1.1 19:04:00 INFO - requests == 1.2.3 19:04:00 INFO - wsgiref == 0.1.2 19:04:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:04:00 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')]} 19:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:00 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')]} 19:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:00 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 0x106d93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3784bb5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b71d30>, '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 0x106a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b66be8>, '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.iGmZmIEg44/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.LLXsRUemFo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 19:04:00 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 19:04:00 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 19:04:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iGmZmIEg44/Render', 19:04:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:04:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:04:00 INFO - 'HOME': '/Users/cltbld', 19:04:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:04:00 INFO - 'LOGNAME': 'cltbld', 19:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:00 INFO - 'MOZ_NO_REMOTE': '1', 19:04:00 INFO - 'NO_EM_RESTART': '1', 19:04:00 INFO - 'PAGER': '/bin/cat', 19:04:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:00 INFO - 'PWD': '/builds/slave/test', 19:04:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:04:00 INFO - 'SHELL': '/bin/bash', 19:04:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LLXsRUemFo/Listeners', 19:04:00 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 19:04:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:04:00 INFO - 'USER': 'cltbld', 19:04:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:04:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:00 INFO - 'XPC_FLAGS': '0x0', 19:04:00 INFO - 'XPC_SERVICE_NAME': '0', 19:04:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:00 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)) 19:04:00 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)) 19:04:00 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)) 19:04:00 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)) 19:04:00 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)) 19:04:00 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)) 19:04:00 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)) 19:04:00 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)) 19:04:00 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)) 19:04:00 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)) 19:04:00 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)) 19:04:00 INFO - Cleaning up... 19:04:00 INFO - Return code: 0 19:04:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:04:00 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')]} 19:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:00 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')]} 19:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:00 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 0x106d93b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d96768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3784bb5f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b71d30>, '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 0x106a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b66be8>, '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.iGmZmIEg44/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.LLXsRUemFo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 19:04:00 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 19:04:00 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 19:04:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iGmZmIEg44/Render', 19:04:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:04:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:04:00 INFO - 'HOME': '/Users/cltbld', 19:04:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:04:00 INFO - 'LOGNAME': 'cltbld', 19:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:00 INFO - 'MOZ_NO_REMOTE': '1', 19:04:00 INFO - 'NO_EM_RESTART': '1', 19:04:00 INFO - 'PAGER': '/bin/cat', 19:04:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:00 INFO - 'PWD': '/builds/slave/test', 19:04:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:04:00 INFO - 'SHELL': '/bin/bash', 19:04:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LLXsRUemFo/Listeners', 19:04:00 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 19:04:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:04:00 INFO - 'USER': 'cltbld', 19:04:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:04:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:00 INFO - 'XPC_FLAGS': '0x0', 19:04:00 INFO - 'XPC_SERVICE_NAME': '0', 19:04:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:04:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:04:01 INFO - Cleaning up... 19:04:01 INFO - Return code: 0 19:04:01 INFO - Running post-action listener: _resource_record_post_action 19:04:01 INFO - Running post-action listener: _start_resource_monitoring 19:04:01 INFO - Starting resource monitoring. 19:04:01 INFO - [mozharness: 2017-03-21 02:04:01.244729Z] Finished create-virtualenv step (success) 19:04:01 INFO - [mozharness: 2017-03-21 02:04:01.245771Z] Running install step. 19:04:01 INFO - Running pre-action listener: _resource_record_pre_action 19:04:01 INFO - Running main action method: install 19:04:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:04:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:04:01 INFO - Reading from file tmpfile_stdout 19:04:01 INFO - Detecting whether we're running mozinstall >=1.0... 19:04:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:04:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:04:01 INFO - Reading from file tmpfile_stdout 19:04:01 INFO - Output received: 19:04:01 INFO - Usage: mozinstall [options] installer 19:04:01 INFO - Options: 19:04:01 INFO - -h, --help show this help message and exit 19:04:01 INFO - -d DEST, --destination=DEST 19:04:01 INFO - Directory to install application into. [default: 19:04:01 INFO - "/builds/slave/test"] 19:04:01 INFO - --app=APP Application being installed. [default: firefox] 19:04:01 INFO - mkdir: /builds/slave/test/build/application 19:04:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:04:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:04:22 INFO - Reading from file tmpfile_stdout 19:04:22 INFO - Output received: 19:04:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:04:22 INFO - Running post-action listener: _resource_record_post_action 19:04:22 INFO - [mozharness: 2017-03-21 02:04:22.095122Z] Finished install step (success) 19:04:22 INFO - [mozharness: 2017-03-21 02:04:22.095252Z] Running run-tests step. 19:04:22 INFO - Running pre-action listener: _resource_record_pre_action 19:04:22 INFO - Running main action method: run_tests 19:04:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:04:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:04:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:04:22 INFO - 2017-03-20 19:04:22.109 screenresolution[2171:24418] starting screenresolution argv=screenresolution get 19:04:22 INFO - 2017-03-20 19:04:22.112 screenresolution[2171:24418] Display 0: 1600x1200x32@60 19:04:22 INFO - 2017-03-20 19:04:22.118 screenresolution[2172:24420] starting screenresolution argv=screenresolution list 19:04:22 INFO - Available Modes on Display 0 19:04:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:04:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:04:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:04:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:04:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:04:22 INFO - Intel Iris: 19:04:22 INFO - Chipset Model: Intel Iris 19:04:22 INFO - Type: GPU 19:04:22 INFO - Bus: Built-In 19:04:22 INFO - VRAM (Dynamic, Max): 1536 MB 19:04:22 INFO - Vendor: Intel (0x8086) 19:04:22 INFO - Device ID: 0x0a2e 19:04:22 INFO - Revision ID: 0x0009 19:04:22 INFO - Displays: 19:04:22 INFO - Display: 19:04:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:04:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:04:22 INFO - Display Serial Number: 1600x1200 60 19:04:22 INFO - Main Display: Yes 19:04:22 INFO - Mirror: Off 19:04:22 INFO - Online: Yes 19:04:22 INFO - Rotation: Supported 19:04:22 INFO - Return code: 0 19:04:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:04:22 INFO - Python 2.7.3 19:04:22 INFO - Return code: 0 19:04:22 INFO - grabbing minidump binary from tooltool 19:04: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')]} 19:04:22 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 0x106b71d30>, '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 0x106a98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b66be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:04:22 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 19:04:22 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 19:04:22 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 19:04:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:04:22 INFO - Return code: 0 19:04:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:04:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:04:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:04:22 INFO - ENV: RUST_BACKTRACE is now 1 19:04:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:04:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:04:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0119', '--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 19:04:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0119 --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 19:04:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iGmZmIEg44/Render', 19:04:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:04:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:04:22 INFO - 'HOME': '/Users/cltbld', 19:04:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:04:22 INFO - 'LOGNAME': 'cltbld', 19:04:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:04:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:04:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:22 INFO - 'MOZ_NO_REMOTE': '1', 19:04:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:04:22 INFO - 'NO_EM_RESTART': '1', 19:04:22 INFO - 'PAGER': '/bin/cat', 19:04:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:04:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:22 INFO - 'PWD': '/builds/slave/test', 19:04:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:04:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:04:22 INFO - 'RUST_BACKTRACE': '1', 19:04:22 INFO - 'SHELL': '/bin/bash', 19:04:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LLXsRUemFo/Listeners', 19:04:22 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 19:04:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:04:22 INFO - 'USER': 'cltbld', 19:04:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:04:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:04:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:22 INFO - 'XPC_FLAGS': '0x0', 19:04:22 INFO - 'XPC_SERVICE_NAME': '0', 19:04:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:04:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0119', '--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 19:04:22 INFO - mozversion application_buildid: 20170320175028 19:04:22 INFO - mozversion application_changeset: f897fc6fb17f13251963aa4236e541064e9881d3 19:04:22 INFO - mozversion application_display_name: Nightly 19:04:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:04:22 INFO - mozversion application_name: Firefox 19:04:22 INFO - mozversion application_remotingname: firefox 19:04:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:04:22 INFO - mozversion application_vendor: Mozilla 19:04:22 INFO - mozversion application_version: 55.0a1 19:04:22 INFO - mozversion platform_buildid: 20170320175028 19:04:22 INFO - mozversion platform_changeset: f897fc6fb17f13251963aa4236e541064e9881d3 19:04:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:04:22 INFO - mozversion platform_version: 55.0a1 19:04:22 INFO - using testdate: 1490061862 19:04:22 INFO - actual date: 1490061862 19:04:22 INFO - starting webserver on 'localhost:57452' 19:04:22 INFO - SUITE-START | Running 2 tests 19:04:22 INFO - TEST-START | dromaeo_css 19:04:22 INFO - operating with platform_type : mac_ 19:04:22 INFO - Initialising browser for dromaeo_css test... 19:04:22 INFO - TEST-INFO | started process 2182 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpfmkMvZ/profile http://localhost:57452/getInfo.html) 19:04:25 INFO - PID 2182 | __metrics Screen width/height:1600/1200 19:04:25 INFO - PID 2182 | colorDepth:24 19:04:25 INFO - PID 2182 | Browser inner width/height: 1024/689 19:04:25 INFO - PID 2182 | __metrics 19:04:25 INFO - PID 2182 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:04:25 INFO - PID 2182 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:04:26 INFO - TEST-INFO | 2182: exit 0 19:04:26 INFO - Browser initialized. 19:04:26 INFO - Running cycle 1/1 for dromaeo_css test... 19:04:26 INFO - TEST-INFO | started process 2184 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpfmkMvZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:04:38 INFO - PID 2184 | RSS: Main: 225591296 19:04:38 INFO - PID 2184 | 19:07:42 INFO - PID 2184 | Cycle 1(1): loaded http://localhost:57452/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57452/tests/dromaeo/cssquery-ext.html) 19:07:44 INFO - PID 2184 | RSS: Main: 400150528 19:07:44 INFO - PID 2184 | 19:09:27 INFO - PID 2184 | ************************* 19:09:27 INFO - PID 2184 | A coding exception was thrown and uncaught in a Task. 19:09:27 INFO - PID 2184 | 19:09:27 ERROR - PID 2184 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:09:27 INFO - PID 2184 | Full stack: 19:09:27 INFO - PID 2184 | ************************* 19:10:47 INFO - PID 2184 | Cycle 1(1): loaded http://localhost:57452/tests/dromaeo/cssquery-ext.html (next: http://localhost:57452/tests/dromaeo/cssquery-jquery.html) 19:10:48 INFO - PID 2184 | RSS: Main: 365154304 19:10:48 INFO - PID 2184 | 19:13:51 INFO - PID 2184 | Cycle 1(1): loaded http://localhost:57452/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57452/tests/dromaeo/cssquery-mootools.html) 19:13:51 INFO - PID 2184 | RSS: Main: 326381568 19:13:51 INFO - PID 2184 | 19:16:54 INFO - PID 2184 | Cycle 1(1): loaded http://localhost:57452/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57452/tests/dromaeo/cssquery-prototype.html) 19:16:54 INFO - PID 2184 | RSS: Main: 333160448 19:16:54 INFO - PID 2184 | 19:19:58 INFO - PID 2184 | Cycle 1(1): loaded http://localhost:57452/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57452/tests/dromaeo/cssquery-yui.html) 19:19:59 INFO - PID 2184 | RSS: Main: 337084416 19:19:59 INFO - PID 2184 | 19:23:02 INFO - PID 2184 | Cycle 1(1): loaded http://localhost:57452/tests/dromaeo/cssquery-yui.html (next: http://localhost:57452/tests/dromaeo/cssquery-dojo.html) 19:23:03 INFO - PID 2184 | RSS: Main: 422494208 19:23:03 INFO - PID 2184 | 19:23:03 INFO - PID 2184 | __start_tp_report 19:23:03 INFO - PID 2184 | _x_x_mozilla_page_load 19:23:03 INFO - PID 2184 | _x_x_mozilla_page_load_details 19:23:03 INFO - PID 2184 | |i|pagename|runs| 19:23:03 INFO - PID 2184 | |0;dojo.html;3363.2937083212523;3375.6118046424667;3393.947876158393;3431.4338134207865;3437.86248550058;5823.767049318033;5952.166696662471;6010.909836352458;6019.699015049252;6071.089336599507;5917.852053698649;5986.07215881538;6043.1539584458105;6075.726592303346;6091.26904771427;5232.241325007872;5315.229291752694;5316.415194328621;5334.786608535674;5372.623916325859;5451.972740136293;5467.261919640857;5477.835664930059;5481.780728770845;5513.2005859150395;5277.973610131925;5297.894042119175;5337.226102215157;5389.8113566025195;5398.6220964532495;5330.413654498002;5382.381026182;5416.458354164592;5452.291202143736;5461.344638643349;5291.153415453509;5323.893522129536;5347.304850369427;5354.678719276817;5366.543843773284;5962.165296858443;5973.581849270553;6010.459058684695;6013.428724271187;6018.789342373039;6116.847078823021;6119.3197658210165;6126.426068710472;6203.069539569055;6274.215723034621;6268.028455589391;6317.557770956035;6329.746810127589;6331.113644089831;6342.87314253717;5903.76384944606;6053.51571874249;6066.332703402622;6070.939290607082;6090.095278761139;6172.4136207060255;6228.408301211378;6396.232452105777;6410.1987251593555;6506.707198176094;5577.912307100077;6220.906686399708;6267.71795269214;6279.215098112736;6282.277538083179;6272.843178920472;6287.559870809091;6289.937100628935;6301.936980630135;6313.494920406357;6171.105189747551;6187.791466555286;6258.593191442542;6260.561760676709;6262.968685156545;6169.383061693885;6219.440250377488;6286.937130628727;6297.653629050446;6299.779507717208;5116.437191908887;5126.641135120581;5134.922976155361;5136.229565565195;5179.948200518022;4575.17646823575;4579.061292435043;4579.977100114478;4592.311153327028;4619.745913974696;5372.677639341652;5451.591130665216;5462.289902312754;5477.315335583052;5532.30846144232;6183.783567575113;6212.4408803207025;6224.128621992924;6244.438000579969;6248.750049997949;5515.172724091338;5518.613697041249;5518.972405138029;5526.281583394133;5555.083411237181;5285.445028272053;5444.482774136451;5445.101558242845;5448.210009548593;5456.781728730885;6210.192674952317;6310.7791227306825;6450.451711604566;6496.70764815575;6534.901976470262;6076.8784624308155;6195.101710251898;6234.314225435108;6245.500359971101;6253.124562561154;5764.510016648632;6326.272478665012;6443.065755465525;6468.191476065492;6529.771457998947;6256.280527739186;6268.780592679417;6287.371262873676;6292.056191571301;6298.968505157628;6125.509959203164;6188.2883468399905;6268.373162683695;6271.278802937538;6272.6236425814595;6119.07606531266;6144.1398204250545;6191.535634827496;6197.783077592263;6223.564350495603;6209.2548894133;6221.129041934223;6233;6240.7503699851495;6253.218347706536;6097.817065488042;6109;6110.052941794029;6114.847128821815;6133.570650054453;6064.818055458343;6122.020476723703;6129.540284478771;6169.413905678954;6277.372262773686;6002.249718785152;6058.606190597597;6062.636241825505;6072.848178795565;6079.665618390854 19:23:03 INFO - PID 2184 | |1;ext.html;711.4699548836114;715.0775499605509;783.7648705388384;852.7356519478958;864.2006144316506;24255.878720606393;27364.042258520956;27366.04218852338;27396.17811465654;27413.72586274139;35719.10702232445;36196.81901590495;36196.9140925772;36225.275494490095;36298;9021.278297736199;9210.263178945701;9220.585073671667;9229.584668689926;9261.53692315385;7185.317394847507;9049.819003619923;9200.585973631203;9202.539873006357;9208.079192080806;7398.297161769623;10621.362718236893;10840.566377344896;10841.566337346496;10867;10967.616133435331;11037.392943388111;11052.281601695864;11057.004869561779;11061.834072488919;9225.584848681825;10697.272195590152;10756.623518176904;10794.622188223375;10844.511996960076;25276.873615631986;25615;25667.486650267077;25709.10018149356;25761.227163185133;3682.4476328550663;3735.962640373589;3784.7539909905768;3822.503074600312;3864.265789499986;27080.32299192516;27590.724092759017;27681.584776228374;27700.584491232647;27761.305967350978;3073.5082386818226;3160.1625569224175;3176.8411579420936;3218.388506183841;3260.6468315648976;280184;282293.1770682308;283255;283367;284095;52793.472065279624;52985.735071325165;53041.40875773733;53069.673258168084;53121;55380;55390.44609553934;55605.165922511194;55744.72127639336;55792.442075579536;14841.332140053724;15016.174110424032;15019.849801501845;15030.17334046616;15032.473863414729;12015.219010764273;12064.879351206375;12067.75864482723;12071.39643017863;12115.575954841539;11737.706557336134;11771.646850594496;11891.70270743221;14204.005719599529;14224.85775142256;5056.266841308064;6073.331933487313;6100.145979562864;6103.3591472894705;6124.234470691164;823.56762699582;919.8528235482424;929.4144688845984;947.393668052447;989.2531138990161;27019.72980270172;27137.728622713916;27269.590956135675;27548.17355479339;27793.722062779114;983.3559018842669;1022.7903279827617;1059.0838924330553;1073.608133031438;1074.3392813419691;13467.595972120853;13917.652058698412;14182.007259491736;14204.64488387778;14233.359498822578;485247;489354;489712;490027;490488;53794.46205537894;54065.45934540683;54166.72916635471;54322.91354172894;54328.72835635796;1361.142480237444;1439.0861802755117;1440.3302464354126;1442.1923722715312;1457.9927100364641;25183.118590849233;26383.736162638128;26448.8677556611;26569.33576660599;26626.467470650867;42723.7863810679;46590.30114548352;47237;47428;47553.524464756294;473936.6303168462;475665;475819;475963;476507;34232.26141908691;34236;34249.97250082502;34344.65655343414;34465.553444655336;43396.783016084715;44094.559054409045;44966;45031.099378012914;45361.09277814491;35812.87504104877;36662.26675466529;37190.25619487649;37393.43909841409;38887.80556097201;35709.82145089258;36830.63169368272;36903.26193476169;37946;40120.598794012854;38537.80731096439;38587.035324116;38865;39282.01794955149;39396.01509962274;33170.83414583008;34285;34797;34850.9544713659;35043.82478087593;25630.615540766532;25749.871250643628;25829.870850645628;26240.475190496465;26293.34266643349 19:23:03 INFO - PID 2184 | |2;jquery.html;385.0931057359919;398.2294260605726;417.39269363076716;419.7586387826999;431.15493632480354;13299.268540230283;15273.465428709997;21399;21482.785172148273;21564.382671299656;20538.17847286107;21167;21620.459488512795;22327.33018009458;22592.322230333077;6697.564658297195;6806.591604503746;6862.897056544156;6959.338862808025;6961.373476387124;3592.8562857485667;4357.847475338363;4489.708168969023;6841.93158068418;6954.965225173867;4459;4498.190325741365;7956.085050219241;7958.442908996372;8010.279074883259;7673.693052277902;7932.563708996003;7953.5227886327;7978.680852765911;8075.192480751878;7460.403167746567;7602.809929751746;7794.883076753853;7821.452498325119;7824.608769561556;22484.775152248596;22726.204582839688;27635.723642763514;28078.298042548897;28234.29414264639;2733.1117386849355;2866.928326791826;2917.3290143266954;2923.079230042551;2933.06142034549;16095.758563621555;16730.74903876443;16731.916340418342;16930.322787088626;17636.559086022822;1924.980750192494;2119.5760847830343;2142.924997625076;2143.6034333648327;2146.323907969;135939.96090058755;160885;163748.18125909413;165532;169269;17389.826101739072;20245.14116612032;21300;21866.562668746537;21967.560648787254;32060.679393206236;36550;36982.63017369845;37133.628663713556;37285;8933.73198804024;10489.632862849763;10909.83635245472;10946.288491248044;11152.944235278772;8704.738857834149;8710.651573936972;8751.387402881737;8903.777405564782;8907.866382004275;10408.291737507658;10681.252312338062;10862.78274434507;10864.881348137196;10866.446385099496;3339.4471570719734;3913.491246138041;4027.8791636250958;4143.502779666459;4161.375793630979;854.6965827131403;1000.7898341348398;1002.9849552256723;1018.4551265073151;1028.4343611013912;21217.18211008733;22541.774582254297;22779.974901129488;22864.885675571517;22877.656835147154;891.7681402835309;998.5456617239139;1021.5198856537415;1029.1766586730735;1029.7785976015193;10362.689119326433;10748.193885458622;11791.702912679599;11846.526138954518;11872.287662740264;609504;678396;690024;691693;709893;106156;145093.8235926462;148763.51236487713;150802;151133;1118.59730497021;1142.3431526872082;1167.7022359298326;1168.4975460551875;1178.505027888289;15650.843491564938;19874.801251987294;19931.60136797285;19989.800101998793;20050.197992080153;48278.517214828804;58561.4143858556;59870.70064649649;61146.38853611407;62112;65022.02466963094;86823;88122;89158;89715.65426518738;11545.711357216136;11648.301101933912;12196.268223906594;12486.562970295996;12554.686132846751;13793.655158620713;13927.791083133963;13942.58172254834;14269.571912842632;14273.714525709634;11016.834747478633;11541;11627.6511704649;11753.236039657737;11923.403829808649;11410.657680269605;11546.307221566733;11623.709407264549;11809.586664466702;11955.880441195477;9901.55443005081;11458.598949037078;11979.161458697807;11984.340861252715;12059.879401205875;11435.199536032398;12224.572139975058;12290.938545307215;12327.506899724269;12385.442655080362;10084.848727269244;10133.13868321201;10266.870644228979;11072.169587281147;11458.255213411101 19:23:03 INFO - PID 2184 | |3;mootools.html;1573.6537961648432;1578.9526314210564;1597.704424681434;1611.1702473226287;1658.8258232885546;10695.78608427831;11139.665810025692;11182.496787644555;11198.888011119887;11227.326360418381;10733.624323148691;11208.943955280212;11225;11225.831612525819;11231.887681123208;2351.329870986765;2394.676718642987;2398.0767404549288;2400.603900356439;2401.735809061002;2344.2146880794953;2373.098222675381;2375.0737212487143;2382.9285121446383;2383.8331316807744;2051.1180192517213;2348.941276468085;2355.9764402355927;2362.574736547421;2381.297517232412;2303.1593468384085;2316.2587971849016;2328.732195797488;2331.5336932613377;2333.9066437342485;2295.5064661097945;2353.5645905507536;2357.1867705641525;2359.8702071386065;2360.917367892133;11127.332360058423;11231.21381503295;11231.550737970552;11240.718982025433;11294.152938529562;5580.832575022756;5596.2165296858475;5915.763369465216;5918.733656985446;5933.465988061095;3088.9382212355854;3183.8567264473154;3338.6327503974544;3596.9029446018953;3694.242680250542;1109.4951796932457;1175.5650409348596;1233.8951189148934;1236.2211806561897;1241.1808206583612;13584.864151358459;14090.788638170436;14167.716645667131;15406.614834629112;15445.459408920746;3646.635336466385;4558.111168322212;4562.498125206291;4686.133065382915;4697.718136911796;9490.478023708762;10470.790584188426;11433.314001159957;11449.370284634426;11474.36890970988;4828.396450443694;5000.974995125074;5289.2330612061805;5725.2843394575675;5745.310562732415;4551.772411379484;5298.28473156119;5326.147816349366;5334.226537152092;5334.706591137525;2856.3858770364473;3180.6183258008723;3372.1738174147;3396.592408910897;3413.675700808419;1017.6183931025865;1040.6877936618985;1052.752603138262;1053.957841686324;1059.6926891201465;760.6462994707488;773.5320131320583;790.2334735306744;804.8430556041516;809.1503920883049;6390.968045159744;6518.837029074311;6638.568493048033;6658.966705166443;6687.933120668828;850.9278309330289;936.9812603747887;993.5479356892597;1011.6813203840767;1029.2126523209752;3972.324704800191;4001.15975645112;4127.236461254677;4136.875893723193;4182.811773470201;13244.867551324556;13732.931335343259;13752.587422377344;13791.448342066205;13794.310284485937;11590.420478976017;13650.180989140683;13672.589822305346;13706;13716.588502344946;9416.717498475056;9641.27690423221;9871;9887.406755594831;9929.25530585209;6303.9684801575695;6630.83422914431;6695.966520167368;6837.62393068386;6949.3745562899585;11357.204995650225;11808;12364.134510584172;12368.814467782811;12376.75246495047;10545.420001899969;10881.793673883782;11959.222650527689;12007.879921201025;12040.277583345027;8929.598168082322;8981.236594889508;8995.775105622412;9169.954150229472;9173.54132293396;10049;10220;10221.080102790784;10228.48857557134;10230.795384092127;8673.653053877773;8956.776080598038;8996.910030899608;9013.18881300686;9076.954615226881;8720.869186962074;8753.562321884008;8812.339074569305;8851.159139881702;8863.113688631085;7790.1041380241995;7841.490303130278;7872.252136047066;7883.605819708877;7890.526568405914;5769.509591684754;5908.172855800105;5942.881142377215;5992.101184822312;6022.518198544193;5360.356757189163;5772.19189313488;5812.7674893003805;5888.852778680567;5941.257342832146 19:23:03 INFO - PID 2184 | |4;prototype.html;365.1564885115384;365.8591442294716;371.4001886952572;374.4925625777072;380.3609935308682;5621.7751289948355;5663.2160869326135;5726.3414707308675;5784.652920824754;5832.783542253943;5121.027004869082;5551.2529042896085;5735.913961290574;5751.482366587006;5761.366249712528;3975.681945444372;3997.3204555225534;4022.4368588397574;4587.931181032287;4844.66087373884;4792.137415265268;4795.482371754839;4802.871325238566;4816.951830481703;4832.444268909086;4024.3963405489117;4377.868663940071;4787.688800227974;4820.517948205186;4825.831095911643;3992.2614316351423;4167.416561681367;4278.336857787017;4736.83421080264;4822.5900798432;4347.521772605042;4349.826006959718;4349.956500434987;4387.210302145612;4387.881090321979;5650.858728531778;5655;5672;5674.3190817101795;5681.34664513578;4291.463567054118;4707.7289131934185;5526.50261476469;5565.916511252334;5572.359178694421;5533.422974452262;5789.305283365981;6236.253848922309;6254.8123556293385;6266.968665156645;4302.870913872589;4429.7785110744335;4569.840055598072;4777.641676874214;4954.677945933503;5284.39229488606;6080.543959203077;6267.2479302484;6424.614523128627;6535.738570457176;4876.4879687633;5009.897822479049;5030.346055012825;5032.867604788967;5045.217991211368;4963.528464795839;5154.381474223117;5172.844814655567;5174.223866420067;5192.209686928488;5248.737563121828;5468.781248750005;5512.200730893998;5541.9168712469345;5557.3331200256225;5235.267062611238;6081.814046260936;6134.509239260938;6155.322914479404;6191.690415479208;1545.6754081642755;1669.8246684098237;1738.3220543987854;1768.487138729754;1784.518180091368;1270.9173903696415;1271.9046071544672;1283.657325381183;1311.9803202951964;1322.7023919618202;5493.2034854945805;5524.889502209933;5526.889462210734;5544.556435485232;5550.972245138749;4765.785539650724;4983.8504844854715;6054.969725151346;6073.14975903365;6283.434490895841;5342.54588359986;5483.177523371526;5503.3120859892515;5512.39363669996;5528.695921724263;2990.775691823122;3247.8863239786965;3268.509723541488;3270.6917233106474;3293.226091868409;6309.463695585927;6603.702833372414;6648.767293144717;6669.599824010575;6715.932840671629;6435;6508.381703738138;6528.477721782246;6547.5416720830035;6559.7376104955265;5509.338879334506;5991.58058935879;6183.196184495987;6525.706343214567;6608.537402381787;6049.78825741097;6169.691515424301;6185.41238582334;6269.811905642838;6337.334579869232;5992.280926288873;6159.507239420746;6202.317745048132;6272.466840318624;6320.598172694346;5377.838664840061;5640.746166422438;5964.463198312173;6096.603720758137;6349.396807303298;4277.65778737694;4727.054589082129;4977.751112444435;5000.999800040079;5006.5994720423005;5317.441668624739;6005.567745063257;6315.336889626523;6397.584157029778;6398.712057957497;4873.342098816614;6202.875942481035;6208.658523781055;6230.112543646392;6262.906056409249;4936.037472692934;4973.88087680269;5617.382087970238;5757.625754325955;6091.634501929899;5770.567207459373;6027.969860150672;6035;6062.333143354315;6063.848403789941;4944.184209605375;6130.811977771445;6197.388678943417;6218.751249949952;6241.500679945684;5917.467427931507;5977.790777322773;5997.400259973968;6005.339412664691;6009.639421634716 19:23:03 INFO - PID 2184 | |5;yui.html;711.6726305899286;716.3061193150013;734.6877577029765;784.7567254151213;837.4347315561996;15094.16982065986;16006.519804405872;16018.519444416657;16022.839771602281;16077.356905723771;14133.363998620061;14784.6303842404;14791.112533247986;15097.698046039073;15300.846991530081;912.4616476278994;955.2262667239559;956.7512446763822;957.4351132831628;958.5542722633974;825.628467189764;935.4200395754642;938.7981583959447;942.6606421688186;943.8395472769646;1001.2390583156816;1006.3106771861262;1010.1363334349136;1010.2877471382694;1015.7257540464108;1009.6062535611118;1009.8333774927128;1010.3836659637615;1010.8079464901682;1012.6253286284121;746.045062320231;746.2612014105996;748.1919526910923;748.4685873030155;748.7080038784878;16316.184190790413;16414.67170656592;16714.247858846382;16788.916055419766;16848.241829117596;12579.811302830465;14814.851851481455;14831.258437078102;14875.404983800636;15078.321475533627;11574.942125289404;11704.707382315424;11726.296422214695;11745.765084698343;12206.938965305206;3773.9433908491396;3792.1846802937225;3889.7860617666015;3919.941200881989;3928.8821335359985;111474;113164;113480.43259783731;114039;115010.27484587739;11229.14719071344;11567.942160289313;11633;11790.499877640053;11977.940110299567;24534.87732561326;24858.751412485643;24894.004239830203;24896.253112406655;25038.248852534452;7792.688292468238;7872.803179920548;7874.960625196837;7942.166072562413;8108.918910810934;4238.660907127422;4244.063363747186;4295.72077814941;4365.563443655609;4437.844675436344;3449.2753623188405;3499.9300013999577;3519.04985653872;3534.169470174507;3536.0982949347754;546.0880329849161;598.4793229889937;611.0437165835453;615.4922189193933;629.134939458245;573.4494884910449;623.1151764494429;656.5273003437518;688.3254410677564;713.350850725837;9947.303688741718;10140;10192.031756983075;10530.31552949056;10554.736131596617;660.9615250817501;697.2365260040248;712.6792943175592;713.3864876206459;723.9312265334785;4777.641676874248;4941.827036053721;4942.629302802305;4946.060248552763;4946.703197808143;91471;93011;94035;104892;106467.35326467291;82512;89927.55036224908;89950.10049899417;90511.7590592751;91275;78436.6078169617;80002;80053;80192.59903700445;80493.19506804974;9352.625894964398;9549.856752148862;9627.547785803685;9647.324687272105;9664.516774161124;50397;51842.48157518377;52243.73878130585;52507.73746131245;53177.46822531725;66898.3310166892;67375;67724.3227567718;67896;68142;11785.116116291483;11788.882111179122;11847.111466639864;11876;12224.938875305566;10994.395308258123;12469.251844889335;12708.173968692005;12994.350282486026;13175.14361566495;11582.362970036393;11594.130440216848;11608.709782255512;12274.570390036306;12288.508459661514;11685.415729213335;11769.646910592353;12207.75584488323;12259.448324825225;12456.43946022413;11486.942565287454;11612.780658030784;11657.708557286136;11753.412329383667;12370;10076.445795481026;10309.463119324446;10550.261481696207;10556.788864222826;11328.394469271949;8576.65693372283;9103.635854565744;9911.900880991387;10009.792079847619;10139.2395570334 19:23:03 INFO - PID 2184 | __end_tp_report 19:23:03 INFO - PID 2184 | __start_cc_report 19:23:03 INFO - PID 2184 | _x_x_mozilla_cycle_collect,1992 19:23:03 INFO - PID 2184 | __end_cc_report 19:23:03 INFO - PID 2184 | __startTimestamp1490062983198__endTimestamp 19:23:03 INFO - PID 2184 | 19:23:03 INFO - PID 2184 | ------- Summary: start ------- 19:23:03 INFO - PID 2184 | Number of tests: 6 19:23:03 INFO - PID 2184 | 19:23:03 INFO - PID 2184 | [#0] dojo.html Cycles:165 Average:5834.37 Median:6090.10 stddev:622.63 (10.2%) stddev-sans-first:593.59 19:23:03 INFO - PID 2184 | Values: 3363.3 3375.6 3393.9 3431.4 3437.9 5823.8 5952.2 6010.9 6019.7 6071.1 5917.9 5986.1 6043.2 6075.7 6091.3 5232.2 5315.2 5316.4 5334.8 5372.6 5452.0 5467.3 5477.8 5481.8 5513.2 5278.0 5297.9 5337.2 5389.8 5398.6 5330.4 5382.4 5416.5 5452.3 5461.3 5291.2 5323.9 5347.3 5354.7 5366.5 5962.2 5973.6 6010.5 6013.4 6018.8 6116.8 6119.3 6126.4 6203.1 6274.2 6268.0 6317.6 6329.7 6331.1 6342.9 5903.8 6053.5 6066.3 6070.9 6090.1 6172.4 6228.4 6396.2 6410.2 6506.7 5577.9 6220.9 6267.7 6279.2 6282.3 6272.8 6287.6 6289.9 6301.9 6313.5 6171.1 6187.8 6258.6 6260.6 6263.0 6169.4 6219.4 6286.9 6297.7 6299.8 5116.4 5126.6 5134.9 5136.2 5179.9 4575.2 4579.1 4580.0 4592.3 4619.7 5372.7 5451.6 5462.3 5477.3 5532.3 6183.8 6212.4 6224.1 6244.4 6248.8 5515.2 5518.6 5519.0 5526.3 5555.1 5285.4 5444.5 5445.1 5448.2 5456.8 6210.2 6310.8 6450.5 6496.7 6534.9 6076.9 6195.1 6234.3 6245.5 6253.1 5764.5 6326.3 6443.1 6468.2 6529.8 6256.3 6268.8 6287.4 6292.1 6299.0 6125.5 6188.3 6268.4 6271.3 6272.6 6119.1 6144.1 6191.5 6197.8 6223.6 6209.3 6221.1 6233.0 6240.8 6253.2 6097.8 6109.0 6110.1 6114.8 6133.6 6064.8 6122.0 6129.5 6169.4 6277.4 6002.2 6058.6 6062.6 6072.8 6079.7 19:23:03 INFO - PID 2184 | 19:23:03 INFO - PID 2184 | [#1] ext.html Cycles:180 Average:55532.16 Median:34947.39 stddev:113429.52 (324.6%) stddev-sans-first:113673.04 19:23:03 INFO - PID 2184 | Values: 711.5 715.1 783.8 852.7 864.2 24255.9 27364.0 27366.0 27396.2 27413.7 35719.1 36196.8 36196.9 36225.3 36298.0 9021.3 9210.3 9220.6 9229.6 9261.5 7185.3 9049.8 9200.6 9202.5 9208.1 7398.3 10621.4 10840.6 10841.6 10867.0 10967.6 11037.4 11052.3 11057.0 11061.8 9225.6 10697.3 10756.6 10794.6 10844.5 25276.9 25615.0 25667.5 25709.1 25761.2 3682.4 3736.0 3784.8 3822.5 3864.3 27080.3 27590.7 27681.6 27700.6 27761.3 3073.5 3160.2 3176.8 3218.4 3260.6 280184.0 282293.2 283255.0 283367.0 284095.0 52793.5 52985.7 53041.4 53069.7 53121.0 55380.0 55390.4 55605.2 55744.7 55792.4 14841.3 15016.2 15019.8 15030.2 15032.5 12015.2 12064.9 12067.8 12071.4 12115.6 11737.7 11771.6 11891.7 14204.0 14224.9 5056.3 6073.3 6100.1 6103.4 6124.2 823.6 919.9 929.4 947.4 989.3 27019.7 27137.7 27269.6 27548.2 27793.7 983.4 1022.8 1059.1 1073.6 1074.3 13467.6 13917.7 14182.0 14204.6 14233.4 485247.0 489354.0 489712.0 490027.0 490488.0 53794.5 54065.5 54166.7 54322.9 54328.7 1361.1 1439.1 1440.3 1442.2 1458.0 25183.1 26383.7 26448.9 26569.3 26626.5 42723.8 46590.3 47237.0 47428.0 47553.5 473936.6 475665.0 475819.0 475963.0 476507.0 34232.3 34236.0 34250.0 34344.7 34465.6 43396.8 44094.6 44966.0 45031.1 45361.1 35812.9 36662.3 37190.3 37393.4 38887.8 35709.8 36830.6 36903.3 37946.0 40120.6 38537.8 38587.0 38865.0 39282.0 39396.0 33170.8 34285.0 34797.0 34851.0 35043.8 25630.6 25749.9 25829.9 26240.5 26293.3 19:23:03 INFO - PID 2184 | 19:23:03 INFO - PID 2184 | [#2] jquery.html Cycles:180 Average:40828.01 Median:11770.96 stddev:113364.39 (963.1%) stddev-sans-first:113641.73 19:23:03 INFO - PID 2184 | Values: 385.1 398.2 417.4 419.8 431.2 13299.3 15273.5 21399.0 21482.8 21564.4 20538.2 21167.0 21620.5 22327.3 22592.3 6697.6 6806.6 6862.9 6959.3 6961.4 3592.9 4357.8 4489.7 6841.9 6955.0 4459.0 4498.2 7956.1 7958.4 8010.3 7673.7 7932.6 7953.5 7978.7 8075.2 7460.4 7602.8 7794.9 7821.5 7824.6 22484.8 22726.2 27635.7 28078.3 28234.3 2733.1 2866.9 2917.3 2923.1 2933.1 16095.8 16730.7 16731.9 16930.3 17636.6 1925.0 2119.6 2142.9 2143.6 2146.3 135940.0 160885.0 163748.2 165532.0 169269.0 17389.8 20245.1 21300.0 21866.6 21967.6 32060.7 36550.0 36982.6 37133.6 37285.0 8933.7 10489.6 10909.8 10946.3 11152.9 8704.7 8710.7 8751.4 8903.8 8907.9 10408.3 10681.3 10862.8 10864.9 10866.4 3339.4 3913.5 4027.9 4143.5 4161.4 854.7 1000.8 1003.0 1018.5 1028.4 21217.2 22541.8 22780.0 22864.9 22877.7 891.8 998.5 1021.5 1029.2 1029.8 10362.7 10748.2 11791.7 11846.5 11872.3 609504.0 678396.0 690024.0 691693.0 709893.0 106156.0 145093.8 148763.5 150802.0 151133.0 1118.6 1142.3 1167.7 1168.5 1178.5 15650.8 19874.8 19931.6 19989.8 20050.2 48278.5 58561.4 59870.7 61146.4 62112.0 65022.0 86823.0 88122.0 89158.0 89715.7 11545.7 11648.3 12196.3 12486.6 12554.7 13793.7 13927.8 13942.6 14269.6 14273.7 11016.8 11541.0 11627.7 11753.2 11923.4 11410.7 11546.3 11623.7 11809.6 11955.9 9901.6 11458.6 11979.2 11984.3 12059.9 11435.2 12224.6 12290.9 12327.5 12385.4 10084.8 10133.1 10266.9 11072.2 11458.3 19:23:03 INFO - PID 2184 | 19:23:03 INFO - PID 2184 | [#3] mootools.html Cycles:180 Average:6599.76 Median:2629.06 stddev:4142.90 (157.6%) stddev-sans-first:4137.31 19:23:03 INFO - PID 2184 | Values: 1573.7 1579.0 1597.7 1611.2 1658.8 10695.8 11139.7 11182.5 11198.9 11227.3 10733.6 11208.9 11225.0 11225.8 11231.9 2351.3 2394.7 2398.1 2400.6 2401.7 2344.2 2373.1 2375.1 2382.9 2383.8 2051.1 2348.9 2356.0 2362.6 2381.3 2303.2 2316.3 2328.7 2331.5 2333.9 2295.5 2353.6 2357.2 2359.9 2360.9 11127.3 11231.2 11231.6 11240.7 11294.2 5580.8 5596.2 5915.8 5918.7 5933.5 3088.9 3183.9 3338.6 3596.9 3694.2 1109.5 1175.6 1233.9 1236.2 1241.2 13584.9 14090.8 14167.7 15406.6 15445.5 3646.6 4558.1 4562.5 4686.1 4697.7 9490.5 10470.8 11433.3 11449.4 11474.4 4828.4 5001.0 5289.2 5725.3 5745.3 4551.8 5298.3 5326.1 5334.2 5334.7 2856.4 3180.6 3372.2 3396.6 3413.7 1017.6 1040.7 1052.8 1054.0 1059.7 760.6 773.5 790.2 804.8 809.2 6391.0 6518.8 6638.6 6659.0 6687.9 850.9 937.0 993.5 1011.7 1029.2 3972.3 4001.2 4127.2 4136.9 4182.8 13244.9 13732.9 13752.6 13791.4 13794.3 11590.4 13650.2 13672.6 13706.0 13716.6 9416.7 9641.3 9871.0 9887.4 9929.3 6304.0 6630.8 6696.0 6837.6 6949.4 11357.2 11808.0 12364.1 12368.8 12376.8 10545.4 10881.8 11959.2 12007.9 12040.3 8929.6 8981.2 8995.8 9170.0 9173.5 10049.0 10220.0 10221.1 10228.5 10230.8 8673.7 8956.8 8996.9 9013.2 9077.0 8720.9 8753.6 8812.3 8851.2 8863.1 7790.1 7841.5 7872.3 7883.6 7890.5 5769.5 5908.2 5942.9 5992.1 6022.5 5360.4 5772.2 5812.8 5888.9 5941.3 19:23:03 INFO - PID 2184 | 19:23:03 INFO - PID 2184 | [#4] prototype.html Cycles:180 Average:5106.33 Median:5531.06 stddev:1438.95 (26.0%) stddev-sans-first:1398.29 19:23:03 INFO - PID 2184 | Values: 365.2 365.9 371.4 374.5 380.4 5621.8 5663.2 5726.3 5784.7 5832.8 5121.0 5551.3 5735.9 5751.5 5761.4 3975.7 3997.3 4022.4 4587.9 4844.7 4792.1 4795.5 4802.9 4817.0 4832.4 4024.4 4377.9 4787.7 4820.5 4825.8 3992.3 4167.4 4278.3 4736.8 4822.6 4347.5 4349.8 4350.0 4387.2 4387.9 5650.9 5655.0 5672.0 5674.3 5681.3 4291.5 4707.7 5526.5 5565.9 5572.4 5533.4 5789.3 6236.3 6254.8 6267.0 4302.9 4429.8 4569.8 4777.6 4954.7 5284.4 6080.5 6267.2 6424.6 6535.7 4876.5 5009.9 5030.3 5032.9 5045.2 4963.5 5154.4 5172.8 5174.2 5192.2 5248.7 5468.8 5512.2 5541.9 5557.3 5235.3 6081.8 6134.5 6155.3 6191.7 1545.7 1669.8 1738.3 1768.5 1784.5 1270.9 1271.9 1283.7 1312.0 1322.7 5493.2 5524.9 5526.9 5544.6 5551.0 4765.8 4983.9 6055.0 6073.1 6283.4 5342.5 5483.2 5503.3 5512.4 5528.7 2990.8 3247.9 3268.5 3270.7 3293.2 6309.5 6603.7 6648.8 6669.6 6715.9 6435.0 6508.4 6528.5 6547.5 6559.7 5509.3 5991.6 6183.2 6525.7 6608.5 6049.8 6169.7 6185.4 6269.8 6337.3 5992.3 6159.5 6202.3 6272.5 6320.6 5377.8 5640.7 5964.5 6096.6 6349.4 4277.7 4727.1 4977.8 5001.0 5006.6 5317.4 6005.6 6315.3 6397.6 6398.7 4873.3 6202.9 6208.7 6230.1 6262.9 4936.0 4973.9 5617.4 5757.6 6091.6 5770.6 6028.0 6035.0 6062.3 6063.8 4944.2 6130.8 6197.4 6218.8 6241.5 5917.5 5977.8 5997.4 6005.3 6009.6 19:23:03 INFO - PID 2184 | 19:23:03 INFO - PID 2184 | [#5] yui.html Cycles:180 Average:20600.51 Median:3526.61 stddev:29849.28 (846.4%) stddev-sans-first:29895.66 19:23:03 INFO - PID 2184 | Values: 711.7 716.3 734.7 784.8 837.4 15094.2 16006.5 16018.5 16022.8 16077.4 14133.4 14784.6 14791.1 15097.7 15300.8 912.5 955.2 956.8 957.4 958.6 825.6 935.4 938.8 942.7 943.8 1001.2 1006.3 1010.1 1010.3 1015.7 1009.6 1009.8 1010.4 1010.8 1012.6 746.0 746.3 748.2 748.5 748.7 16316.2 16414.7 16714.2 16788.9 16848.2 12579.8 14814.9 14831.3 14875.4 15078.3 11574.9 11704.7 11726.3 11745.8 12206.9 3773.9 3792.2 3889.8 3919.9 3928.9 111474.0 113164.0 113480.4 114039.0 115010.3 11229.1 11567.9 11633.0 11790.5 11977.9 24534.9 24858.8 24894.0 24896.3 25038.2 7792.7 7872.8 7875.0 7942.2 8108.9 4238.7 4244.1 4295.7 4365.6 4437.8 3449.3 3499.9 3519.0 3534.2 3536.1 546.1 598.5 611.0 615.5 629.1 573.4 623.1 656.5 688.3 713.4 9947.3 10140.0 10192.0 10530.3 10554.7 661.0 697.2 712.7 713.4 723.9 4777.6 4941.8 4942.6 4946.1 4946.7 91471.0 93011.0 94035.0 104892.0 106467.4 82512.0 89927.6 89950.1 90511.8 91275.0 78436.6 80002.0 80053.0 80192.6 80493.2 9352.6 9549.9 9627.5 9647.3 9664.5 50397.0 51842.5 52243.7 52507.7 53177.5 66898.3 67375.0 67724.3 67896.0 68142.0 11785.1 11788.9 11847.1 11876.0 12224.9 10994.4 12469.3 12708.2 12994.4 13175.1 11582.4 11594.1 11608.7 12274.6 12288.5 11685.4 11769.6 12207.8 12259.4 12456.4 11486.9 11612.8 11657.7 11753.4 12370.0 10076.4 10309.5 10550.3 10556.8 11328.4 8576.7 9103.6 9911.9 10009.8 10139.2 19:23:03 INFO - PID 2184 | -------- Summary: end -------- 19:23:03 INFO - PID 2184 | 19:23:03 INFO - TEST-INFO | 2184: exit 0 19:23:04 INFO - TEST-OK | dromaeo_css | took 1121304ms 19:23:04 INFO - TEST-START | kraken 19:23:04 INFO - operating with platform_type : mac_ 19:23:04 INFO - Initialising browser for kraken test... 19:23:04 INFO - TEST-INFO | started process 2188 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpBZr7nc/profile http://localhost:57452/getInfo.html) 19:23:06 INFO - PID 2188 | __metrics Screen width/height:1600/1200 19:23:06 INFO - PID 2188 | colorDepth:24 19:23:06 INFO - PID 2188 | Browser inner width/height: 1024/689 19:23:06 INFO - PID 2188 | __metrics 19:23:06 INFO - PID 2188 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:23:06 INFO - PID 2188 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:23:07 INFO - TEST-INFO | 2188: exit 0 19:23:07 INFO - Browser initialized. 19:23:07 INFO - Running cycle 1/1 for kraken test... 19:23:07 INFO - TEST-INFO | started process 2189 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpBZr7nc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:23:19 INFO - PID 2189 | RSS: Main: 224964608 19:23:19 INFO - PID 2189 | 19:23:22 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:57452/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57452/tests/kraken/driver.html?testName=audio-beat-detection) 19:23:23 INFO - PID 2189 | RSS: Main: 284143616 19:23:23 INFO - PID 2189 | 19:23:25 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:57452/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57452/tests/kraken/driver.html?testName=audio-dft) 19:23:26 INFO - PID 2189 | RSS: Main: 287600640 19:23:26 INFO - PID 2189 | 19:23:29 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:57452/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57452/tests/kraken/driver.html?testName=audio-fft) 19:23:30 INFO - PID 2189 | RSS: Main: 378290176 19:23:30 INFO - PID 2189 | 19:23:32 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:57452/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57452/tests/kraken/driver.html?testName=audio-oscillator) 19:23:33 INFO - PID 2189 | RSS: Main: 281890816 19:23:33 INFO - PID 2189 | 19:23:35 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:57452/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57452/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:23:35 INFO - PID 2189 | RSS: Main: 285388800 19:23:35 INFO - PID 2189 | 19:23:38 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:57452/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57452/tests/kraken/driver.html?testName=imaging-darkroom) 19:23:39 INFO - PID 2189 | RSS: Main: 326823936 19:23:39 INFO - PID 2189 | 19:23:42 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:57452/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57452/tests/kraken/driver.html?testName=imaging-desaturate) 19:23:43 INFO - PID 2189 | RSS: Main: 345161728 19:23:43 INFO - PID 2189 | 19:23:46 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:57452/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57452/tests/kraken/driver.html?testName=json-parse-financial) 19:23:46 INFO - PID 2189 | RSS: Main: 359993344 19:23:46 INFO - PID 2189 | 19:23:48 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:57452/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57452/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:23:49 INFO - PID 2189 | RSS: Main: 304754688 19:23:49 INFO - PID 2189 | 19:23:50 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:57452/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57452/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:23:51 INFO - PID 2189 | RSS: Main: 307179520 19:23:51 INFO - PID 2189 | 19:23:53 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:57452/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57452/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:23:54 INFO - PID 2189 | RSS: Main: 308822016 19:23:54 INFO - PID 2189 | 19:23:57 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:57452/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57452/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:23:58 INFO - PID 2189 | RSS: Main: 327061504 19:23:58 INFO - PID 2189 | 19:24:01 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:57452/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57452/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:24:01 INFO - PID 2189 | RSS: Main: 320294912 19:24:01 INFO - PID 2189 | 19:24:03 INFO - PID 2189 | Cycle 1(1): loaded http://localhost:57452/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57452/tests/kraken/driver.html?testName=ai-astar) 19:24:03 INFO - PID 2189 | RSS: Main: 382230528 19:24:03 INFO - PID 2189 | 19:24:03 INFO - PID 2189 | __start_tp_report 19:24:03 INFO - PID 2189 | _x_x_mozilla_page_load 19:24:03 INFO - PID 2189 | _x_x_mozilla_page_load_details 19:24:03 INFO - PID 2189 | |i|pagename|runs| 19:24:03 INFO - PID 2189 | |0;ai-astar;114;116;116;113;113;116;114;115;116;116 19:24:03 INFO - PID 2189 | |1;audio-beat-detection;150;113;113;149;111;110;117;112;134;110 19:24:03 INFO - PID 2189 | |2;audio-dft;189;186;184;186;187;199;260;199;187;186 19:24:03 INFO - PID 2189 | |3;audio-fft;81;57;64;90;58;58;75;77;107;82 19:24:03 INFO - PID 2189 | |4;audio-oscillator;87;71;89;70;71;70;83;70;70;84 19:24:03 INFO - PID 2189 | |5;imaging-gaussian-blur;89;89;88;89;88;89;89;89;90;90 19:24:03 INFO - PID 2189 | |6;imaging-darkroom;96;97;97;97;96;95;102;93;137;120 19:24:03 INFO - PID 2189 | |7;imaging-desaturate;85;86;86;87;86;86;84;87;83;86 19:24:03 INFO - PID 2189 | |8;json-parse-financial;51;49;82;96;92;84;62;63;63;61 19:24:03 INFO - PID 2189 | |9;json-stringify-tinderbox;53;55;64;71;65;61;57;59;59;59 19:24:03 INFO - PID 2189 | |10;stanford-crypto-aes;85;84;83;83;84;83;81;83;83;82 19:24:03 INFO - PID 2189 | |11;stanford-crypto-ccm;140;141;143;128;146;148;143;138;173;180 19:24:03 INFO - PID 2189 | |12;stanford-crypto-pbkdf2;191;189;187;189;188;175;185;185;183;185 19:24:03 INFO - PID 2189 | |13;stanford-crypto-sha256-iterative;67;69;67;68;68;69;67;69;68;68 19:24:03 INFO - PID 2189 | __end_tp_report 19:24:03 INFO - PID 2189 | __start_cc_report 19:24:03 INFO - PID 2189 | _x_x_mozilla_cycle_collect,2160 19:24:03 INFO - PID 2189 | __end_cc_report 19:24:03 INFO - PID 2189 | __startTimestamp1490063043959__endTimestamp 19:24:03 INFO - PID 2189 | 19:24:03 INFO - PID 2189 | ------- Summary: start ------- 19:24:03 INFO - PID 2189 | Number of tests: 14 19:24:03 INFO - PID 2189 | 19:24:03 INFO - PID 2189 | [#0] ai-astar Cycles:10 Average:114.90 Median:116.00 stddev:1.29 (1.1%) stddev-sans-first:1.32 19:24:03 INFO - PID 2189 | Values: 114.0 116.0 116.0 113.0 113.0 116.0 114.0 115.0 116.0 116.0 19:24:03 INFO - PID 2189 | 19:24:03 INFO - PID 2189 | [#1] audio-beat-detection Cycles:10 Average:121.90 Median:115.00 stddev:16.17 (14.1%) stddev-sans-first:13.58 19:24:03 INFO - PID 2189 | Values: 150.0 113.0 113.0 149.0 111.0 110.0 117.0 112.0 134.0 110.0 19:24:03 INFO - PID 2189 | 19:24:03 INFO - PID 2189 | [#2] audio-dft Cycles:10 Average:196.30 Median:188.00 stddev:23.02 (12.2%) stddev-sans-first:24.26 19:24:03 INFO - PID 2189 | Values: 189.0 186.0 184.0 186.0 187.0 199.0 260.0 199.0 187.0 186.0 19:24:03 INFO - PID 2189 | 19:24:03 INFO - PID 2189 | [#3] audio-fft Cycles:10 Average:74.90 Median:76.00 stddev:16.20 (21.3%) stddev-sans-first:17.03 19:24:03 INFO - PID 2189 | Values: 81.0 57.0 64.0 90.0 58.0 58.0 75.0 77.0 107.0 82.0 19:24:03 INFO - PID 2189 | 19:24:03 INFO - PID 2189 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:77.00 stddev:8.13 (10.6%) stddev-sans-first:7.68 19:24:03 INFO - PID 2189 | Values: 87.0 71.0 89.0 70.0 71.0 70.0 83.0 70.0 70.0 84.0 19:24:03 INFO - PID 2189 | 19:24:03 INFO - PID 2189 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:89.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 19:24:03 INFO - PID 2189 | Values: 89.0 89.0 88.0 89.0 88.0 89.0 89.0 89.0 90.0 90.0 19:24:03 INFO - PID 2189 | 19:24:03 INFO - PID 2189 | [#6] imaging-darkroom Cycles:10 Average:103.00 Median:96.00 stddev:14.20 (14.8%) stddev-sans-first:14.84 19:24:03 INFO - PID 2189 | Values: 96.0 97.0 97.0 97.0 96.0 95.0 102.0 93.0 137.0 120.0 19:24:03 INFO - PID 2189 | 19:24:03 INFO - PID 2189 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:1.26 (1.5%) stddev-sans-first:1.32 19:24:03 INFO - PID 2189 | Values: 85.0 86.0 86.0 87.0 86.0 86.0 84.0 87.0 83.0 86.0 19:24:03 INFO - PID 2189 | 19:24:03 INFO - PID 2189 | [#8] json-parse-financial Cycles:10 Average:70.30 Median:72.50 stddev:16.81 (23.2%) stddev-sans-first:16.32 19:24:03 INFO - PID 2189 | Values: 51.0 49.0 82.0 96.0 92.0 84.0 62.0 63.0 63.0 61.0 19:24:03 INFO - PID 2189 | 19:24:03 INFO - PID 2189 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:5.25 (8.8%) stddev-sans-first:4.86 19:24:03 INFO - PID 2189 | Values: 53.0 55.0 64.0 71.0 65.0 61.0 57.0 59.0 59.0 59.0 19:24:03 INFO - PID 2189 | 19:24:03 INFO - PID 2189 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:1.10 (1.3%) stddev-sans-first:0.93 19:24:03 INFO - PID 2189 | Values: 85.0 84.0 83.0 83.0 84.0 83.0 81.0 83.0 83.0 82.0 19:24:03 INFO - PID 2189 | 19:24:03 INFO - PID 2189 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:144.50 stddev:16.04 (11.1%) stddev-sans-first:16.75 19:24:03 INFO - PID 2189 | Values: 140.0 141.0 143.0 128.0 146.0 148.0 143.0 138.0 173.0 180.0 19:24:03 INFO - PID 2189 | 19:24:03 INFO - PID 2189 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.70 Median:187.50 stddev:4.47 (2.4%) stddev-sans-first:4.31 19:24:03 INFO - PID 2189 | Values: 191.0 189.0 187.0 189.0 188.0 175.0 185.0 185.0 183.0 185.0 19:24:03 INFO - PID 2189 | 19:24:03 INFO - PID 2189 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 19:24:03 INFO - PID 2189 | Values: 67.0 69.0 67.0 68.0 68.0 69.0 67.0 69.0 68.0 68.0 19:24:03 INFO - PID 2189 | -------- Summary: end -------- 19:24:03 INFO - PID 2189 | 19:24:04 INFO - TEST-INFO | 2189: exit 0 19:24:04 INFO - TEST-OK | kraken | took 60897ms 19:24:04 INFO - SUITE-END | took 1182s 19:24:05 INFO - Completed test suite (00:19:42) 19:24:05 INFO - javascript benchmark 19:24:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7776.042289831705, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3363.2937083212523, 3375.6118046424667, 3393.947876158393, 3431.4338134207865, 3437.86248550058, 5823.767049318033, 5952.166696662471, 6010.909836352458, 6019.699015049252, 6071.089336599507, 5917.852053698649, 5986.07215881538, 6043.1539584458105, 6075.726592303346, 6091.26904771427, 5232.241325007872, 5315.229291752694, 5316.415194328621, 5334.786608535674, 5372.623916325859, 5451.972740136293, 5467.261919640857, 5477.835664930059, 5481.780728770845, 5513.2005859150395, 5277.973610131925, 5297.894042119175, 5337.226102215157, 5389.8113566025195, 5398.6220964532495, 5330.413654498002, 5382.381026182, 5416.458354164592, 5452.291202143736, 5461.344638643349, 5291.153415453509, 5323.893522129536, 5347.304850369427, 5354.678719276817, 5366.543843773284, 5962.165296858443, 5973.581849270553, 6010.459058684695, 6013.428724271187, 6018.789342373039, 6116.847078823021, 6119.3197658210165, 6126.426068710472, 6203.069539569055, 6274.215723034621, 6268.028455589391, 6317.557770956035, 6329.746810127589, 6331.113644089831, 6342.87314253717, 5903.76384944606, 6053.51571874249, 6066.332703402622, 6070.939290607082, 6090.095278761139, 6172.4136207060255, 6228.408301211378, 6396.232452105777, 6410.1987251593555, 6506.707198176094, 5577.912307100077, 6220.906686399708, 6267.71795269214, 6279.215098112736, 6282.277538083179, 6272.843178920472, 6287.559870809091, 6289.937100628935, 6301.936980630135, 6313.494920406357, 6171.105189747551, 6187.791466555286, 6258.593191442542, 6260.561760676709, 6262.968685156545, 6169.383061693885, 6219.440250377488, 6286.937130628727, 6297.653629050446, 6299.779507717208, 5116.437191908887, 5126.641135120581, 5134.922976155361, 5136.229565565195, 5179.948200518022, 4575.17646823575, 4579.061292435043, 4579.977100114478, 4592.311153327028, 4619.745913974696, 5372.677639341652, 5451.591130665216, 5462.289902312754, 5477.315335583052, 5532.30846144232, 6183.783567575113, 6212.4408803207025, 6224.128621992924, 6244.438000579969, 6248.750049997949, 5515.172724091338, 5518.613697041249, 5518.972405138029, 5526.281583394133, 5555.083411237181, 5285.445028272053, 5444.482774136451, 5445.101558242845, 5448.210009548593, 5456.781728730885, 6210.192674952317, 6310.7791227306825, 6450.451711604566, 6496.70764815575, 6534.901976470262, 6076.8784624308155, 6195.101710251898, 6234.314225435108, 6245.500359971101, 6253.124562561154, 5764.510016648632, 6326.272478665012, 6443.065755465525, 6468.191476065492, 6529.771457998947, 6256.280527739186, 6268.780592679417, 6287.371262873676, 6292.056191571301, 6298.968505157628, 6125.509959203164, 6188.2883468399905, 6268.373162683695, 6271.278802937538, 6272.6236425814595, 6119.07606531266, 6144.1398204250545, 6191.535634827496, 6197.783077592263, 6223.564350495603, 6209.2548894133, 6221.129041934223, 6233.0, 6240.7503699851495, 6253.218347706536, 6097.817065488042, 6109.0, 6110.052941794029, 6114.847128821815, 6133.570650054453, 6064.818055458343, 6122.020476723703, 6129.540284478771, 6169.413905678954, 6277.372262773686, 6002.249718785152, 6058.606190597597, 6062.636241825505, 6072.848178795565, 6079.665618390854], "value": 5795.163538667122, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.4699548836114, 715.0775499605509, 783.7648705388384, 852.7356519478958, 864.2006144316506, 24255.878720606393, 27364.042258520956, 27366.04218852338, 27396.17811465654, 27413.72586274139, 35719.10702232445, 36196.81901590495, 36196.9140925772, 36225.275494490095, 36298.0, 9021.278297736199, 9210.263178945701, 9220.585073671667, 9229.584668689926, 9261.53692315385, 7185.317394847507, 9049.819003619923, 9200.585973631203, 9202.539873006357, 9208.079192080806, 7398.297161769623, 10621.362718236893, 10840.566377344896, 10841.566337346496, 10867.0, 10967.616133435331, 11037.392943388111, 11052.281601695864, 11057.004869561779, 11061.834072488919, 9225.584848681825, 10697.272195590152, 10756.623518176904, 10794.622188223375, 10844.511996960076, 25276.873615631986, 25615.0, 25667.486650267077, 25709.10018149356, 25761.227163185133, 3682.4476328550663, 3735.962640373589, 3784.7539909905768, 3822.503074600312, 3864.265789499986, 27080.32299192516, 27590.724092759017, 27681.584776228374, 27700.584491232647, 27761.305967350978, 3073.5082386818226, 3160.1625569224175, 3176.8411579420936, 3218.388506183841, 3260.6468315648976, 280184.0, 282293.1770682308, 283255.0, 283367.0, 284095.0, 52793.472065279624, 52985.735071325165, 53041.40875773733, 53069.673258168084, 53121.0, 55380.0, 55390.44609553934, 55605.165922511194, 55744.72127639336, 55792.442075579536, 14841.332140053724, 15016.174110424032, 15019.849801501845, 15030.17334046616, 15032.473863414729, 12015.219010764273, 12064.879351206375, 12067.75864482723, 12071.39643017863, 12115.575954841539, 11737.706557336134, 11771.646850594496, 11891.70270743221, 14204.005719599529, 14224.85775142256, 5056.266841308064, 6073.331933487313, 6100.145979562864, 6103.3591472894705, 6124.234470691164, 823.56762699582, 919.8528235482424, 929.4144688845984, 947.393668052447, 989.2531138990161, 27019.72980270172, 27137.728622713916, 27269.590956135675, 27548.17355479339, 27793.722062779114, 983.3559018842669, 1022.7903279827617, 1059.0838924330553, 1073.608133031438, 1074.3392813419691, 13467.595972120853, 13917.652058698412, 14182.007259491736, 14204.64488387778, 14233.359498822578, 485247.0, 489354.0, 489712.0, 490027.0, 490488.0, 53794.46205537894, 54065.45934540683, 54166.72916635471, 54322.91354172894, 54328.72835635796, 1361.142480237444, 1439.0861802755117, 1440.3302464354126, 1442.1923722715312, 1457.9927100364641, 25183.118590849233, 26383.736162638128, 26448.8677556611, 26569.33576660599, 26626.467470650867, 42723.7863810679, 46590.30114548352, 47237.0, 47428.0, 47553.524464756294, 473936.6303168462, 475665.0, 475819.0, 475963.0, 476507.0, 34232.26141908691, 34236.0, 34249.97250082502, 34344.65655343414, 34465.553444655336, 43396.783016084715, 44094.559054409045, 44966.0, 45031.099378012914, 45361.09277814491, 35812.87504104877, 36662.26675466529, 37190.25619487649, 37393.43909841409, 38887.80556097201, 35709.82145089258, 36830.63169368272, 36903.26193476169, 37946.0, 40120.598794012854, 38537.80731096439, 38587.035324116, 38865.0, 39282.01794955149, 39396.01509962274, 33170.83414583008, 34285.0, 34797.0, 34850.9544713659, 35043.82478087593, 25630.615540766532, 25749.871250643628, 25829.870850645628, 26240.475190496465, 26293.34266643349], "value": 18494.59261378464, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.0931057359919, 398.2294260605726, 417.39269363076716, 419.7586387826999, 431.15493632480354, 13299.268540230283, 15273.465428709997, 21399.0, 21482.785172148273, 21564.382671299656, 20538.17847286107, 21167.0, 21620.459488512795, 22327.33018009458, 22592.322230333077, 6697.564658297195, 6806.591604503746, 6862.897056544156, 6959.338862808025, 6961.373476387124, 3592.8562857485667, 4357.847475338363, 4489.708168969023, 6841.93158068418, 6954.965225173867, 4459.0, 4498.190325741365, 7956.085050219241, 7958.442908996372, 8010.279074883259, 7673.693052277902, 7932.563708996003, 7953.5227886327, 7978.680852765911, 8075.192480751878, 7460.403167746567, 7602.809929751746, 7794.883076753853, 7821.452498325119, 7824.608769561556, 22484.775152248596, 22726.204582839688, 27635.723642763514, 28078.298042548897, 28234.29414264639, 2733.1117386849355, 2866.928326791826, 2917.3290143266954, 2923.079230042551, 2933.06142034549, 16095.758563621555, 16730.74903876443, 16731.916340418342, 16930.322787088626, 17636.559086022822, 1924.980750192494, 2119.5760847830343, 2142.924997625076, 2143.6034333648327, 2146.323907969, 135939.96090058755, 160885.0, 163748.18125909413, 165532.0, 169269.0, 17389.826101739072, 20245.14116612032, 21300.0, 21866.562668746537, 21967.560648787254, 32060.679393206236, 36550.0, 36982.63017369845, 37133.628663713556, 37285.0, 8933.73198804024, 10489.632862849763, 10909.83635245472, 10946.288491248044, 11152.944235278772, 8704.738857834149, 8710.651573936972, 8751.387402881737, 8903.777405564782, 8907.866382004275, 10408.291737507658, 10681.252312338062, 10862.78274434507, 10864.881348137196, 10866.446385099496, 3339.4471570719734, 3913.491246138041, 4027.8791636250958, 4143.502779666459, 4161.375793630979, 854.6965827131403, 1000.7898341348398, 1002.9849552256723, 1018.4551265073151, 1028.4343611013912, 21217.18211008733, 22541.774582254297, 22779.974901129488, 22864.885675571517, 22877.656835147154, 891.7681402835309, 998.5456617239139, 1021.5198856537415, 1029.1766586730735, 1029.7785976015193, 10362.689119326433, 10748.193885458622, 11791.702912679599, 11846.526138954518, 11872.287662740264, 609504.0, 678396.0, 690024.0, 691693.0, 709893.0, 106156.0, 145093.8235926462, 148763.51236487713, 150802.0, 151133.0, 1118.59730497021, 1142.3431526872082, 1167.7022359298326, 1168.4975460551875, 1178.505027888289, 15650.843491564938, 19874.801251987294, 19931.60136797285, 19989.800101998793, 20050.197992080153, 48278.517214828804, 58561.4143858556, 59870.70064649649, 61146.38853611407, 62112.0, 65022.02466963094, 86823.0, 88122.0, 89158.0, 89715.65426518738, 11545.711357216136, 11648.301101933912, 12196.268223906594, 12486.562970295996, 12554.686132846751, 13793.655158620713, 13927.791083133963, 13942.58172254834, 14269.571912842632, 14273.714525709634, 11016.834747478633, 11541.0, 11627.6511704649, 11753.236039657737, 11923.403829808649, 11410.657680269605, 11546.307221566733, 11623.709407264549, 11809.586664466702, 11955.880441195477, 9901.55443005081, 11458.598949037078, 11979.161458697807, 11984.340861252715, 12059.879401205875, 11435.199536032398, 12224.572139975058, 12290.938545307215, 12327.506899724269, 12385.442655080362, 10084.848727269244, 10133.13868321201, 10266.870644228979, 11072.169587281147, 11458.255213411101], "value": 11650.815006311417, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1573.6537961648432, 1578.9526314210564, 1597.704424681434, 1611.1702473226287, 1658.8258232885546, 10695.78608427831, 11139.665810025692, 11182.496787644555, 11198.888011119887, 11227.326360418381, 10733.624323148691, 11208.943955280212, 11225.0, 11225.831612525819, 11231.887681123208, 2351.329870986765, 2394.676718642987, 2398.0767404549288, 2400.603900356439, 2401.735809061002, 2344.2146880794953, 2373.098222675381, 2375.0737212487143, 2382.9285121446383, 2383.8331316807744, 2051.1180192517213, 2348.941276468085, 2355.9764402355927, 2362.574736547421, 2381.297517232412, 2303.1593468384085, 2316.2587971849016, 2328.732195797488, 2331.5336932613377, 2333.9066437342485, 2295.5064661097945, 2353.5645905507536, 2357.1867705641525, 2359.8702071386065, 2360.917367892133, 11127.332360058423, 11231.21381503295, 11231.550737970552, 11240.718982025433, 11294.152938529562, 5580.832575022756, 5596.2165296858475, 5915.763369465216, 5918.733656985446, 5933.465988061095, 3088.9382212355854, 3183.8567264473154, 3338.6327503974544, 3596.9029446018953, 3694.242680250542, 1109.4951796932457, 1175.5650409348596, 1233.8951189148934, 1236.2211806561897, 1241.1808206583612, 13584.864151358459, 14090.788638170436, 14167.716645667131, 15406.614834629112, 15445.459408920746, 3646.635336466385, 4558.111168322212, 4562.498125206291, 4686.133065382915, 4697.718136911796, 9490.478023708762, 10470.790584188426, 11433.314001159957, 11449.370284634426, 11474.36890970988, 4828.396450443694, 5000.974995125074, 5289.2330612061805, 5725.2843394575675, 5745.310562732415, 4551.772411379484, 5298.28473156119, 5326.147816349366, 5334.226537152092, 5334.706591137525, 2856.3858770364473, 3180.6183258008723, 3372.1738174147, 3396.592408910897, 3413.675700808419, 1017.6183931025865, 1040.6877936618985, 1052.752603138262, 1053.957841686324, 1059.6926891201465, 760.6462994707488, 773.5320131320583, 790.2334735306744, 804.8430556041516, 809.1503920883049, 6390.968045159744, 6518.837029074311, 6638.568493048033, 6658.966705166443, 6687.933120668828, 850.9278309330289, 936.9812603747887, 993.5479356892597, 1011.6813203840767, 1029.2126523209752, 3972.324704800191, 4001.15975645112, 4127.236461254677, 4136.875893723193, 4182.811773470201, 13244.867551324556, 13732.931335343259, 13752.587422377344, 13791.448342066205, 13794.310284485937, 11590.420478976017, 13650.180989140683, 13672.589822305346, 13706.0, 13716.588502344946, 9416.717498475056, 9641.27690423221, 9871.0, 9887.406755594831, 9929.25530585209, 6303.9684801575695, 6630.83422914431, 6695.966520167368, 6837.62393068386, 6949.3745562899585, 11357.204995650225, 11808.0, 12364.134510584172, 12368.814467782811, 12376.75246495047, 10545.420001899969, 10881.793673883782, 11959.222650527689, 12007.879921201025, 12040.277583345027, 8929.598168082322, 8981.236594889508, 8995.775105622412, 9169.954150229472, 9173.54132293396, 10049.0, 10220.0, 10221.080102790784, 10228.48857557134, 10230.795384092127, 8673.653053877773, 8956.776080598038, 8996.910030899608, 9013.18881300686, 9076.954615226881, 8720.869186962074, 8753.562321884008, 8812.339074569305, 8851.159139881702, 8863.113688631085, 7790.1041380241995, 7841.490303130278, 7872.252136047066, 7883.605819708877, 7890.526568405914, 5769.509591684754, 5908.172855800105, 5942.881142377215, 5992.101184822312, 6022.518198544193, 5360.356757189163, 5772.19189313488, 5812.7674893003805, 5888.852778680567, 5941.257342832146], "value": 5010.765025376171, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.1564885115384, 365.8591442294716, 371.4001886952572, 374.4925625777072, 380.3609935308682, 5621.7751289948355, 5663.2160869326135, 5726.3414707308675, 5784.652920824754, 5832.783542253943, 5121.027004869082, 5551.2529042896085, 5735.913961290574, 5751.482366587006, 5761.366249712528, 3975.681945444372, 3997.3204555225534, 4022.4368588397574, 4587.931181032287, 4844.66087373884, 4792.137415265268, 4795.482371754839, 4802.871325238566, 4816.951830481703, 4832.444268909086, 4024.3963405489117, 4377.868663940071, 4787.688800227974, 4820.517948205186, 4825.831095911643, 3992.2614316351423, 4167.416561681367, 4278.336857787017, 4736.83421080264, 4822.5900798432, 4347.521772605042, 4349.826006959718, 4349.956500434987, 4387.210302145612, 4387.881090321979, 5650.858728531778, 5655.0, 5672.0, 5674.3190817101795, 5681.34664513578, 4291.463567054118, 4707.7289131934185, 5526.50261476469, 5565.916511252334, 5572.359178694421, 5533.422974452262, 5789.305283365981, 6236.253848922309, 6254.8123556293385, 6266.968665156645, 4302.870913872589, 4429.7785110744335, 4569.840055598072, 4777.641676874214, 4954.677945933503, 5284.39229488606, 6080.543959203077, 6267.2479302484, 6424.614523128627, 6535.738570457176, 4876.4879687633, 5009.897822479049, 5030.346055012825, 5032.867604788967, 5045.217991211368, 4963.528464795839, 5154.381474223117, 5172.844814655567, 5174.223866420067, 5192.209686928488, 5248.737563121828, 5468.781248750005, 5512.200730893998, 5541.9168712469345, 5557.3331200256225, 5235.267062611238, 6081.814046260936, 6134.509239260938, 6155.322914479404, 6191.690415479208, 1545.6754081642755, 1669.8246684098237, 1738.3220543987854, 1768.487138729754, 1784.518180091368, 1270.9173903696415, 1271.9046071544672, 1283.657325381183, 1311.9803202951964, 1322.7023919618202, 5493.2034854945805, 5524.889502209933, 5526.889462210734, 5544.556435485232, 5550.972245138749, 4765.785539650724, 4983.8504844854715, 6054.969725151346, 6073.14975903365, 6283.434490895841, 5342.54588359986, 5483.177523371526, 5503.3120859892515, 5512.39363669996, 5528.695921724263, 2990.775691823122, 3247.8863239786965, 3268.509723541488, 3270.6917233106474, 3293.226091868409, 6309.463695585927, 6603.702833372414, 6648.767293144717, 6669.599824010575, 6715.932840671629, 6435.0, 6508.381703738138, 6528.477721782246, 6547.5416720830035, 6559.7376104955265, 5509.338879334506, 5991.58058935879, 6183.196184495987, 6525.706343214567, 6608.537402381787, 6049.78825741097, 6169.691515424301, 6185.41238582334, 6269.811905642838, 6337.334579869232, 5992.280926288873, 6159.507239420746, 6202.317745048132, 6272.466840318624, 6320.598172694346, 5377.838664840061, 5640.746166422438, 5964.463198312173, 6096.603720758137, 6349.396807303298, 4277.65778737694, 4727.054589082129, 4977.751112444435, 5000.999800040079, 5006.5994720423005, 5317.441668624739, 6005.567745063257, 6315.336889626523, 6397.584157029778, 6398.712057957497, 4873.342098816614, 6202.875942481035, 6208.658523781055, 6230.112543646392, 6262.906056409249, 4936.037472692934, 4973.88087680269, 5617.382087970238, 5757.625754325955, 6091.634501929899, 5770.567207459373, 6027.969860150672, 6035.0, 6062.333143354315, 6063.848403789941, 4944.184209605375, 6130.811977771445, 6197.388678943417, 6218.751249949952, 6241.500679945684, 5917.467427931507, 5977.790777322773, 5997.400259973968, 6005.339412664691, 6009.639421634716], "value": 4675.171785321684, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.6726305899286, 716.3061193150013, 734.6877577029765, 784.7567254151213, 837.4347315561996, 15094.16982065986, 16006.519804405872, 16018.519444416657, 16022.839771602281, 16077.356905723771, 14133.363998620061, 14784.6303842404, 14791.112533247986, 15097.698046039073, 15300.846991530081, 912.4616476278994, 955.2262667239559, 956.7512446763822, 957.4351132831628, 958.5542722633974, 825.628467189764, 935.4200395754642, 938.7981583959447, 942.6606421688186, 943.8395472769646, 1001.2390583156816, 1006.3106771861262, 1010.1363334349136, 1010.2877471382694, 1015.7257540464108, 1009.6062535611118, 1009.8333774927128, 1010.3836659637615, 1010.8079464901682, 1012.6253286284121, 746.045062320231, 746.2612014105996, 748.1919526910923, 748.4685873030155, 748.7080038784878, 16316.184190790413, 16414.67170656592, 16714.247858846382, 16788.916055419766, 16848.241829117596, 12579.811302830465, 14814.851851481455, 14831.258437078102, 14875.404983800636, 15078.321475533627, 11574.942125289404, 11704.707382315424, 11726.296422214695, 11745.765084698343, 12206.938965305206, 3773.9433908491396, 3792.1846802937225, 3889.7860617666015, 3919.941200881989, 3928.8821335359985, 111474.0, 113164.0, 113480.43259783731, 114039.0, 115010.27484587739, 11229.14719071344, 11567.942160289313, 11633.0, 11790.499877640053, 11977.940110299567, 24534.87732561326, 24858.751412485643, 24894.004239830203, 24896.253112406655, 25038.248852534452, 7792.688292468238, 7872.803179920548, 7874.960625196837, 7942.166072562413, 8108.918910810934, 4238.660907127422, 4244.063363747186, 4295.72077814941, 4365.563443655609, 4437.844675436344, 3449.2753623188405, 3499.9300013999577, 3519.04985653872, 3534.169470174507, 3536.0982949347754, 546.0880329849161, 598.4793229889937, 611.0437165835453, 615.4922189193933, 629.134939458245, 573.4494884910449, 623.1151764494429, 656.5273003437518, 688.3254410677564, 713.350850725837, 9947.303688741718, 10140.0, 10192.031756983075, 10530.31552949056, 10554.736131596617, 660.9615250817501, 697.2365260040248, 712.6792943175592, 713.3864876206459, 723.9312265334785, 4777.641676874248, 4941.827036053721, 4942.629302802305, 4946.060248552763, 4946.703197808143, 91471.0, 93011.0, 94035.0, 104892.0, 106467.35326467291, 82512.0, 89927.55036224908, 89950.10049899417, 90511.7590592751, 91275.0, 78436.6078169617, 80002.0, 80053.0, 80192.59903700445, 80493.19506804974, 9352.625894964398, 9549.856752148862, 9627.547785803685, 9647.324687272105, 9664.516774161124, 50397.0, 51842.48157518377, 52243.73878130585, 52507.73746131245, 53177.46822531725, 66898.3310166892, 67375.0, 67724.3227567718, 67896.0, 68142.0, 11785.116116291483, 11788.882111179122, 11847.111466639864, 11876.0, 12224.938875305566, 10994.395308258123, 12469.251844889335, 12708.173968692005, 12994.350282486026, 13175.14361566495, 11582.362970036393, 11594.130440216848, 11608.709782255512, 12274.570390036306, 12288.508459661514, 11685.415729213335, 11769.646910592353, 12207.75584488323, 12259.448324825225, 12456.43946022413, 11486.942565287454, 11612.780658030784, 11657.708557286136, 11753.412329383667, 12370.0, 10076.445795481026, 10309.463119324446, 10550.261481696207, 10556.788864222826, 11328.394469271949, 8576.65693372283, 9103.635854565744, 9911.900880991387, 10009.792079847619, 10139.2395570334], "value": 7556.934828553154, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1477.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 116.0, 113.0, 113.0, 116.0, 114.0, 115.0, 116.0, 116.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 113.0, 113.0, 149.0, 111.0, 110.0, 117.0, 112.0, 134.0, 110.0], "value": 121.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 186.0, 184.0, 186.0, 187.0, 199.0, 260.0, 199.0, 187.0, 186.0], "value": 196.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 64.0, 90.0, 58.0, 58.0, 75.0, 77.0, 107.0, 82.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 89.0, 70.0, 71.0, 70.0, 83.0, 70.0, 70.0, 84.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 88.0, 89.0, 88.0, 89.0, 89.0, 89.0, 90.0, 90.0], "value": 89.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 97.0, 96.0, 95.0, 102.0, 93.0, 137.0, 120.0], "value": 103.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 87.0, 86.0, 86.0, 84.0, 87.0, 83.0, 86.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 82.0, 96.0, 92.0, 84.0, 62.0, 63.0, 63.0, 61.0], "value": 70.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 64.0, 71.0, 65.0, 61.0, 57.0, 59.0, 59.0, 59.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 83.0, 84.0, 83.0, 81.0, 83.0, 83.0, 82.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 141.0, 143.0, 128.0, 146.0, 148.0, 143.0, 138.0, 173.0, 180.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 189.0, 187.0, 189.0, 188.0, 175.0, 185.0, 185.0, 183.0, 185.0], "value": 185.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 68.0, 68.0, 69.0, 67.0, 69.0, 68.0, 68.0], "value": 68.0, "unit": "score"}]}]} 19:24:05 INFO - Return code: 0 19:24:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:24:05 ERROR - # TBPL SUCCESS # 19:24:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:24:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:24:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:24:05 INFO - 2017-03-20 19:24:05.292 screenresolution[2193:26515] starting screenresolution argv=screenresolution get 19:24:05 INFO - 2017-03-20 19:24:05.295 screenresolution[2193:26515] Display 0: 1600x1200x32@60 19:24:05 INFO - 2017-03-20 19:24:05.301 screenresolution[2194:26518] starting screenresolution argv=screenresolution list 19:24:05 INFO - Available Modes on Display 0 19:24:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:24:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:24:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:24:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:24:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:24:05 INFO - Intel Iris: 19:24:05 INFO - Chipset Model: Intel Iris 19:24:05 INFO - Type: GPU 19:24:05 INFO - Bus: Built-In 19:24:05 INFO - VRAM (Dynamic, Max): 1536 MB 19:24:05 INFO - Vendor: Intel (0x8086) 19:24:05 INFO - Device ID: 0x0a2e 19:24:05 INFO - Revision ID: 0x0009 19:24:05 INFO - Displays: 19:24:05 INFO - Display: 19:24:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:24:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:24:05 INFO - Display Serial Number: 1600x1200 60 19:24:05 INFO - Main Display: Yes 19:24:05 INFO - Mirror: Off 19:24:05 INFO - Online: Yes 19:24:05 INFO - Rotation: Supported 19:24:05 INFO - Return code: 0 19:24:05 INFO - Running post-action listener: _resource_record_post_action 19:24:05 INFO - [mozharness: 2017-03-21 02:24:05.539324Z] Finished run-tests step (success) 19:24:05 INFO - Running post-run listener: _resource_record_post_run 19:24:05 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 643584; Write bytes: 510933504; Read time: 13; Write time: 1585 19:24:05 INFO - TinderboxPrint: CPU usage
53.6% 19:24:05 INFO - TinderboxPrint: I/O read bytes / time
643,584 / 13 19:24:05 INFO - TinderboxPrint: I/O write bytes / time
510,933,504 / 1,585 19:24:05 INFO - TinderboxPrint: CPU idle
2,233.5 (46.4%) 19:24:05 INFO - TinderboxPrint: CPU system
966.1 (20.1%) 19:24:05 INFO - TinderboxPrint: CPU user
1,614.1 (33.5%) 19:24:05 INFO - TinderboxPrint: Swap in / out
210,743,296 / 0 19:24:05 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 202017280; Write bytes: 201351168; Read time: 15567; Write time: 364 19:24:05 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 643072; Write bytes: 299645440; Read time: 8; Write time: 1188 19:24:06 INFO - Running post-run listener: _upload_blobber_files 19:24:06 INFO - Blob upload gear active. 19:24:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:24:06 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 19:24:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:24:06 INFO - (blobuploader) - INFO - Open directory for files ... 19:24:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:24:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:24:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:24:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:24:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:24:07 INFO - (blobuploader) - INFO - Done attempting. 19:24:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:24:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:24:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:24:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:24:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:24:08 INFO - (blobuploader) - INFO - Done attempting. 19:24:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:24:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:24:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:24:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:24:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:24:09 INFO - (blobuploader) - INFO - Done attempting. 19:24:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:24:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:24:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:24:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:24:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:24:11 INFO - (blobuploader) - INFO - Done attempting. 19:24:11 INFO - (blobuploader) - INFO - Iteration through files over. 19:24:11 INFO - Return code: 0 19:24:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:24:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:24:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c4f79a31e77bd06a2d0b3e437a1c697ee0e03a218c150f388996330dbaed7646c7fdd5730e025827ab31822bd53d6c0aa5381dda9cacef0b4fe983d18e6572c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0b83338358b797dd36ea82b924bc0c2a5c21aa0d03245f71e6c9627bd367ca069d03b182dc3035b7760977d3f824bdfa20af8429f3e2529a09e503b3ae0a7e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6bbb40b97f3a708e34d6ed9344501940b1303ea1def4b2fada4153cee001498ad3ea0f90fd1486da9a1557a618a7848da61b3c11163c90c3fb9fd59da4bb3239", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0d02bd8a46a1522499f9b65f8dfb137ffac43feaeedf5e02a872764c5c5cee080d6bc75a4f596a00e1b5ddd178728aa55d3326bbed5779f727db80705b68ab1"} 19:24:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:24:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:24:11 INFO - Contents: 19:24:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c4f79a31e77bd06a2d0b3e437a1c697ee0e03a218c150f388996330dbaed7646c7fdd5730e025827ab31822bd53d6c0aa5381dda9cacef0b4fe983d18e6572c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0b83338358b797dd36ea82b924bc0c2a5c21aa0d03245f71e6c9627bd367ca069d03b182dc3035b7760977d3f824bdfa20af8429f3e2529a09e503b3ae0a7e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6bbb40b97f3a708e34d6ed9344501940b1303ea1def4b2fada4153cee001498ad3ea0f90fd1486da9a1557a618a7848da61b3c11163c90c3fb9fd59da4bb3239", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0d02bd8a46a1522499f9b65f8dfb137ffac43feaeedf5e02a872764c5c5cee080d6bc75a4f596a00e1b5ddd178728aa55d3326bbed5779f727db80705b68ab1"} 19:24:11 INFO - Running post-run listener: copy_logs_to_upload_dir 19:24:11 INFO - Copying logs to upload dir... 19:24:11 INFO - mkdir: /builds/slave/test/build/upload/logs 19:24:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.462772 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-03-20 19:24:11.323029) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 19:24:11.326203) ========= 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.iGmZmIEg44/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.LLXsRUemFo/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c4f79a31e77bd06a2d0b3e437a1c697ee0e03a218c150f388996330dbaed7646c7fdd5730e025827ab31822bd53d6c0aa5381dda9cacef0b4fe983d18e6572c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0b83338358b797dd36ea82b924bc0c2a5c21aa0d03245f71e6c9627bd367ca069d03b182dc3035b7760977d3f824bdfa20af8429f3e2529a09e503b3ae0a7e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6bbb40b97f3a708e34d6ed9344501940b1303ea1def4b2fada4153cee001498ad3ea0f90fd1486da9a1557a618a7848da61b3c11163c90c3fb9fd59da4bb3239", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0d02bd8a46a1522499f9b65f8dfb137ffac43feaeedf5e02a872764c5c5cee080d6bc75a4f596a00e1b5ddd178728aa55d3326bbed5779f727db80705b68ab1"} build_url:https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/C2wQWhBrTUK2J1MqnPRvYg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c4f79a31e77bd06a2d0b3e437a1c697ee0e03a218c150f388996330dbaed7646c7fdd5730e025827ab31822bd53d6c0aa5381dda9cacef0b4fe983d18e6572c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0b83338358b797dd36ea82b924bc0c2a5c21aa0d03245f71e6c9627bd367ca069d03b182dc3035b7760977d3f824bdfa20af8429f3e2529a09e503b3ae0a7e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6bbb40b97f3a708e34d6ed9344501940b1303ea1def4b2fada4153cee001498ad3ea0f90fd1486da9a1557a618a7848da61b3c11163c90c3fb9fd59da4bb3239", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0d02bd8a46a1522499f9b65f8dfb137ffac43feaeedf5e02a872764c5c5cee080d6bc75a4f596a00e1b5ddd178728aa55d3326bbed5779f727db80705b68ab1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 19:24:11.360649) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 19:24:11.361046) ========= 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.iGmZmIEg44/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.LLXsRUemFo/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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.005446 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 19:24:11.409920) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 19:24:11.410263) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 19:24:11.410639) ========= ========= Total master_lag: 0.18 =========