builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0357 starttime: 1493493524.34 results: success (0) buildid: 20170429114946 builduid: ec94f56ea5d04263a3a32e962bd968e8 revision: 21640269841ace0b6ab6818f89994558ef984b7a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-29 12:18:44.336917) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-29 12:18:44.337320) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-29 12:18:44.337668) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-29 12:18:44.603492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 12:18:44.603805) ========= 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.7fRiPrGzn9/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.HEULhz1c0p/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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-04-29 12:18:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 37.2M=0s 2017-04-29 12:18:45 (37.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.542383 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 12:18:45.180728) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 12:18:45.181246) ========= 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.7fRiPrGzn9/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.HEULhz1c0p/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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.027262 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 12:18:45.231493) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-29 12:18:45.231859) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 21640269841ace0b6ab6818f89994558ef984b7a --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 21640269841ace0b6ab6818f89994558ef984b7a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7fRiPrGzn9/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.HEULhz1c0p/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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-04-29 12:18:45,346 truncating revision to first 12 chars 2017-04-29 12:18:45,346 Setting DEBUG logging. 2017-04-29 12:18:45,346 attempt 1/10 2017-04-29 12:18:45,346 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/21640269841a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-29 12:18:46,128 unpacking tar archive at: mozilla-central-21640269841a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.053730 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-29 12:18:46.310976) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-29 12:18:46.311679) ========= script_repo_revision: 21640269841ace0b6ab6818f89994558ef984b7a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-29 12:18:46.312495) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-29 12:18:46.313246) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-29 12:18:46.338202) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-29 12:18:46.339140) ========= /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.7fRiPrGzn9/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.HEULhz1c0p/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 12:18:46 INFO - MultiFileLogger online at 20170429 12:18:46 in /builds/slave/test 12:18:46 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 12:18:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:18:46 INFO - {'append_to_log': False, 12:18:46 INFO - 'base_work_dir': '/builds/slave/test', 12:18:46 INFO - 'blob_upload_branch': 'Firefox', 12:18:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:18:46 INFO - 'branch': 'Firefox', 12:18:46 INFO - 'buildbot_json_path': 'buildprops.json', 12:18:46 INFO - 'config_files': ('talos/mac_config.py',), 12:18:46 INFO - 'default_actions': ('clobber', 12:18:46 INFO - 'read-buildbot-config', 12:18:46 INFO - 'download-and-extract', 12:18:46 INFO - 'populate-webroot', 12:18:46 INFO - 'create-virtualenv', 12:18:46 INFO - 'install', 12:18:46 INFO - 'run-tests'), 12:18:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:18:46 INFO - 'download_minidump_stackwalk': True, 12:18:46 INFO - 'download_symbols': 'ondemand', 12:18:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:18:46 INFO - 'tooltool.py': '/tools/tooltool.py', 12:18:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:18:46 INFO - '/tools/misc-python/virtualenv.py')}, 12:18:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:18:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:18:46 INFO - 'gecko_profile': False, 12:18:46 INFO - 'gecko_profile_interval': 0, 12:18:46 INFO - 'installer_path': 'installer.exe', 12:18:46 INFO - 'log_level': 'info', 12:18:46 INFO - 'log_name': 'talos', 12:18:46 INFO - 'log_to_console': True, 12:18:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:18:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:18:46 INFO - 'opt_config_files': (), 12:18:46 INFO - 'pip_index': False, 12:18:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:18:46 INFO - 'cmd': ('bash', 12:18:46 INFO - '-c', 12:18:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:18:46 INFO - 'enabled': True, 12:18:46 INFO - 'halt_on_failure': False, 12:18:46 INFO - 'name': 'check_screen_resolution'},), 12:18:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:18:46 INFO - 'cmd': ('bash', 12:18:46 INFO - '-c', 12:18:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:18:46 INFO - 'enabled': True, 12:18:46 INFO - 'halt_on_failure': False, 12:18:46 INFO - 'name': 'check_screen_resolution'},), 12:18:46 INFO - 'run_cmd_checks_enabled': True, 12:18:46 INFO - 'suite': 'dromaeojs', 12:18:46 INFO - 'system_bits': '32', 12:18:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:18:46 INFO - 'title': 't-yosemite-r7-0357', 12:18:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:18:46 INFO - 'use_talos_json': True, 12:18:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:18:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:18:46 INFO - 'work_dir': 'build'} 12:18:46 INFO - [mozharness: 2017-04-29 19:18:46.560497Z] Running clobber step. 12:18:46 INFO - Running pre-action listener: _resource_record_pre_action 12:18:46 INFO - Running main action method: clobber 12:18:46 INFO - rmtree: /builds/slave/test/build 12:18:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:18:48 INFO - Running post-action listener: _resource_record_post_action 12:18:48 INFO - [mozharness: 2017-04-29 19:18:48.952694Z] Finished clobber step (success) 12:18:48 INFO - [mozharness: 2017-04-29 19:18:48.952854Z] Running read-buildbot-config step. 12:18:48 INFO - Running pre-action listener: _resource_record_pre_action 12:18:48 INFO - Running main action method: read_buildbot_config 12:18:48 INFO - Using buildbot properties: 12:18:48 INFO - { 12:18:48 INFO - "project": "", 12:18:48 INFO - "product": "firefox", 12:18:48 INFO - "script_repo_revision": "production", 12:18:48 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 12:18:48 INFO - "repository": "", 12:18:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 12:18:48 INFO - "buildid": "20170429114946", 12:18:48 INFO - "pgo_build": "False", 12:18:48 INFO - "basedir": "/builds/slave/test", 12:18:48 INFO - "buildnumber": 42, 12:18:48 INFO - "slavename": "t-yosemite-r7-0357", 12:18:48 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 12:18:48 INFO - "platform": "yosemite_r7", 12:18:48 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:18:48 INFO - "branch": "mozilla-central", 12:18:48 INFO - "repo_path": "mozilla-central", 12:18:48 INFO - "revision": "21640269841ace0b6ab6818f89994558ef984b7a", 12:18:48 INFO - "stage_platform": "macosx64", 12:18:48 INFO - "builduid": "ec94f56ea5d04263a3a32e962bd968e8", 12:18:48 INFO - "slavebuilddir": "test" 12:18:48 INFO - } 12:18:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/SJsRl0NPQEagXF5tqxGaqw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 12:18:48 INFO - Running post-action listener: _resource_record_post_action 12:18:48 INFO - [mozharness: 2017-04-29 19:18:48.956108Z] Finished read-buildbot-config step (success) 12:18:48 INFO - [mozharness: 2017-04-29 19:18:48.956216Z] Running download-and-extract step. 12:18:48 INFO - Running pre-action listener: _resource_record_pre_action 12:18:48 INFO - Running main action method: download_and_extract 12:18:48 INFO - mkdir: /builds/slave/test/build/tests 12:18:48 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')]} 12:18:48 INFO - trying https://queue.taskcluster.net/v1/task/SJsRl0NPQEagXF5tqxGaqw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 12:18:48 INFO - Downloading https://queue.taskcluster.net/v1/task/SJsRl0NPQEagXF5tqxGaqw/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 12:18:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SJsRl0NPQEagXF5tqxGaqw/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 12:18:50 INFO - Downloaded 1325 bytes. 12:18:50 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 12:18:50 INFO - Using the following test package requirements: 12:18:50 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:18:50 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 12:18:50 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:18:50 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:18:50 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 12:18:50 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:18:50 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 12:18:50 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:18:50 INFO - u'jsshell-mac.zip'], 12:18:50 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:18:50 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 12:18:50 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:18:50 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:18:50 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 12:18:50 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:18:50 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 12:18:50 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:18:50 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 12:18:50 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:18:50 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 12:18:50 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:18:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SJsRl0NPQEagXF5tqxGaqw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:18:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SJsRl0NPQEagXF5tqxGaqw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:18:50 INFO - Fetch https://queue.taskcluster.net/v1/task/SJsRl0NPQEagXF5tqxGaqw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:18:52 INFO - Content-Length response header: 52698519 12:18:52 INFO - Bytes received: 52698519 12:19:08 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 12:19:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SJsRl0NPQEagXF5tqxGaqw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:19:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SJsRl0NPQEagXF5tqxGaqw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:19:08 INFO - Fetch https://queue.taskcluster.net/v1/task/SJsRl0NPQEagXF5tqxGaqw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:19:10 INFO - Content-Length response header: 52698519 12:19:10 INFO - Bytes received: 52698519 12:19:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SJsRl0NPQEagXF5tqxGaqw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 12:19:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SJsRl0NPQEagXF5tqxGaqw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:19:25 INFO - Fetch https://queue.taskcluster.net/v1/task/SJsRl0NPQEagXF5tqxGaqw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 12:19:26 INFO - Content-Length response header: 14408811 12:19:26 INFO - Bytes received: 14408811 12:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:27 INFO - trying https://queue.taskcluster.net/v1/task/SJsRl0NPQEagXF5tqxGaqw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:19:27 INFO - Downloading https://queue.taskcluster.net/v1/task/SJsRl0NPQEagXF5tqxGaqw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 12:19:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SJsRl0NPQEagXF5tqxGaqw/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 12:19:29 INFO - Downloaded 71196328 bytes. 12:19:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SJsRl0NPQEagXF5tqxGaqw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:19:29 INFO - mkdir: /builds/slave/test/properties 12:19:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:19:29 INFO - Writing to file /builds/slave/test/properties/build_url 12:19:29 INFO - Contents: 12:19:29 INFO - build_url:https://queue.taskcluster.net/v1/task/SJsRl0NPQEagXF5tqxGaqw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:19:29 INFO - Running post-action listener: _resource_record_post_action 12:19:29 INFO - Running post-action listener: set_extra_try_arguments 12:19:29 INFO - [mozharness: 2017-04-29 19:19:29.992924Z] Finished download-and-extract step (success) 12:19:29 INFO - [mozharness: 2017-04-29 19:19:29.993083Z] Running populate-webroot step. 12:19:29 INFO - Running pre-action listener: _resource_record_pre_action 12:19:29 INFO - Running main action method: populate_webroot 12:19:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:19:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:19:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:19:30 INFO - '--tppagecycles', 12:19:30 INFO - '7'], 12:19:30 INFO - 'tests': ['tsvgm']}}, 12:19:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:19:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:19:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:19:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:19:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:19:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:19:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:19:30 INFO - 'talos_options': ['--disable-e10s'], 12:19:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:19:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:19:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:19:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:19:30 INFO - 'talos_options': ['--disable-e10s'], 12:19:30 INFO - 'tests': ['damp', 'tps']}, 12:19:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:19:30 INFO - 'tests': ['damp', 'tps']}, 12:19:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:19:30 INFO - 'tests': ['dromaeo_dom']}, 12:19:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:19:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:19:30 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 12:19:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:19:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:19:30 INFO - 'tests': ['a11yr', 12:19:30 INFO - 'ts_paint', 12:19:30 INFO - 'tpaint', 12:19:30 INFO - 'sessionrestore', 12:19:30 INFO - 'sessionrestore_no_auto_restore', 12:19:30 INFO - 'tabpaint']}, 12:19:30 INFO - 'other-e10s': {'tests': ['a11yr', 12:19:30 INFO - 'ts_paint', 12:19:30 INFO - 'tpaint', 12:19:30 INFO - 'sessionrestore', 12:19:30 INFO - 'sessionrestore_no_auto_restore', 12:19:30 INFO - 'tabpaint']}, 12:19:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:19:30 INFO - 'ts_paint', 12:19:30 INFO - 'tpaint', 12:19:30 INFO - 'sessionrestore', 12:19:30 INFO - 'sessionrestore_no_auto_restore', 12:19:30 INFO - 'tabpaint']}, 12:19:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:19:30 INFO - 'ts_paint', 12:19:30 INFO - 'tpaint', 12:19:30 INFO - 'sessionrestore', 12:19:30 INFO - 'sessionrestore_no_auto_restore', 12:19:30 INFO - 'tabpaint']}, 12:19:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:19:30 INFO - 'tests': ['a11yr', 12:19:30 INFO - 'ts_paint', 12:19:30 INFO - 'tpaint', 12:19:30 INFO - 'sessionrestore', 12:19:30 INFO - 'sessionrestore_no_auto_restore', 12:19:30 INFO - 'tabpaint']}, 12:19:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:19:30 INFO - 'tests': ['a11yr', 12:19:30 INFO - 'ts_paint', 12:19:30 INFO - 'tpaint', 12:19:30 INFO - 'sessionrestore', 12:19:30 INFO - 'sessionrestore_no_auto_restore', 12:19:30 INFO - 'tabpaint']}, 12:19:30 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 12:19:30 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 12:19:30 INFO - 'bloom_basic_ref']}, 12:19:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:19:30 INFO - 'tests': ['tsvgx', 12:19:30 INFO - 'tsvgr_opacity', 12:19:30 INFO - 'tart', 12:19:30 INFO - 'tscrollx', 12:19:30 INFO - 'cart', 12:19:30 INFO - 'tsvg_static']}, 12:19:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:19:30 INFO - 'tsvgr_opacity', 12:19:30 INFO - 'tart', 12:19:30 INFO - 'tscrollx', 12:19:30 INFO - 'cart', 12:19:30 INFO - 'tsvg_static']}, 12:19:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:19:30 INFO - 'talos_options': ['--disable-e10s'], 12:19:30 INFO - 'tests': ['tp5o']}, 12:19:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:19:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:19:30 INFO - 'talos_options': ['--disable-e10s', 12:19:30 INFO - '--xperf_path', 12:19:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:19:30 INFO - 'tests': ['tp5n']}, 12:19:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:19:30 INFO - 'talos_options': ['--xperf_path', 12:19:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:19:30 INFO - 'tests': ['tp5n']}}, 12:19:30 INFO - 'talos.zip': {'path': '', 12:19:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:19:30 INFO - Running post-action listener: _resource_record_post_action 12:19:30 INFO - [mozharness: 2017-04-29 19:19:30.012246Z] Finished populate-webroot step (success) 12:19:30 INFO - [mozharness: 2017-04-29 19:19:30.012355Z] Running create-virtualenv step. 12:19:30 INFO - Running pre-action listener: _resource_record_pre_action 12:19:30 INFO - Running main action method: create_virtualenv 12:19:30 INFO - Creating virtualenv /builds/slave/test/build/venv 12:19:30 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 12:19:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:19:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:19:30 INFO - Using real prefix '/tools/python27' 12:19:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:19:31 INFO - Installing distribute.............................................................................................................................................................................................done. 12:19:33 INFO - Installing pip.................done. 12:19:33 INFO - Return code: 0 12:19:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:19:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:19:34 INFO - Reading from file tmpfile_stdout 12:19:34 INFO - Output received: 12:19:34 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) 12:19:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:34 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 0x103255b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103258768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b8a48b820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103033d30>, '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 0x102f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103028be8>, '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.7fRiPrGzn9/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.HEULhz1c0p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 12:19:34 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 12:19:34 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 12:19:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fRiPrGzn9/Render', 12:19:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:34 INFO - 'HOME': '/Users/cltbld', 12:19:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:34 INFO - 'LOGNAME': 'cltbld', 12:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:34 INFO - 'MOZ_NO_REMOTE': '1', 12:19:34 INFO - 'NO_EM_RESTART': '1', 12:19:34 INFO - 'PAGER': '/bin/cat', 12:19:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:34 INFO - 'PWD': '/builds/slave/test', 12:19:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:34 INFO - 'SHELL': '/bin/bash', 12:19:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEULhz1c0p/Listeners', 12:19:34 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 12:19:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:34 INFO - 'USER': 'cltbld', 12:19:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:34 INFO - 'XPC_FLAGS': '0x0', 12:19:34 INFO - 'XPC_SERVICE_NAME': '0', 12:19:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:34 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 12:19:34 INFO - Cleaning up... 12:19:34 INFO - Return code: 0 12:19:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:34 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 0x103255b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103258768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b8a48b820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103033d30>, '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 0x102f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103028be8>, '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.7fRiPrGzn9/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.HEULhz1c0p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 12:19:34 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 12:19:34 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 12:19:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fRiPrGzn9/Render', 12:19:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:34 INFO - 'HOME': '/Users/cltbld', 12:19:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:34 INFO - 'LOGNAME': 'cltbld', 12:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:34 INFO - 'MOZ_NO_REMOTE': '1', 12:19:34 INFO - 'NO_EM_RESTART': '1', 12:19:34 INFO - 'PAGER': '/bin/cat', 12:19:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:34 INFO - 'PWD': '/builds/slave/test', 12:19:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:34 INFO - 'SHELL': '/bin/bash', 12:19:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEULhz1c0p/Listeners', 12:19:34 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 12:19:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:34 INFO - 'USER': 'cltbld', 12:19:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:34 INFO - 'XPC_FLAGS': '0x0', 12:19:34 INFO - 'XPC_SERVICE_NAME': '0', 12:19:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:34 INFO - Downloading/unpacking psutil>=3.1.1 12:19:34 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 12:19:34 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 12:19:34 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 12:19:34 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 12:19:34 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 12:19:34 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 12:19:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:19:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:19:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:19:38 INFO - Installing collected packages: psutil 12:19:38 INFO - Running setup.py install for psutil 12:19:38 INFO - building 'psutil._psutil_osx' extension 12:19:38 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 12:19:39 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 12:19:39 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 12:19:39 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 12:19:39 INFO - building 'psutil._psutil_posix' extension 12:19:39 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 12:19:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:19:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:19:39 INFO - ^ 12:19:39 INFO - 1 warning generated. 12:19:39 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 12:19:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:19:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:19:39 INFO - Successfully installed psutil 12:19:39 INFO - Cleaning up... 12:19:39 INFO - Return code: 0 12:19:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:19:39 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')]} 12:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:39 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')]} 12:19:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:39 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 0x103255b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103258768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b8a48b820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103033d30>, '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 0x102f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103028be8>, '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.7fRiPrGzn9/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.HEULhz1c0p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 12:19:39 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 12:19:39 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 12:19:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fRiPrGzn9/Render', 12:19:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:39 INFO - 'HOME': '/Users/cltbld', 12:19:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:39 INFO - 'LOGNAME': 'cltbld', 12:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:39 INFO - 'MOZ_NO_REMOTE': '1', 12:19:39 INFO - 'NO_EM_RESTART': '1', 12:19:39 INFO - 'PAGER': '/bin/cat', 12:19:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:39 INFO - 'PWD': '/builds/slave/test', 12:19:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:39 INFO - 'SHELL': '/bin/bash', 12:19:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEULhz1c0p/Listeners', 12:19:39 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 12:19:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:39 INFO - 'USER': 'cltbld', 12:19:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:39 INFO - 'XPC_FLAGS': '0x0', 12:19:39 INFO - 'XPC_SERVICE_NAME': '0', 12:19:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:19:40 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 12:19:40 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 12:19:40 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 12:19:40 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 12:19:40 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 12:19:40 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 12:19:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:19:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:19:42 INFO - Installing collected packages: mozsystemmonitor 12:19:42 INFO - Running setup.py install for mozsystemmonitor 12:19:42 INFO - Successfully installed mozsystemmonitor 12:19:42 INFO - Cleaning up... 12:19:42 INFO - Return code: 0 12:19:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103255b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103258768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b8a48b820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103033d30>, '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 0x102f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103028be8>, '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.7fRiPrGzn9/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.HEULhz1c0p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 12:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:19:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fRiPrGzn9/Render', 12:19:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:42 INFO - 'HOME': '/Users/cltbld', 12:19:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:42 INFO - 'LOGNAME': 'cltbld', 12:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:42 INFO - 'MOZ_NO_REMOTE': '1', 12:19:42 INFO - 'NO_EM_RESTART': '1', 12:19:42 INFO - 'PAGER': '/bin/cat', 12:19:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:42 INFO - 'PWD': '/builds/slave/test', 12:19:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:42 INFO - 'SHELL': '/bin/bash', 12:19:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEULhz1c0p/Listeners', 12:19:42 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 12:19:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:42 INFO - 'USER': 'cltbld', 12:19:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:42 INFO - 'XPC_FLAGS': '0x0', 12:19:42 INFO - 'XPC_SERVICE_NAME': '0', 12:19:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:43 INFO - Downloading/unpacking jsonschema==2.5.1 12:19:43 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 12:19:43 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 12:19:43 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 12:19:43 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 12:19:43 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 12:19:43 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 12:19:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:19:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19: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 12:19:46 INFO - Downloading functools32-3.2.3-2.tar.gz 12:19:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:19:46 INFO - warning: no files found matching '*.txt' 12:19:46 INFO - no previously-included directories found matching 'build' 12:19:46 INFO - no previously-included directories found matching 'dist' 12:19:46 INFO - no previously-included directories found matching '.git*' 12:19:46 INFO - Installing collected packages: jsonschema, functools32 12:19:46 INFO - Running setup.py install for functools32 12:19:46 INFO - warning: no files found matching '*.txt' 12:19:46 INFO - no previously-included directories found matching 'build' 12:19:46 INFO - no previously-included directories found matching 'dist' 12:19:46 INFO - no previously-included directories found matching '.git*' 12:19:46 INFO - Successfully installed jsonschema functools32 12:19:46 INFO - Cleaning up... 12:19:46 INFO - Return code: 0 12:19:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:46 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 0x103255b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103258768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b8a48b820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103033d30>, '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 0x102f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103028be8>, '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.7fRiPrGzn9/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.HEULhz1c0p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 12:19:46 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 12:19:46 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 12:19:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fRiPrGzn9/Render', 12:19:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:46 INFO - 'HOME': '/Users/cltbld', 12:19:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:46 INFO - 'LOGNAME': 'cltbld', 12:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:46 INFO - 'MOZ_NO_REMOTE': '1', 12:19:46 INFO - 'NO_EM_RESTART': '1', 12:19:46 INFO - 'PAGER': '/bin/cat', 12:19:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:46 INFO - 'PWD': '/builds/slave/test', 12:19:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:46 INFO - 'SHELL': '/bin/bash', 12:19:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEULhz1c0p/Listeners', 12:19:46 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 12:19:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:46 INFO - 'USER': 'cltbld', 12:19:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:46 INFO - 'XPC_FLAGS': '0x0', 12:19:46 INFO - 'XPC_SERVICE_NAME': '0', 12:19:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:19:47 INFO - Cleaning up... 12:19:47 INFO - Return code: 0 12:19:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103255b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103258768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b8a48b820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103033d30>, '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 0x102f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103028be8>, '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.7fRiPrGzn9/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.HEULhz1c0p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 12:19:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:19:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fRiPrGzn9/Render', 12:19:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:47 INFO - 'HOME': '/Users/cltbld', 12:19:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:47 INFO - 'LOGNAME': 'cltbld', 12:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:47 INFO - 'MOZ_NO_REMOTE': '1', 12:19:47 INFO - 'NO_EM_RESTART': '1', 12:19:47 INFO - 'PAGER': '/bin/cat', 12:19:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:47 INFO - 'PWD': '/builds/slave/test', 12:19:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:47 INFO - 'SHELL': '/bin/bash', 12:19:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEULhz1c0p/Listeners', 12:19:47 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 12:19:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:47 INFO - 'USER': 'cltbld', 12:19:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:47 INFO - 'XPC_FLAGS': '0x0', 12:19:47 INFO - 'XPC_SERVICE_NAME': '0', 12:19:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:47 INFO - Downloading/unpacking blobuploader==1.2.4 12:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:49 INFO - Downloading blobuploader-1.2.4.tar.gz 12:19:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:19:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:19:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:51 INFO - Downloading docopt-0.6.1.tar.gz 12:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:19:51 INFO - Installing collected packages: blobuploader, requests, docopt 12:19:51 INFO - Running setup.py install for blobuploader 12:19:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:19:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:19:51 INFO - Running setup.py install for requests 12:19:51 INFO - Running setup.py install for docopt 12:19:52 INFO - Successfully installed blobuploader requests docopt 12:19:52 INFO - Cleaning up... 12:19:52 INFO - Return code: 0 12:19:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:52 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')]} 12:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:52 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')]} 12:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:52 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 0x103255b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103258768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b8a48b820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103033d30>, '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 0x102f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103028be8>, '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.7fRiPrGzn9/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.HEULhz1c0p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 12:19:52 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 12:19:52 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 12:19:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fRiPrGzn9/Render', 12:19:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:52 INFO - 'HOME': '/Users/cltbld', 12:19:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:52 INFO - 'LOGNAME': 'cltbld', 12:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:52 INFO - 'MOZ_NO_REMOTE': '1', 12:19:52 INFO - 'NO_EM_RESTART': '1', 12:19:52 INFO - 'PAGER': '/bin/cat', 12:19:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:52 INFO - 'PWD': '/builds/slave/test', 12:19:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:52 INFO - 'SHELL': '/bin/bash', 12:19:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEULhz1c0p/Listeners', 12:19:52 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 12:19:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:52 INFO - 'USER': 'cltbld', 12:19:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:52 INFO - 'XPC_FLAGS': '0x0', 12:19:52 INFO - 'XPC_SERVICE_NAME': '0', 12:19:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:52 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-IACMpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:52 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-9Q8FRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:52 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-90Bflm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:52 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-zdt9Ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:52 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-n__DCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:52 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-TK8dzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:53 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-Mz3fHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:53 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-G36bBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:53 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-gXa4_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:53 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-OBrko_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:53 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-6lm_I_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:53 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-eS0BIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:53 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-HQ0hK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:53 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-mCU7pQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:53 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-kEfIWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:53 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-UkqgAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:54 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-dTfCEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:19:54 INFO - Running setup.py install for manifestparser 12:19:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:19:54 INFO - Running setup.py install for mozcrash 12:19:54 INFO - Running setup.py install for mozdebug 12:19:54 INFO - Running setup.py install for mozdevice 12:19:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:19:54 INFO - Running setup.py install for mozfile 12:19:54 INFO - Running setup.py install for mozhttpd 12:19:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:19:55 INFO - Running setup.py install for mozinfo 12:19:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:19:55 INFO - Running setup.py install for mozInstall 12:19:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:19:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:19:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:19:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:19:55 INFO - Running setup.py install for mozleak 12:19:55 INFO - Running setup.py install for mozlog 12:19:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:19:55 INFO - Running setup.py install for moznetwork 12:19:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:19:55 INFO - Running setup.py install for mozprocess 12:19:55 INFO - Running setup.py install for mozprofile 12:19:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:19:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:19:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:19:56 INFO - Running setup.py install for mozrunner 12:19:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:19:56 INFO - Running setup.py install for mozscreenshot 12:19:56 INFO - Running setup.py install for moztest 12:19:56 INFO - Running setup.py install for mozversion 12:19:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:19:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:19:56 INFO - Cleaning up... 12:19:56 INFO - Return code: 0 12:19:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:56 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')]} 12:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:56 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')]} 12:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:56 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 0x103255b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103258768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b8a48b820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103033d30>, '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 0x102f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103028be8>, '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.7fRiPrGzn9/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.HEULhz1c0p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 12:19:56 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 12:19:56 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 12:19:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fRiPrGzn9/Render', 12:19:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:56 INFO - 'HOME': '/Users/cltbld', 12:19:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:56 INFO - 'LOGNAME': 'cltbld', 12:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:56 INFO - 'MOZ_NO_REMOTE': '1', 12:19:56 INFO - 'NO_EM_RESTART': '1', 12:19:56 INFO - 'PAGER': '/bin/cat', 12:19:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:56 INFO - 'PWD': '/builds/slave/test', 12:19:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:56 INFO - 'SHELL': '/bin/bash', 12:19:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEULhz1c0p/Listeners', 12:19:56 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 12:19:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:56 INFO - 'USER': 'cltbld', 12:19:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:56 INFO - 'XPC_FLAGS': '0x0', 12:19:56 INFO - 'XPC_SERVICE_NAME': '0', 12:19:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:57 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-1rZWn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:57 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)) 12:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:57 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-1b7zkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:57 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)) 12:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:57 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-fxDFy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:57 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)) 12:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:57 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-04XCfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 12:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:57 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-ZfBufS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:57 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)) 12:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:57 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-Sh23Ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:57 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)) 12:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:57 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-I97nml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:57 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)) 12:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:57 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-FgwDUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:57 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)) 12:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:57 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-OtBirx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:57 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)) 12:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:57 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-k7U4Ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:58 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)) 12:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:58 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-6tv3r5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:58 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)) 12:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:58 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-IEiygV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:58 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)) 12:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:58 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-TpQORf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:58 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)) 12:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:58 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-vsLj16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:58 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)) 12:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:58 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-jPe0tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:58 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)) 12:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:58 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-oDVZO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:58 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)) 12:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:58 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-PdvcNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:58 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)) 12:19:58 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)) 12:19:58 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)) 12:19:58 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)) 12:19:58 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:19:58 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:19:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:19:58 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 12:19:58 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 12:19:58 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 12:19:58 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 12:19:58 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 12:19:58 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 12:20:01 INFO - Downloading blessings-1.6.tar.gz 12:20:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:20:01 INFO - Installing collected packages: blessings 12:20:01 INFO - Running setup.py install for blessings 12:20:01 INFO - Successfully installed blessings 12:20:01 INFO - Cleaning up... 12:20:01 INFO - Return code: 0 12:20:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:20:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:20:02 INFO - Reading from file tmpfile_stdout 12:20:02 INFO - Current package versions: 12:20:02 INFO - blessings == 1.6 12:20:02 INFO - blobuploader == 1.2.4 12:20:02 INFO - docopt == 0.6.1 12:20:02 INFO - functools32 == 3.2.3-2 12:20:02 INFO - jsonschema == 2.5.1 12:20:02 INFO - manifestparser == 1.1 12:20:02 INFO - mozInstall == 1.12 12:20:02 INFO - mozcrash == 1.0 12:20:02 INFO - mozdebug == 0.1 12:20:02 INFO - mozdevice == 0.50 12:20:02 INFO - mozfile == 1.2 12:20:02 INFO - mozhttpd == 0.7 12:20:02 INFO - mozinfo == 0.9 12:20:02 INFO - mozleak == 0.1 12:20:02 INFO - mozlog == 3.4 12:20:02 INFO - moznetwork == 0.27 12:20:02 INFO - mozprocess == 0.25 12:20:02 INFO - mozprofile == 0.28 12:20:02 INFO - mozrunner == 6.13 12:20:02 INFO - mozscreenshot == 0.1 12:20:02 INFO - mozsystemmonitor == 0.3 12:20:02 INFO - moztest == 0.8 12:20:02 INFO - mozversion == 1.4 12:20:02 INFO - psutil == 3.1.1 12:20:02 INFO - requests == 1.2.3 12:20:02 INFO - wsgiref == 0.1.2 12:20:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:02 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 0x103255b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103258768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b8a48b820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103033d30>, '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 0x102f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103028be8>, '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.7fRiPrGzn9/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.HEULhz1c0p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 12:20:02 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 12:20:02 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 12:20:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fRiPrGzn9/Render', 12:20:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:02 INFO - 'HOME': '/Users/cltbld', 12:20:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:02 INFO - 'LOGNAME': 'cltbld', 12:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:02 INFO - 'MOZ_NO_REMOTE': '1', 12:20:02 INFO - 'NO_EM_RESTART': '1', 12:20:02 INFO - 'PAGER': '/bin/cat', 12:20:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:02 INFO - 'PWD': '/builds/slave/test', 12:20:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:02 INFO - 'SHELL': '/bin/bash', 12:20:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEULhz1c0p/Listeners', 12:20:02 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 12:20:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:02 INFO - 'USER': 'cltbld', 12:20:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:02 INFO - 'XPC_FLAGS': '0x0', 12:20:02 INFO - 'XPC_SERVICE_NAME': '0', 12:20:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:02 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)) 12:20:02 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)) 12:20:02 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)) 12:20:02 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)) 12:20:02 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)) 12:20:02 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)) 12:20:02 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)) 12:20:02 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)) 12:20:02 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)) 12:20:02 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)) 12:20:02 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)) 12:20:02 INFO - Cleaning up... 12:20:02 INFO - Return code: 0 12:20:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:20:02 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 0x103255b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103258768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b8a48b820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103033d30>, '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 0x102f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103028be8>, '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.7fRiPrGzn9/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.HEULhz1c0p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 12:20:02 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 12:20:02 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 12:20:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fRiPrGzn9/Render', 12:20:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:02 INFO - 'HOME': '/Users/cltbld', 12:20:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:02 INFO - 'LOGNAME': 'cltbld', 12:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:02 INFO - 'MOZ_NO_REMOTE': '1', 12:20:02 INFO - 'NO_EM_RESTART': '1', 12:20:02 INFO - 'PAGER': '/bin/cat', 12:20:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:02 INFO - 'PWD': '/builds/slave/test', 12:20:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:02 INFO - 'SHELL': '/bin/bash', 12:20:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEULhz1c0p/Listeners', 12:20:02 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 12:20:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:02 INFO - 'USER': 'cltbld', 12:20:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:02 INFO - 'XPC_FLAGS': '0x0', 12:20:02 INFO - 'XPC_SERVICE_NAME': '0', 12:20:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:20:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:20:02 INFO - Cleaning up... 12:20:02 INFO - Return code: 0 12:20:02 INFO - Running post-action listener: _resource_record_post_action 12:20:02 INFO - Running post-action listener: _start_resource_monitoring 12:20:02 INFO - Starting resource monitoring. 12:20:02 INFO - [mozharness: 2017-04-29 19:20:02.751461Z] Finished create-virtualenv step (success) 12:20:02 INFO - [mozharness: 2017-04-29 19:20:02.752410Z] Running install step. 12:20:02 INFO - Running pre-action listener: _resource_record_pre_action 12:20:02 INFO - Running main action method: install 12:20:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:20:03 INFO - Reading from file tmpfile_stdout 12:20:03 INFO - Detecting whether we're running mozinstall >=1.0... 12:20:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:20:03 INFO - Reading from file tmpfile_stdout 12:20:03 INFO - Output received: 12:20:03 INFO - Usage: mozinstall [options] installer 12:20:03 INFO - Options: 12:20:03 INFO - -h, --help show this help message and exit 12:20:03 INFO - -d DEST, --destination=DEST 12:20:03 INFO - Directory to install application into. [default: 12:20:03 INFO - "/builds/slave/test"] 12:20:03 INFO - --app=APP Application being installed. [default: firefox] 12:20:03 INFO - mkdir: /builds/slave/test/build/application 12:20:03 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'] 12:20:03 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 12:20:23 INFO - Reading from file tmpfile_stdout 12:20:23 INFO - Output received: 12:20:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:20:23 INFO - Running post-action listener: _resource_record_post_action 12:20:23 INFO - [mozharness: 2017-04-29 19:20:23.209010Z] Finished install step (success) 12:20:23 INFO - [mozharness: 2017-04-29 19:20:23.209166Z] Running run-tests step. 12:20:23 INFO - Running pre-action listener: _resource_record_pre_action 12:20:23 INFO - Running main action method: run_tests 12:20:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:20:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:20:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:20:23 INFO - 2017-04-29 12:20:23.223 screenresolution[1650:8970] starting screenresolution argv=screenresolution get 12:20:23 INFO - 2017-04-29 12:20:23.226 screenresolution[1650:8970] Display 0: 1600x1200x32@60 12:20:23 INFO - 2017-04-29 12:20:23.232 screenresolution[1651:8972] starting screenresolution argv=screenresolution list 12:20:23 INFO - Available Modes on Display 0 12:20:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:20:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:20:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:20:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:20:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:20:23 INFO - Intel Iris: 12:20:23 INFO - Chipset Model: Intel Iris 12:20:23 INFO - Type: GPU 12:20:23 INFO - Bus: Built-In 12:20:23 INFO - VRAM (Dynamic, Max): 1536 MB 12:20:23 INFO - Vendor: Intel (0x8086) 12:20:23 INFO - Device ID: 0x0a2e 12:20:23 INFO - Revision ID: 0x0009 12:20:23 INFO - Displays: 12:20:23 INFO - Display: 12:20:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:20:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:20:23 INFO - Display Serial Number: 1600x1200 60 12:20:23 INFO - Main Display: Yes 12:20:23 INFO - Mirror: Off 12:20:23 INFO - Online: Yes 12:20:23 INFO - Rotation: Supported 12:20:23 INFO - Return code: 0 12:20:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:20:23 INFO - Python 2.7.3 12:20:23 INFO - Return code: 0 12:20:23 INFO - grabbing minidump binary from tooltool 12:20: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')]} 12:20:23 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 0x103033d30>, '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 0x102f59db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103028be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:20:23 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 12:20:23 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 12:20:23 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 12:20:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:20:23 INFO - Return code: 0 12:20:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:20:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:20:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:20:23 INFO - ENV: RUST_BACKTRACE is now 1 12:20:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:20:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:20:23 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/SJsRl0NPQEagXF5tqxGaqw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0357', '--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 12:20:23 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/SJsRl0NPQEagXF5tqxGaqw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0357 --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 12:20:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7fRiPrGzn9/Render', 12:20:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:20:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:20:23 INFO - 'HOME': '/Users/cltbld', 12:20:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:20:23 INFO - 'LOGNAME': 'cltbld', 12:20:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:20:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:20:23 INFO - 'MOZ_NO_REMOTE': '1', 12:20:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:20:23 INFO - 'NO_EM_RESTART': '1', 12:20:23 INFO - 'PAGER': '/bin/cat', 12:20:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:20:23 INFO - 'PWD': '/builds/slave/test', 12:20:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:20:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:20:23 INFO - 'RUST_BACKTRACE': '1', 12:20:23 INFO - 'SHELL': '/bin/bash', 12:20:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEULhz1c0p/Listeners', 12:20:23 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 12:20:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:20:23 INFO - 'USER': 'cltbld', 12:20:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:20:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:20:23 INFO - 'XPC_FLAGS': '0x0', 12:20:23 INFO - 'XPC_SERVICE_NAME': '0', 12:20:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:20:23 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/SJsRl0NPQEagXF5tqxGaqw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0357', '--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 12:20:23 INFO - mozversion application_buildid: 20170429114946 12:20:23 INFO - mozversion application_changeset: 21640269841ace0b6ab6818f89994558ef984b7a 12:20:23 INFO - mozversion application_display_name: Nightly 12:20:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:20:23 INFO - mozversion application_name: Firefox 12:20:23 INFO - mozversion application_remotingname: firefox 12:20:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:20:23 INFO - mozversion application_vendor: Mozilla 12:20:23 INFO - mozversion application_version: 55.0a1 12:20:23 INFO - mozversion platform_buildid: 20170429114946 12:20:23 INFO - mozversion platform_changeset: 21640269841ace0b6ab6818f89994558ef984b7a 12:20:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:20:23 INFO - mozversion platform_version: 55.0a1 12:20:23 INFO - using testdate: 1493493623 12:20:23 INFO - actual date: 1493493623 12:20:23 INFO - starting webserver on 'localhost:49239' 12:20:23 INFO - SUITE-START | Running 2 tests 12:20:23 INFO - TEST-START | dromaeo_css 12:20:23 INFO - operating with platform_type : mac_ 12:20:23 INFO - Initialising browser for dromaeo_css test... 12:20:23 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpBpXwi2/profile http://localhost:49239/getInfo.html) 12:20:26 INFO - PID 1661 | __metrics Screen width/height:1600/1200 12:20:26 INFO - PID 1661 | colorDepth:24 12:20:26 INFO - PID 1661 | Browser inner width/height: 1024/689 12:20:26 INFO - PID 1661 | __metrics 12:20:26 INFO - PID 1661 | 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" 12:20:26 INFO - PID 1661 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:20:27 INFO - TEST-INFO | 1661: exit 0 12:20:27 INFO - Browser initialized. 12:20:27 INFO - Running cycle 1/1 for dromaeo_css test... 12:20:27 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpBpXwi2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:20:39 INFO - PID 1663 | RSS: Main: 241123328 12:20:39 INFO - PID 1663 | 12:23:45 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49239/tests/dromaeo/cssquery-ext.html) 12:23:47 INFO - PID 1663 | RSS: Main: 400846848 12:23:47 INFO - PID 1663 | 12:25:29 INFO - PID 1663 | ************************* 12:25:29 INFO - PID 1663 | A coding exception was thrown and uncaught in a Task. 12:25:29 INFO - PID 1663 | 12:25:29 ERROR - PID 1663 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:25:29 INFO - PID 1663 | Full stack: 12:25:29 INFO - PID 1663 | ************************* 12:25:29 INFO - PID 1663 | ************************* 12:25:29 INFO - PID 1663 | A coding exception was thrown and uncaught in a Task. 12:25:29 INFO - PID 1663 | 12:25:29 ERROR - PID 1663 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:25:29 INFO - PID 1663 | Full stack: 12:25:29 INFO - PID 1663 | ************************* 12:25:29 INFO - PID 1663 | ************************* 12:25:29 INFO - PID 1663 | A coding exception was thrown and uncaught in a Task. 12:25:29 INFO - PID 1663 | 12:25:29 ERROR - PID 1663 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:25:29 INFO - PID 1663 | Full stack: 12:25:29 INFO - PID 1663 | ************************* 12:25:29 INFO - PID 1663 | ************************* 12:25:29 INFO - PID 1663 | A coding exception was thrown and uncaught in a Task. 12:25:29 INFO - PID 1663 | 12:25:29 ERROR - PID 1663 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:25:29 INFO - PID 1663 | Full stack: 12:25:29 INFO - PID 1663 | ************************* 12:26:49 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-ext.html (next: http://localhost:49239/tests/dromaeo/cssquery-jquery.html) 12:26:50 INFO - PID 1663 | RSS: Main: 367042560 12:26:50 INFO - PID 1663 | 12:29:52 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49239/tests/dromaeo/cssquery-mootools.html) 12:29:53 INFO - PID 1663 | RSS: Main: 346533888 12:29:53 INFO - PID 1663 | 12:32:55 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49239/tests/dromaeo/cssquery-prototype.html) 12:32:56 INFO - PID 1663 | RSS: Main: 358072320 12:32:56 INFO - PID 1663 | 12:35:59 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49239/tests/dromaeo/cssquery-yui.html) 12:36:00 INFO - PID 1663 | RSS: Main: 330579968 12:36:00 INFO - PID 1663 | 12:39:02 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-yui.html (next: http://localhost:49239/tests/dromaeo/cssquery-dojo.html) 12:39:02 INFO - PID 1663 | RSS: Main: 377061376 12:39:02 INFO - PID 1663 | 12:39:02 INFO - PID 1663 | __start_tp_report 12:39:02 INFO - PID 1663 | _x_x_mozilla_page_load 12:39:02 INFO - PID 1663 | _x_x_mozilla_page_load_details 12:39:02 INFO - PID 1663 | |i|pagename|runs| 12:39:02 INFO - PID 1663 | |0;dojo.html;3493.7030352420043;3495.475678648204;3511.5786105667326;3518.3315170117685;3579.355715971124;5230.686158830473;5982.970085149579;6100.145979562853;6182.443580077792;6196.504279657628;6123.448889599935;6137.907931381022;6151.631621825596;6162.7534898604;6201.782937597185;5129.6409251352425;5179.741012949356;5270.683758974455;5295.4704529547125;5368.62419630626;5325.3077099976945;5372.623916325859;5391.218273350361;5397.78408863645;5413.702246376448;4410.933835992462;5290.100682883919;5294.285271488338;5297.337832770903;5358.383785864617;5290.418054014055;5290.629655924087;5290.973545132289;5302.628815982883;5317.494837990384;5265.631405801595;5293.153095504739;5326.094563924142;5339.9733001335135;5352.437994010612;6144;6144.723487443031;6151.108089327023;6160;6182.072689096626;6203.534734894901;6484.221893372825;6484.254310754276;6486.318936511692;6499.1876015498065;6406.391392817675;6424.967875160641;6504.38208370204;6603.867922641521;6631.900521492182;6246.125542424064;6289.968550157266;6298.874022519524;6319.399657032574;6339.397757213057;6670.132882725312;6690.933090669031;6693.598384096969;6705.09481220029;6712.463002959751;6254.061890716429;6287;6324.683765811691;6325.462335701425;6351.68241587928;6465.224173099258;6519.3154718754795;6525.3474652535315;6528.08606795049;6530.346965303526;6374.426301632875;6380.680965951684;6414.102025716404;6428.485721142298;6439.388258115471;6260.436560709558;6352.205974253218;6446.935530644633;6462.48300135988;6470.45001174896;5137.537621614073;5177.404598471224;5212.478752124757;5217.295665085165;5229.790808367698;4524.389207457017;4646.070785842845;4651.511591282934;4667.8599642010795;4692.4603670577635;6010.188624535719;6077.453029227302;6104.816855494253;6166.8899598071885;6171.9691401542705;6379.744810207632;6400.679966001681;6492.058651495507;6590.275069742324;6598;6113.385090542009;6151.876962460726;6159;6163.691815409212;6170;5718.628289161191;5719.399463056402;5723.198752174699;5727.627704199297;5732.369439361667;6398.168238129014;6478.676066196577;6644.235912870082;6721.327867213239;6732.023856540676;6505.31694172124;6568.671566421755;6578.539502234989;6608.306127856506;6612.107365505595;6672.799816005528;6720.126383570105;6733.93266067333;6743.696533655899;6749.595024298558;6264.060390941395;6312.526560508072;6442.8389290268115;6454.1609590752905;6460.612363258219;6509.8698026040165;6562.737490500326;6572.8356791080605;6620.702068407029;6624.9337506624315;6141.271221159771;6244.875102498016;6332.651704156131;6363.395477429637;6372.87254254903;6270.811875643738;6284.905726414199;6307.432331090224;6311.337309582428;6370.74517019314;6178.289496707756;6288.308286088618;6289.842753931005;6290.025046117859;6306.621602703853;5360.517553420055;5367.194920761761;6165.075238714228;6306.590071645512;6353.459955903615;6280.717367718555;6294.339094395023;6294.622322660655;6306.4639505642535;6309.305976342507 12:39:02 INFO - PID 1663 | |1;ext.html;714.2036629158488;760.1144666463567;810.4772421787947;1122.4724379541617;1131.4569006876704;25265.873670631645;30476.69523304769;36067.81966090169;36243.27513449736;36277;37708.62291377085;37914.43128353077;37972.999999999935;37997.620023799755;38032;5915.438033386821;8303.543305118215;8474.11021842707;8481.194286542768;8483.406161568693;5971.104334349839;8291;8473.872891906627;8480.067192608809;8489.872651910226;8496.235338819504;8542.402031857773;8543.57282135894;8547.316214702809;8562.529060901648;5862.091375836752;7846.372290216769;8192.18078192182;8516.446430981967;8541.14588541141;5983.311919129313;8183.836323273561;8363.790905227357;8374.246317831425;8380.664773409057;37456;37811.62188378136;37824.24351512954;37864.62135378639;37866.62133378686;3675.1363429594026;3715.6841668458214;3717.6282371762877;3718.312112259214;3732.64539868712;30432.847835760902;30591.69408305933;30595.92914248013;30621.540676889643;30673.233169170726;3132.1386618679817;3177.205698575356;3207.3905957868164;3213.96786032139;3216.662250463691;221176;270093.64953175304;270271;270645;273790;46115;46218.76890615525;46224.3066354005;46238.075238495716;46246.5375346249;48368;48408;48426.54720358395;48439.273410898866;48451.75774121107;11926.701832454259;13714.24571648549;13819.930900345635;13820.37808298629;13821.654458638615;9331.486768227813;9375.90624093764;10895.237333386587;11227.326360418401;11242.325460472397;10088.949555252324;12274.4476498556;12401.62795116148;12417.875821241672;12420.689482762822;4728.338032675429;4913.385826771653;5335.3864305604575;5426.163034576462;5445.700486473203;1046.1421634259987;1049.569676432659;1050.3540322701483;1084.38732116354;1090.2967585907045;22675.88662056679;23860.64209036866;23873;23874;23933;1115.5091759625739;1118.3625333559955;1142.0520967596874;1152.1071169843437;1162.6279590530949;11664.416779161009;12044.33756143403;12190.390480476119;12237.959773419181;12256.203346782431;303898;304621;305740;305991;306129;50079;50300.999999999265;50360.992780144195;50422;50541.483755487396;1411.1321537254514;1537.9154146521826;1582.8179759327595;1589.173629712543;1596.2098761113323;22402.66396004094;23582.646260305766;23682.526349473257;23700.288991330286;23714.88142559276;31417.52873706942;37488.68789592351;37524.43713344247;37625.4356184652;37625.62374376221;281547;283035;283117;283156;283314.1668583288;32006.51990220195;33366.499502506995;33481.83259083689;33495.49756753602;33500.83249583736;43263.9184020402;43266.783666081465;43303;43406.131877361644;43549.129017420106;27816.304592385353;28980.855095724386;29173.7082629171;30453.390932180788;30485.69514304917;23216.88391558099;29659.380474597452;30197;30227.94202203;30238.69761302359;34560.308793824486;35292.29415411626;35691.28617427689;36044;36082.8195859019;28940.855295723388;29480.115596532138;30156;30220.24449388783;30521.23696907595;17921.462356129337;20960.37118886436;22288.77711222867;22318.10727570879;22427 12:39:02 INFO - PID 1663 | |2;jquery.html;391.82367934429516;398.57750784168763;427.3377157758015;435.8866694659388;442.9645628349732;13333.399997000133;15285.159316237603;15821.762673559877;21998;22119.557608847834;22103.89480525975;22348;22650.77349226507;23185.536289274205;23487.177948771798;5280.577553795706;5741.712914354286;5932.199153114318;6078.300995385543;6078.635281883101;3506.9649303506894;6018.3078945921125;6058.96970515149;6066.302375226861;6070.18052562905;3642.1805093853936;3750.606186350421;6239.469645080174;6243.968780156093;6258.62448253104;5913.379095195007;5921.496672782819;6021.879562408771;6023.939760602404;6024.96987515064;5434.565234781208;5507.807226747084;5512.476314750093;5512.531434828044;5515.7242137892945;27859.16422507328;28064.85967570149;28530;28618.427631447463;28898.27754306138;2020.8585399022074;2206.801387875083;2206.9958169033052;2207.8896055197174;2208.7901649343285;14673.073280631661;14680.623456604933;14874.330655120546;15806.814488913378;17592.12039398025;2094.6962690409805;2106.3891471473253;2157.795009474113;2159.6976423300753;2170.1861801824316;133806;156870;162880;163203;165767.1711641434;11724.88275117255;12342.382880855921;12390.88482036603;12392.194507356993;12417.689557761129;16677.332906683838;16683.998960062436;16693.332266709196;16700.916495417445;16709.746768992376;8702.260307873901;8935.33676911352;8945.910540894507;8976.41653292547;9091.227245684058;8518.275946544489;8556.101609331055;8625.827483450295;8735.650573977096;8751.649934002697;7578.317951384402;7722.3436007938835;7754.457187996899;7762.650680719381;7772.82360938938;1797.730340448943;2079.8856062916684;2082.6043051820106;2085.9061342239333;2233.251860626676;900.7342833864026;964.6720115160879;965.6861520006026;985.6500942165571;1002.8295189817749;16840.24218910152;19716.977374123577;20121.39635810928;20941.89529052345;21034.47413814636;976.1605019683067;992.3202606214766;997.2769741937183;1023.1661196125134;1025.220832167558;9310;10136.493175341204;10832.350058996328;10841.566337346418;10841.620543280947;527322;534460;538749.2875498756;540992;544110;127934;129546;130369.69630303765;130406.83083875764;132987;1152.2798251093068;1174.747429302687;1194.5699548162654;1198.5804968261214;1200.0339726520235;16201.32678108099;17477.038762867654;17764.733528996818;18084.367047153286;18265.634687306447;55001.44998549963;57045;57174.7141264291;58403.70798145982;58408.70795645995;78888;79813.60093199497;80012;80371;80476.59761701155;8277.089520152898;8712.39013269065;8846.682494064726;8876.51179185151;8988.191062804379;13683.452661893412;13690.04169708111;14058.578242652737;14081.718365632834;14087.577372678836;11564.94217528907;11702.239354441934;12076;12089.75820483603;12131.696707582381;10750.946245268724;10755.677329680122;10963.56145754161;11254.94372528132;11275.379854108103;11471.369074700971;11677.357745324089;11987.940060299643;12057.819132713192;12376.257424554555;8768.386212965032;8791.296696264411;8815.471071735716;8860.246879015356;8868.423552469068;9868.950655246677;11763.529458821893;12014.879851201726;12078.456469459072;12105.213161144497 12:39:02 INFO - PID 1663 | |3;mootools.html;1266.6769973656717;1431.413120620546;1451.579042077797;1454.8763355114816;1456.482948553263;11107.278026928254;11592;11593.246438981481;11602.419879006058;11614.012808911231;11017.779644407126;11582.247153934988;11699.239549429281;11702.824457633142;11714.238574492652;2499.8750062496892;2549.0950712497074;2553.182981445938;2553.4510080332725;2562.449073449208;2075.6367635663773;2397.760223977597;2500.2624225853324;2513.9120130795427;2519.496100779842;2080.3758872338312;2115.122224276923;2137.8824164670937;2513.836600620963;2515.0317127905796;2443.987780061106;2462.7660372264695;2474.1711526638596;2474.5545801755675;2480.441900572375;2476.1828596563273;2484.1181380609805;2485.763852434016;2486.8010559155223;2487.2289590227088;11355.659330220107;11627.6511704649;11632.941835290854;11649.941750291278;11663.300201987908;6513.576617519893;6768.593884366954;6779.15260592426;6786.151731033621;6794.320567943166;3917.823697933571;4127.174565086964;4332.545082766295;4359.04101097758;4366.410534577855;1248.7377650693365;1252.6179515247845;1284.6980959474515;1286.2411177405281;1301.4338762638283;16320.183990800531;16437.424690135787;16456.012639241682;16461.506154815375;16479.752803707954;5321.521063104339;5390;5459.781608735686;5460.34475862899;5552.361478429952;11739.530418783324;11747.706307342385;11749.4712737927;11765.764684706259;11770.411479425995;5635.464630860061;6517.706703198368;6525.510586706016;6535.085088087577;6535.509836762262;6011.849703757441;6199.256089269316;6215.160953271341;6245.594036387711;6282.842928926722;4166.708330416842;4301.935470967938;4310.741355518679;4362.083962367875;4374.234508960919;1077.4343469678324;1104.4753741972659;1260.615512268767;1273.9490420383265;1274.9426275817611;630.369816959281;683.2074793239818;736.3372964332144;806.6692656011124;816.481534225759;6476.740930362827;6493.188351456068;6658.800235992928;6743.797686069426;7003.92996070043;596.436367632583;597.9402059793986;611.4619135161118;616.5776443136466;703.5040296590892;3903.6096390360735;4003.679705623543;4149.585041495887;4270.231358355526;4363.890902727458;14473.85526144725;15022.924885375503;15114.09315441077;15114.94195406311;15200.46798362052;14324.14055156694;14859.405623774928;15071.321790519452;15084;15087.396504139931;8445.1977062179;8625.52559609215;8634.827303454022;8648.1784230498;8653.394262401698;5634.267545219259;6676.799696009128;6881.13985751781;7091.539049961736;7153.427725781821;11890.346030968034;12938.935305323414;13471.393787279792;13504.594862154152;13612.65968350799;13649.727005460034;13713.108647937852;13771.724565508433;13894.513692020731;14000.43998240059;8167.959160204161;9187.908120918974;9496.525173741147;9509.334346595948;9514.762130946781;10456.006679365448;10584.841227381441;10618.36289822613;10703.036726694634;10741.355518668905;8868.467891926504;8900.465972041698;9083;9126.634934602542;9157.587908543997;8703.825923481369;8858.11418858109;8898.288136949159;8918.73243802687;9000.774980625536;8110.5944702763445;8190.918090819016;8191.959040204761;8201.917980820115;8219.917800821915;5610.354809196994;5638.802641907513;5706.600537962303;5775.1914731938405;5793.449622285876;5703.971480142573;5907.084401917709;6010.278766548042;6045.063015232646;6166.722497487714 12:39:02 INFO - PID 1663 | |4;prototype.html;372.7912369073319;384.79798105994365;407.35434336576526;407.87355919664924;408.16937532122137;5843.941560584398;5872.76508939643;5894.970525147379;5930.894532440986;6095.238095238095;5358.812441564546;5512.641678290908;5636.2954630671165;5764.7982320618785;5778.942210577893;4196.769177695225;4214.157168566284;4215.620594146526;4222.429971953778;4236.40690303357;3956.76259424434;4152.774931395231;4221.831126754926;4232.936505952413;4237.7669228192435;3518.7009104226045;3854.4603755474254;3861.822144246004;4198.559151289117;4227.894302642443;3510.368133735914;4192;4193.993441574031;4198.6431153352005;4209.2633789086785;3457.772490765792;3621.2576421833724;3625.1299688074673;3634.909127271813;3644.4351125575577;5079.891844884369;5450.836474905759;5572.275604171432;5603.859903502404;5625.5218306444;4568.771561421949;4642.883927901829;4962.528559786851;4964.702117872939;4970.627202959792;5395.325584301962;5432.728363581845;6092.238470191226;6117.969410152965;6157.322694503601;4037.818298176589;4080.6735461163034;4105.486814148231;4134.607212314825;4146.647534959532;6089;6128.724207410677;6265.2770488115675;6398.616083035033;6456.644884531349;3599.3521166190335;4083.4895638045246;4108.055147316134;4120.1553681495825;4129.421880936671;3855.51806024247;3931.5282166140246;3995.680345572347;4188.895277618084;4193.6645068394455;4149.2738770715005;4805.1590971579835;4858.927116093261;4859.586935110555;4869.269609558594;6108.419700128481;6116.003158452415;6137.987232106741;6144.938550614526;6188.412100850502;1268.9428975696117;1281.4425724809737;1305.8573747970527;1356;1401.1453013661658;920.9493477858782;923.4690053219425;939.7885475767897;941.7692665296909;941.7928055827707;5010.448850626428;5651.265335506358;5715.656101362911;5742.684152371576;5768.9711551442815;6341.968290158612;6357.014662727284;6363.568197155695;6371.33101024395;6406.6476343800605;5526.253955716007;5648.15277708347;5659.405762394971;5736.799212027559;5748.683822389725;2830.9433811323656;3289.161263877696;3292.2098696312714;3301.8043001404276;3321.983390083034;5507.311586051744;5744.712764361765;6249.2192223704915;6423.357664233539;6447.516436267299;5813.82558523245;6254.21822272216;6491.415772580396;6497.480201583862;6549.901751473732;5695.686737229492;6431.646259455775;6530.706118224596;6532.118164047888;6536.444402225864;5609.859753506195;5814.342912269983;6076.933842493397;6308.905366419599;6325.335839736761;5353.384360798558;5655.802046928337;6021.591363454653;6122.755089796537;6161.599496032743;6370.1718776558755;6515.315891831289;6552.3447655234095;6553.279139294769;6588.242352129567;3460.290640418658;3940.15286713358;4094.3653733671326;4108.835646574224;4109.486314210723;4849;5417.5665946723375;6286.5168258536705;6337;6384.3934826191435;5788.507976822018;6066.969665151646;6077.11881777131;6133.26400831903;6160.9383906160365;5452.91820622683;5837.445442682938;6022.939770602238;6161.537884658758;6191.752329906753;6063.939360606338;6075.453209211192;6088.756449741961;6098.939010609837;6117.724702388314;5691.630044047124;5991.310999235144;6025.8192254232445;6174.567780255518;6224.253089629274;5006.324146240211;5980.1328807321825;6042.848928776816;6047.969760151347;6060.939390606038 12:39:02 INFO - PID 1663 | |5;yui.html;708.5359089796185;850.4259624753291;852.1010334097529;852.5694524265245;867.4144952157292;12885.291308978003;15735.92132039341;17292.913535432337;17865.37471188507;18362.35731749389;16942.06818624975;16946.406875759352;17328.393506227254;17590.472285831413;17754.023528705915;959.9568019439124;971.4851128901659;980.8332583460793;981.5386768218925;982.921366290695;987.6888780034302;1001.8998100189996;1001.9649312274072;1002.8595996560488;1003.4832061488303;669.6885948034163;693.4071368979526;995.2088089968456;996.173176263703;1019.2253887045824;987.3039507147444;988.5255077562738;989.6931951095183;990.2573070197352;1027.522202175988;723.0889079759488;723.2405973727565;723.9791893430238;732.4360242613211;751.1962200445525;16090.919545402316;16188.676226475405;16221.513354599381;16282.02307861532;16399.91800040992;16400.343986240536;16524.66950660992;16717.665646686997;16866.83133168677;16946.91526542372;13700.588982330546;13991.790123148161;14022.719545609132;14073.296335183302;14129.576112716635;3397.065806903097;3422.4866270059692;3426.109211605001;3430.451127819537;3431.879884204066;119051;120747.39626301812;120821;121208;122136.38931805373;12030.63908082759;12119.212251203644;12123.454444550016;12127.696807579705;13199.340032998312;24630.13794517183;25298.36754081163;25430;25514.938207415227;26377.736222637526;7965.761027169194;8074.515529068275;8087.47431416956;8096.757097287091;8104.959475202704;3913.8434462621744;3916.236333914916;3923.509561304837;3977.76133431995;4018.3369743991916;4297.441332626801;4345.174416860787;4371.256886329332;4383.890402739957;4405.31717583775;912.8995810460844;917.5504003038463;929.8977112517617;931.6832277025844;935.1256575102166;638.49239854315;641.3266070625824;646.8641585267146;653.7875190563086;686.4714170089004;10617.946910265553;10681.519331630096;11191.32852028881;11849.170558061025;12122.696932576757;650.1385663995226;656.6060363781788;659.8944168933044;665.7869481765788;686.9072675188886;5329;5442.700651464128;5536.61584603849;5653.604247702621;5678.602497825113;92044;98926.5053674727;103764;111997.44001279942;112421.43789281002;92382;92980;92994;94163.52918235365;95575.044249558;85514.57242713746;86834;86937.56531217303;88196.1180388188;88775.22449551102;8988.775280618036;10928.398938058483;11166.88833111691;11326.32042077478;11504.309741415542;42675.4649070181;43037.78481107575;43652.12695746131;43662;44445.55554444414;45095;46154.53845461502;54568.727156363966;54843;55681.72159139178;14205.786913196516;14372.49696260626;14392.640183995065;14429.639259018608;14461.710765784836;14804.925975370053;15268.083914965138;17443.738343924597;18559.16483758207;18803.71794423112;14711.117332960057;15378.923105384401;16967.981921084775;17619.55951101233;17699.82300177033;16727.414540491023;16873.746893796848;17553.473395798148;17649.029303388437;17713;16365.836341636432;16630.25163867653;16639.334426622798;16857.747133792756;16889.648828093475;11565.653030409101;11636.592719255124;11818.29090254553;11833.704157396134;12053;12025.218360806519;12555.623331300076;12624.621261362174;12663.430145643653;12673.310765334489 12:39:02 INFO - PID 1663 | __end_tp_report 12:39:02 INFO - PID 1663 | __start_cc_report 12:39:02 INFO - PID 1663 | _x_x_mozilla_cycle_collect,1756 12:39:02 INFO - PID 1663 | __end_cc_report 12:39:02 INFO - PID 1663 | __startTimestamp1493494742878__endTimestamp 12:39:02 INFO - PID 1663 | 12:39:02 INFO - PID 1663 | ------- Summary: start ------- 12:39:02 INFO - PID 1663 | Number of tests: 6 12:39:02 INFO - PID 1663 | 12:39:02 INFO - PID 1663 | [#0] dojo.html Cycles:165 Average:5998.57 Median:6280.72 stddev:699.34 (11.1%) stddev-sans-first:673.31 12:39:02 INFO - PID 1663 | Values: 3493.7 3495.5 3511.6 3518.3 3579.4 5230.7 5983.0 6100.1 6182.4 6196.5 6123.4 6137.9 6151.6 6162.8 6201.8 5129.6 5179.7 5270.7 5295.5 5368.6 5325.3 5372.6 5391.2 5397.8 5413.7 4410.9 5290.1 5294.3 5297.3 5358.4 5290.4 5290.6 5291.0 5302.6 5317.5 5265.6 5293.2 5326.1 5340.0 5352.4 6144.0 6144.7 6151.1 6160.0 6182.1 6203.5 6484.2 6484.3 6486.3 6499.2 6406.4 6425.0 6504.4 6603.9 6631.9 6246.1 6290.0 6298.9 6319.4 6339.4 6670.1 6690.9 6693.6 6705.1 6712.5 6254.1 6287.0 6324.7 6325.5 6351.7 6465.2 6519.3 6525.3 6528.1 6530.3 6374.4 6380.7 6414.1 6428.5 6439.4 6260.4 6352.2 6446.9 6462.5 6470.5 5137.5 5177.4 5212.5 5217.3 5229.8 4524.4 4646.1 4651.5 4667.9 4692.5 6010.2 6077.5 6104.8 6166.9 6172.0 6379.7 6400.7 6492.1 6590.3 6598.0 6113.4 6151.9 6159.0 6163.7 6170.0 5718.6 5719.4 5723.2 5727.6 5732.4 6398.2 6478.7 6644.2 6721.3 6732.0 6505.3 6568.7 6578.5 6608.3 6612.1 6672.8 6720.1 6733.9 6743.7 6749.6 6264.1 6312.5 6442.8 6454.2 6460.6 6509.9 6562.7 6572.8 6620.7 6624.9 6141.3 6244.9 6332.7 6363.4 6372.9 6270.8 6284.9 6307.4 6311.3 6370.7 6178.3 6288.3 6289.8 6290.0 6306.6 5360.5 5367.2 6165.1 6306.6 6353.5 6280.7 6294.3 6294.6 6306.5 6309.3 12:39:02 INFO - PID 1663 | 12:39:02 INFO - PID 1663 | [#1] ext.html Cycles:180 Average:42850.72 Median:17606.96 stddev:74425.77 (422.7%) stddev-sans-first:74567.31 12:39:02 INFO - PID 1663 | Values: 714.2 760.1 810.5 1122.5 1131.5 25265.9 30476.7 36067.8 36243.3 36277.0 37708.6 37914.4 37973.0 37997.6 38032.0 5915.4 8303.5 8474.1 8481.2 8483.4 5971.1 8291.0 8473.9 8480.1 8489.9 8496.2 8542.4 8543.6 8547.3 8562.5 5862.1 7846.4 8192.2 8516.4 8541.1 5983.3 8183.8 8363.8 8374.2 8380.7 37456.0 37811.6 37824.2 37864.6 37866.6 3675.1 3715.7 3717.6 3718.3 3732.6 30432.8 30591.7 30595.9 30621.5 30673.2 3132.1 3177.2 3207.4 3214.0 3216.7 221176.0 270093.6 270271.0 270645.0 273790.0 46115.0 46218.8 46224.3 46238.1 46246.5 48368.0 48408.0 48426.5 48439.3 48451.8 11926.7 13714.2 13819.9 13820.4 13821.7 9331.5 9375.9 10895.2 11227.3 11242.3 10088.9 12274.4 12401.6 12417.9 12420.7 4728.3 4913.4 5335.4 5426.2 5445.7 1046.1 1049.6 1050.4 1084.4 1090.3 22675.9 23860.6 23873.0 23874.0 23933.0 1115.5 1118.4 1142.1 1152.1 1162.6 11664.4 12044.3 12190.4 12238.0 12256.2 303898.0 304621.0 305740.0 305991.0 306129.0 50079.0 50301.0 50361.0 50422.0 50541.5 1411.1 1537.9 1582.8 1589.2 1596.2 22402.7 23582.6 23682.5 23700.3 23714.9 31417.5 37488.7 37524.4 37625.4 37625.6 281547.0 283035.0 283117.0 283156.0 283314.2 32006.5 33366.5 33481.8 33495.5 33500.8 43263.9 43266.8 43303.0 43406.1 43549.1 27816.3 28980.9 29173.7 30453.4 30485.7 23216.9 29659.4 30197.0 30227.9 30238.7 34560.3 35292.3 35691.3 36044.0 36082.8 28940.9 29480.1 30156.0 30220.2 30521.2 17921.5 20960.4 22288.8 22318.1 22427.0 12:39:02 INFO - PID 1663 | 12:39:02 INFO - PID 1663 | [#2] jquery.html Cycles:180 Average:35088.33 Median:12176.40 stddev:91524.32 (751.7%) stddev-sans-first:91743.99 12:39:02 INFO - PID 1663 | Values: 391.8 398.6 427.3 435.9 443.0 13333.4 15285.2 15821.8 21998.0 22119.6 22103.9 22348.0 22650.8 23185.5 23487.2 5280.6 5741.7 5932.2 6078.3 6078.6 3507.0 6018.3 6059.0 6066.3 6070.2 3642.2 3750.6 6239.5 6244.0 6258.6 5913.4 5921.5 6021.9 6023.9 6025.0 5434.6 5507.8 5512.5 5512.5 5515.7 27859.2 28064.9 28530.0 28618.4 28898.3 2020.9 2206.8 2207.0 2207.9 2208.8 14673.1 14680.6 14874.3 15806.8 17592.1 2094.7 2106.4 2157.8 2159.7 2170.2 133806.0 156870.0 162880.0 163203.0 165767.2 11724.9 12342.4 12390.9 12392.2 12417.7 16677.3 16684.0 16693.3 16700.9 16709.7 8702.3 8935.3 8945.9 8976.4 9091.2 8518.3 8556.1 8625.8 8735.7 8751.6 7578.3 7722.3 7754.5 7762.7 7772.8 1797.7 2079.9 2082.6 2085.9 2233.3 900.7 964.7 965.7 985.7 1002.8 16840.2 19717.0 20121.4 20941.9 21034.5 976.2 992.3 997.3 1023.2 1025.2 9310.0 10136.5 10832.4 10841.6 10841.6 527322.0 534460.0 538749.3 540992.0 544110.0 127934.0 129546.0 130369.7 130406.8 132987.0 1152.3 1174.7 1194.6 1198.6 1200.0 16201.3 17477.0 17764.7 18084.4 18265.6 55001.4 57045.0 57174.7 58403.7 58408.7 78888.0 79813.6 80012.0 80371.0 80476.6 8277.1 8712.4 8846.7 8876.5 8988.2 13683.5 13690.0 14058.6 14081.7 14087.6 11564.9 11702.2 12076.0 12089.8 12131.7 10750.9 10755.7 10963.6 11254.9 11275.4 11471.4 11677.4 11987.9 12057.8 12376.3 8768.4 8791.3 8815.5 8860.2 8868.4 9869.0 11763.5 12014.9 12078.5 12105.2 12:39:02 INFO - PID 1663 | 12:39:02 INFO - PID 1663 | [#3] mootools.html Cycles:180 Average:7052.11 Median:3910.72 stddev:4501.32 (115.1%) stddev-sans-first:4492.96 12:39:02 INFO - PID 1663 | Values: 1266.7 1431.4 1451.6 1454.9 1456.5 11107.3 11592.0 11593.2 11602.4 11614.0 11017.8 11582.2 11699.2 11702.8 11714.2 2499.9 2549.1 2553.2 2553.5 2562.4 2075.6 2397.8 2500.3 2513.9 2519.5 2080.4 2115.1 2137.9 2513.8 2515.0 2444.0 2462.8 2474.2 2474.6 2480.4 2476.2 2484.1 2485.8 2486.8 2487.2 11355.7 11627.7 11632.9 11649.9 11663.3 6513.6 6768.6 6779.2 6786.2 6794.3 3917.8 4127.2 4332.5 4359.0 4366.4 1248.7 1252.6 1284.7 1286.2 1301.4 16320.2 16437.4 16456.0 16461.5 16479.8 5321.5 5390.0 5459.8 5460.3 5552.4 11739.5 11747.7 11749.5 11765.8 11770.4 5635.5 6517.7 6525.5 6535.1 6535.5 6011.8 6199.3 6215.2 6245.6 6282.8 4166.7 4301.9 4310.7 4362.1 4374.2 1077.4 1104.5 1260.6 1273.9 1274.9 630.4 683.2 736.3 806.7 816.5 6476.7 6493.2 6658.8 6743.8 7003.9 596.4 597.9 611.5 616.6 703.5 3903.6 4003.7 4149.6 4270.2 4363.9 14473.9 15022.9 15114.1 15114.9 15200.5 14324.1 14859.4 15071.3 15084.0 15087.4 8445.2 8625.5 8634.8 8648.2 8653.4 5634.3 6676.8 6881.1 7091.5 7153.4 11890.3 12938.9 13471.4 13504.6 13612.7 13649.7 13713.1 13771.7 13894.5 14000.4 8168.0 9187.9 9496.5 9509.3 9514.8 10456.0 10584.8 10618.4 10703.0 10741.4 8868.5 8900.5 9083.0 9126.6 9157.6 8703.8 8858.1 8898.3 8918.7 9000.8 8110.6 8190.9 8192.0 8201.9 8219.9 5610.4 5638.8 5706.6 5775.2 5793.4 5704.0 5907.1 6010.3 6045.1 6166.7 12:39:02 INFO - PID 1663 | 12:39:02 INFO - PID 1663 | [#4] prototype.html Cycles:180 Average:4922.80 Median:5653.53 stddev:1563.98 (27.7%) stddev-sans-first:1530.63 12:39:02 INFO - PID 1663 | Values: 372.8 384.8 407.4 407.9 408.2 5843.9 5872.8 5895.0 5930.9 6095.2 5358.8 5512.6 5636.3 5764.8 5778.9 4196.8 4214.2 4215.6 4222.4 4236.4 3956.8 4152.8 4221.8 4232.9 4237.8 3518.7 3854.5 3861.8 4198.6 4227.9 3510.4 4192.0 4194.0 4198.6 4209.3 3457.8 3621.3 3625.1 3634.9 3644.4 5079.9 5450.8 5572.3 5603.9 5625.5 4568.8 4642.9 4962.5 4964.7 4970.6 5395.3 5432.7 6092.2 6118.0 6157.3 4037.8 4080.7 4105.5 4134.6 4146.6 6089.0 6128.7 6265.3 6398.6 6456.6 3599.4 4083.5 4108.1 4120.2 4129.4 3855.5 3931.5 3995.7 4188.9 4193.7 4149.3 4805.2 4858.9 4859.6 4869.3 6108.4 6116.0 6138.0 6144.9 6188.4 1268.9 1281.4 1305.9 1356.0 1401.1 920.9 923.5 939.8 941.8 941.8 5010.4 5651.3 5715.7 5742.7 5769.0 6342.0 6357.0 6363.6 6371.3 6406.6 5526.3 5648.2 5659.4 5736.8 5748.7 2830.9 3289.2 3292.2 3301.8 3322.0 5507.3 5744.7 6249.2 6423.4 6447.5 5813.8 6254.2 6491.4 6497.5 6549.9 5695.7 6431.6 6530.7 6532.1 6536.4 5609.9 5814.3 6076.9 6308.9 6325.3 5353.4 5655.8 6021.6 6122.8 6161.6 6370.2 6515.3 6552.3 6553.3 6588.2 3460.3 3940.2 4094.4 4108.8 4109.5 4849.0 5417.6 6286.5 6337.0 6384.4 5788.5 6067.0 6077.1 6133.3 6160.9 5452.9 5837.4 6022.9 6161.5 6191.8 6063.9 6075.5 6088.8 6098.9 6117.7 5691.6 5991.3 6025.8 6174.6 6224.3 5006.3 5980.1 6042.8 6048.0 6060.9 12:39:02 INFO - PID 1663 | 12:39:02 INFO - PID 1663 | [#5] yui.html Cycles:180 Average:21661.69 Median:25472.47 stddev:30641.10 (120.3%) stddev-sans-first:30686.66 12:39:02 INFO - PID 1663 | Values: 708.5 850.4 852.1 852.6 867.4 12885.3 15735.9 17292.9 17865.4 18362.4 16942.1 16946.4 17328.4 17590.5 17754.0 960.0 971.5 980.8 981.5 982.9 987.7 1001.9 1002.0 1002.9 1003.5 669.7 693.4 995.2 996.2 1019.2 987.3 988.5 989.7 990.3 1027.5 723.1 723.2 724.0 732.4 751.2 16090.9 16188.7 16221.5 16282.0 16399.9 16400.3 16524.7 16717.7 16866.8 16946.9 13700.6 13991.8 14022.7 14073.3 14129.6 3397.1 3422.5 3426.1 3430.5 3431.9 119051.0 120747.4 120821.0 121208.0 122136.4 12030.6 12119.2 12123.5 12127.7 13199.3 24630.1 25298.4 25430.0 25514.9 26377.7 7965.8 8074.5 8087.5 8096.8 8105.0 3913.8 3916.2 3923.5 3977.8 4018.3 4297.4 4345.2 4371.3 4383.9 4405.3 912.9 917.6 929.9 931.7 935.1 638.5 641.3 646.9 653.8 686.5 10617.9 10681.5 11191.3 11849.2 12122.7 650.1 656.6 659.9 665.8 686.9 5329.0 5442.7 5536.6 5653.6 5678.6 92044.0 98926.5 103764.0 111997.4 112421.4 92382.0 92980.0 92994.0 94163.5 95575.0 85514.6 86834.0 86937.6 88196.1 88775.2 8988.8 10928.4 11166.9 11326.3 11504.3 42675.5 43037.8 43652.1 43662.0 44445.6 45095.0 46154.5 54568.7 54843.0 55681.7 14205.8 14372.5 14392.6 14429.6 14461.7 14804.9 15268.1 17443.7 18559.2 18803.7 14711.1 15378.9 16968.0 17619.6 17699.8 16727.4 16873.7 17553.5 17649.0 17713.0 16365.8 16630.3 16639.3 16857.7 16889.6 11565.7 11636.6 11818.3 11833.7 12053.0 12025.2 12555.6 12624.6 12663.4 12673.3 12:39:02 INFO - PID 1663 | -------- Summary: end -------- 12:39:02 INFO - PID 1663 | 12:39:03 INFO - TEST-INFO | 1663: exit 0 12:39:03 INFO - TEST-OK | dromaeo_css | took 1119753ms 12:39:03 INFO - TEST-START | kraken 12:39:03 INFO - operating with platform_type : mac_ 12:39:03 INFO - Initialising browser for kraken test... 12:39:03 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpwpilmp/profile http://localhost:49239/getInfo.html) 12:39:06 INFO - PID 1672 | __metrics Screen width/height:1600/1200 12:39:06 INFO - PID 1672 | colorDepth:24 12:39:06 INFO - PID 1672 | Browser inner width/height: 1024/689 12:39:06 INFO - PID 1672 | __metrics 12:39:06 INFO - PID 1672 | 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" 12:39:06 INFO - PID 1672 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:39:07 INFO - TEST-INFO | 1672: exit 0 12:39:07 INFO - Browser initialized. 12:39:07 INFO - Running cycle 1/1 for kraken test... 12:39:07 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpwpilmp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:39:19 INFO - PID 1673 | RSS: Main: 240885760 12:39:19 INFO - PID 1673 | 12:39:22 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection) 12:39:23 INFO - PID 1673 | RSS: Main: 310173696 12:39:23 INFO - PID 1673 | 12:39:25 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-dft) 12:39:26 INFO - PID 1673 | RSS: Main: 293859328 12:39:26 INFO - PID 1673 | 12:39:29 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-fft) 12:39:30 INFO - PID 1673 | RSS: Main: 387088384 12:39:30 INFO - PID 1673 | 12:39:32 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator) 12:39:32 INFO - PID 1673 | RSS: Main: 288944128 12:39:32 INFO - PID 1673 | 12:39:34 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:39:35 INFO - PID 1673 | RSS: Main: 291643392 12:39:35 INFO - PID 1673 | 12:39:38 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom) 12:39:39 INFO - PID 1673 | RSS: Main: 356642816 12:39:39 INFO - PID 1673 | 12:39:41 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate) 12:39:42 INFO - PID 1673 | RSS: Main: 369225728 12:39:42 INFO - PID 1673 | 12:39:45 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial) 12:39:46 INFO - PID 1673 | RSS: Main: 372125696 12:39:46 INFO - PID 1673 | 12:39:47 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:39:48 INFO - PID 1673 | RSS: Main: 331161600 12:39:48 INFO - PID 1673 | 12:39:49 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:39:50 INFO - PID 1673 | RSS: Main: 332357632 12:39:50 INFO - PID 1673 | 12:39:52 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:39:53 INFO - PID 1673 | RSS: Main: 335831040 12:39:53 INFO - PID 1673 | 12:39:56 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:39:56 INFO - PID 1673 | RSS: Main: 351866880 12:39:56 INFO - PID 1673 | 12:39:59 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:40:00 INFO - PID 1673 | RSS: Main: 344805376 12:40:00 INFO - PID 1673 | 12:40:02 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49239/tests/kraken/driver.html?testName=ai-astar) 12:40:02 INFO - PID 1673 | RSS: Main: 388046848 12:40:02 INFO - PID 1673 | 12:40:02 INFO - PID 1673 | __start_tp_report 12:40:02 INFO - PID 1673 | _x_x_mozilla_page_load 12:40:02 INFO - PID 1673 | _x_x_mozilla_page_load_details 12:40:02 INFO - PID 1673 | |i|pagename|runs| 12:40:02 INFO - PID 1673 | |0;ai-astar;111;115;153;154;115;109;110;110;111;110 12:40:02 INFO - PID 1673 | |1;audio-beat-detection;141;108;107;148;111;105;108;107;133;106 12:40:02 INFO - PID 1673 | |2;audio-dft;187;182;181;185;184;184;183;185;182;185 12:40:02 INFO - PID 1673 | |3;audio-fft;76;80;53;77;49;48;79;78;97;76 12:40:02 INFO - PID 1673 | |4;audio-oscillator;86;69;85;70;85;94;105;93;68;95 12:40:02 INFO - PID 1673 | |5;imaging-gaussian-blur;88;89;88;89;89;88;89;89;89;88 12:40:02 INFO - PID 1673 | |6;imaging-darkroom;95;95;95;94;94;95;96;95;94;95 12:40:02 INFO - PID 1673 | |7;imaging-desaturate;84;90;136;93;83;85;86;84;86;93 12:40:02 INFO - PID 1673 | |8;json-parse-financial;45;46;46;47;48;47;48;47;48;47 12:40:02 INFO - PID 1673 | |9;json-stringify-tinderbox;53;59;57;61;52;55;57;57;55;56 12:40:02 INFO - PID 1673 | |10;stanford-crypto-aes;83;81;80;82;84;82;83;81;83;82 12:40:02 INFO - PID 1673 | |11;stanford-crypto-ccm;137;137;136;137;135;133;137;134;177;150 12:40:02 INFO - PID 1673 | |12;stanford-crypto-pbkdf2;182;224;183;183;180;177;184;179;178;193 12:40:02 INFO - PID 1673 | |13;stanford-crypto-sha256-iterative;66;68;67;66;67;69;67;67;67;67 12:40:02 INFO - PID 1673 | __end_tp_report 12:40:02 INFO - PID 1673 | __start_cc_report 12:40:02 INFO - PID 1673 | _x_x_mozilla_cycle_collect,2190 12:40:02 INFO - PID 1673 | __end_cc_report 12:40:02 INFO - PID 1673 | __startTimestamp1493494802538__endTimestamp 12:40:02 INFO - PID 1673 | 12:40:02 INFO - PID 1673 | ------- Summary: start ------- 12:40:02 INFO - PID 1673 | Number of tests: 14 12:40:02 INFO - PID 1673 | 12:40:02 INFO - PID 1673 | [#0] ai-astar Cycles:10 Average:119.80 Median:113.00 stddev:17.88 (15.8%) stddev-sans-first:18.68 12:40:02 INFO - PID 1673 | Values: 111.0 115.0 153.0 154.0 115.0 109.0 110.0 110.0 111.0 110.0 12:40:02 INFO - PID 1673 | 12:40:02 INFO - PID 1673 | [#1] audio-beat-detection Cycles:10 Average:117.40 Median:109.50 stddev:16.51 (15.1%) stddev-sans-first:15.15 12:40:02 INFO - PID 1673 | Values: 141.0 108.0 107.0 148.0 111.0 105.0 108.0 107.0 133.0 106.0 12:40:02 INFO - PID 1673 | 12:40:02 INFO - PID 1673 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.50 stddev:1.81 (1.0%) stddev-sans-first:1.51 12:40:02 INFO - PID 1673 | Values: 187.0 182.0 181.0 185.0 184.0 184.0 183.0 185.0 182.0 185.0 12:40:02 INFO - PID 1673 | 12:40:02 INFO - PID 1673 | [#3] audio-fft Cycles:10 Average:71.30 Median:77.50 stddev:15.96 (20.6%) stddev-sans-first:16.84 12:40:02 INFO - PID 1673 | Values: 76.0 80.0 53.0 77.0 49.0 48.0 79.0 78.0 97.0 76.0 12:40:02 INFO - PID 1673 | 12:40:02 INFO - PID 1673 | [#4] audio-oscillator Cycles:10 Average:85.00 Median:85.50 stddev:12.54 (14.7%) stddev-sans-first:13.30 12:40:02 INFO - PID 1673 | Values: 86.0 69.0 85.0 70.0 85.0 94.0 105.0 93.0 68.0 95.0 12:40:02 INFO - PID 1673 | 12:40:02 INFO - PID 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:89.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 12:40:02 INFO - PID 1673 | Values: 88.0 89.0 88.0 89.0 89.0 88.0 89.0 89.0 89.0 88.0 12:40:02 INFO - PID 1673 | 12:40:02 INFO - PID 1673 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 12:40:02 INFO - PID 1673 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 96.0 95.0 94.0 95.0 12:40:02 INFO - PID 1673 | 12:40:02 INFO - PID 1673 | [#7] imaging-desaturate Cycles:10 Average:92.00 Median:86.00 stddev:15.89 (18.5%) stddev-sans-first:16.59 12:40:02 INFO - PID 1673 | Values: 84.0 90.0 136.0 93.0 83.0 85.0 86.0 84.0 86.0 93.0 12:40:02 INFO - PID 1673 | 12:40:02 INFO - PID 1673 | [#8] json-parse-financial Cycles:10 Average:46.90 Median:47.00 stddev:0.99 (2.1%) stddev-sans-first:0.78 12:40:02 INFO - PID 1673 | Values: 45.0 46.0 46.0 47.0 48.0 47.0 48.0 47.0 48.0 47.0 12:40:02 INFO - PID 1673 | 12:40:02 INFO - PID 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:56.20 Median:57.00 stddev:2.66 (4.7%) stddev-sans-first:2.55 12:40:02 INFO - PID 1673 | Values: 53.0 59.0 57.0 61.0 52.0 55.0 57.0 57.0 55.0 56.0 12:40:02 INFO - PID 1673 | 12:40:02 INFO - PID 1673 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.50 stddev:1.20 (1.5%) stddev-sans-first:1.22 12:40:02 INFO - PID 1673 | Values: 83.0 81.0 80.0 82.0 84.0 82.0 83.0 81.0 83.0 82.0 12:40:02 INFO - PID 1673 | 12:40:02 INFO - PID 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:141.30 Median:137.00 stddev:13.39 (9.8%) stddev-sans-first:14.11 12:40:02 INFO - PID 1673 | Values: 137.0 137.0 136.0 137.0 135.0 133.0 137.0 134.0 177.0 150.0 12:40:02 INFO - PID 1673 | 12:40:02 INFO - PID 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.30 Median:183.00 stddev:13.98 (7.6%) stddev-sans-first:14.75 12:40:02 INFO - PID 1673 | Values: 182.0 224.0 183.0 183.0 180.0 177.0 184.0 179.0 178.0 193.0 12:40:02 INFO - PID 1673 | 12:40:02 INFO - PID 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 12:40:02 INFO - PID 1673 | Values: 66.0 68.0 67.0 66.0 67.0 69.0 67.0 67.0 67.0 67.0 12:40:02 INFO - PID 1673 | -------- Summary: end -------- 12:40:02 INFO - PID 1673 | 12:40:03 INFO - TEST-INFO | 1673: exit 0 12:40:03 INFO - TEST-OK | kraken | took 60066ms 12:40:03 INFO - SUITE-END | took 1179s 12:40:03 INFO - Completed test suite (00:19:39) 12:40:03 INFO - javascript benchmark 12:40:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7620.657366068943, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3493.7030352420043, 3495.475678648204, 3511.5786105667326, 3518.3315170117685, 3579.355715971124, 5230.686158830473, 5982.970085149579, 6100.145979562853, 6182.443580077792, 6196.504279657628, 6123.448889599935, 6137.907931381022, 6151.631621825596, 6162.7534898604, 6201.782937597185, 5129.6409251352425, 5179.741012949356, 5270.683758974455, 5295.4704529547125, 5368.62419630626, 5325.3077099976945, 5372.623916325859, 5391.218273350361, 5397.78408863645, 5413.702246376448, 4410.933835992462, 5290.100682883919, 5294.285271488338, 5297.337832770903, 5358.383785864617, 5290.418054014055, 5290.629655924087, 5290.973545132289, 5302.628815982883, 5317.494837990384, 5265.631405801595, 5293.153095504739, 5326.094563924142, 5339.9733001335135, 5352.437994010612, 6144.0, 6144.723487443031, 6151.108089327023, 6160.0, 6182.072689096626, 6203.534734894901, 6484.221893372825, 6484.254310754276, 6486.318936511692, 6499.1876015498065, 6406.391392817675, 6424.967875160641, 6504.38208370204, 6603.867922641521, 6631.900521492182, 6246.125542424064, 6289.968550157266, 6298.874022519524, 6319.399657032574, 6339.397757213057, 6670.132882725312, 6690.933090669031, 6693.598384096969, 6705.09481220029, 6712.463002959751, 6254.061890716429, 6287.0, 6324.683765811691, 6325.462335701425, 6351.68241587928, 6465.224173099258, 6519.3154718754795, 6525.3474652535315, 6528.08606795049, 6530.346965303526, 6374.426301632875, 6380.680965951684, 6414.102025716404, 6428.485721142298, 6439.388258115471, 6260.436560709558, 6352.205974253218, 6446.935530644633, 6462.48300135988, 6470.45001174896, 5137.537621614073, 5177.404598471224, 5212.478752124757, 5217.295665085165, 5229.790808367698, 4524.389207457017, 4646.070785842845, 4651.511591282934, 4667.8599642010795, 4692.4603670577635, 6010.188624535719, 6077.453029227302, 6104.816855494253, 6166.8899598071885, 6171.9691401542705, 6379.744810207632, 6400.679966001681, 6492.058651495507, 6590.275069742324, 6598.0, 6113.385090542009, 6151.876962460726, 6159.0, 6163.691815409212, 6170.0, 5718.628289161191, 5719.399463056402, 5723.198752174699, 5727.627704199297, 5732.369439361667, 6398.168238129014, 6478.676066196577, 6644.235912870082, 6721.327867213239, 6732.023856540676, 6505.31694172124, 6568.671566421755, 6578.539502234989, 6608.306127856506, 6612.107365505595, 6672.799816005528, 6720.126383570105, 6733.93266067333, 6743.696533655899, 6749.595024298558, 6264.060390941395, 6312.526560508072, 6442.8389290268115, 6454.1609590752905, 6460.612363258219, 6509.8698026040165, 6562.737490500326, 6572.8356791080605, 6620.702068407029, 6624.9337506624315, 6141.271221159771, 6244.875102498016, 6332.651704156131, 6363.395477429637, 6372.87254254903, 6270.811875643738, 6284.905726414199, 6307.432331090224, 6311.337309582428, 6370.74517019314, 6178.289496707756, 6288.308286088618, 6289.842753931005, 6290.025046117859, 6306.621602703853, 5360.517553420055, 5367.194920761761, 6165.075238714228, 6306.590071645512, 6353.459955903615, 6280.717367718555, 6294.339094395023, 6294.622322660655, 6306.4639505642535, 6309.305976342507], "value": 5952.31674565012, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.2036629158488, 760.1144666463567, 810.4772421787947, 1122.4724379541617, 1131.4569006876704, 25265.873670631645, 30476.69523304769, 36067.81966090169, 36243.27513449736, 36277.0, 37708.62291377085, 37914.43128353077, 37972.999999999935, 37997.620023799755, 38032.0, 5915.438033386821, 8303.543305118215, 8474.11021842707, 8481.194286542768, 8483.406161568693, 5971.104334349839, 8291.0, 8473.872891906627, 8480.067192608809, 8489.872651910226, 8496.235338819504, 8542.402031857773, 8543.57282135894, 8547.316214702809, 8562.529060901648, 5862.091375836752, 7846.372290216769, 8192.18078192182, 8516.446430981967, 8541.14588541141, 5983.311919129313, 8183.836323273561, 8363.790905227357, 8374.246317831425, 8380.664773409057, 37456.0, 37811.62188378136, 37824.24351512954, 37864.62135378639, 37866.62133378686, 3675.1363429594026, 3715.6841668458214, 3717.6282371762877, 3718.312112259214, 3732.64539868712, 30432.847835760902, 30591.69408305933, 30595.92914248013, 30621.540676889643, 30673.233169170726, 3132.1386618679817, 3177.205698575356, 3207.3905957868164, 3213.96786032139, 3216.662250463691, 221176.0, 270093.64953175304, 270271.0, 270645.0, 273790.0, 46115.0, 46218.76890615525, 46224.3066354005, 46238.075238495716, 46246.5375346249, 48368.0, 48408.0, 48426.54720358395, 48439.273410898866, 48451.75774121107, 11926.701832454259, 13714.24571648549, 13819.930900345635, 13820.37808298629, 13821.654458638615, 9331.486768227813, 9375.90624093764, 10895.237333386587, 11227.326360418401, 11242.325460472397, 10088.949555252324, 12274.4476498556, 12401.62795116148, 12417.875821241672, 12420.689482762822, 4728.338032675429, 4913.385826771653, 5335.3864305604575, 5426.163034576462, 5445.700486473203, 1046.1421634259987, 1049.569676432659, 1050.3540322701483, 1084.38732116354, 1090.2967585907045, 22675.88662056679, 23860.64209036866, 23873.0, 23874.0, 23933.0, 1115.5091759625739, 1118.3625333559955, 1142.0520967596874, 1152.1071169843437, 1162.6279590530949, 11664.416779161009, 12044.33756143403, 12190.390480476119, 12237.959773419181, 12256.203346782431, 303898.0, 304621.0, 305740.0, 305991.0, 306129.0, 50079.0, 50300.999999999265, 50360.992780144195, 50422.0, 50541.483755487396, 1411.1321537254514, 1537.9154146521826, 1582.8179759327595, 1589.173629712543, 1596.2098761113323, 22402.66396004094, 23582.646260305766, 23682.526349473257, 23700.288991330286, 23714.88142559276, 31417.52873706942, 37488.68789592351, 37524.43713344247, 37625.4356184652, 37625.62374376221, 281547.0, 283035.0, 283117.0, 283156.0, 283314.1668583288, 32006.51990220195, 33366.499502506995, 33481.83259083689, 33495.49756753602, 33500.83249583736, 43263.9184020402, 43266.783666081465, 43303.0, 43406.131877361644, 43549.129017420106, 27816.304592385353, 28980.855095724386, 29173.7082629171, 30453.390932180788, 30485.69514304917, 23216.88391558099, 29659.380474597452, 30197.0, 30227.94202203, 30238.69761302359, 34560.308793824486, 35292.29415411626, 35691.28617427689, 36044.0, 36082.8195859019, 28940.855295723388, 29480.115596532138, 30156.0, 30220.24449388783, 30521.23696907595, 17921.462356129337, 20960.37118886436, 22288.77711222867, 22318.10727570879, 22427.0], "value": 16832.79872534134, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.82367934429516, 398.57750784168763, 427.3377157758015, 435.8866694659388, 442.9645628349732, 13333.399997000133, 15285.159316237603, 15821.762673559877, 21998.0, 22119.557608847834, 22103.89480525975, 22348.0, 22650.77349226507, 23185.536289274205, 23487.177948771798, 5280.577553795706, 5741.712914354286, 5932.199153114318, 6078.300995385543, 6078.635281883101, 3506.9649303506894, 6018.3078945921125, 6058.96970515149, 6066.302375226861, 6070.18052562905, 3642.1805093853936, 3750.606186350421, 6239.469645080174, 6243.968780156093, 6258.62448253104, 5913.379095195007, 5921.496672782819, 6021.879562408771, 6023.939760602404, 6024.96987515064, 5434.565234781208, 5507.807226747084, 5512.476314750093, 5512.531434828044, 5515.7242137892945, 27859.16422507328, 28064.85967570149, 28530.0, 28618.427631447463, 28898.27754306138, 2020.8585399022074, 2206.801387875083, 2206.9958169033052, 2207.8896055197174, 2208.7901649343285, 14673.073280631661, 14680.623456604933, 14874.330655120546, 15806.814488913378, 17592.12039398025, 2094.6962690409805, 2106.3891471473253, 2157.795009474113, 2159.6976423300753, 2170.1861801824316, 133806.0, 156870.0, 162880.0, 163203.0, 165767.1711641434, 11724.88275117255, 12342.382880855921, 12390.88482036603, 12392.194507356993, 12417.689557761129, 16677.332906683838, 16683.998960062436, 16693.332266709196, 16700.916495417445, 16709.746768992376, 8702.260307873901, 8935.33676911352, 8945.910540894507, 8976.41653292547, 9091.227245684058, 8518.275946544489, 8556.101609331055, 8625.827483450295, 8735.650573977096, 8751.649934002697, 7578.317951384402, 7722.3436007938835, 7754.457187996899, 7762.650680719381, 7772.82360938938, 1797.730340448943, 2079.8856062916684, 2082.6043051820106, 2085.9061342239333, 2233.251860626676, 900.7342833864026, 964.6720115160879, 965.6861520006026, 985.6500942165571, 1002.8295189817749, 16840.24218910152, 19716.977374123577, 20121.39635810928, 20941.89529052345, 21034.47413814636, 976.1605019683067, 992.3202606214766, 997.2769741937183, 1023.1661196125134, 1025.220832167558, 9310.0, 10136.493175341204, 10832.350058996328, 10841.566337346418, 10841.620543280947, 527322.0, 534460.0, 538749.2875498756, 540992.0, 544110.0, 127934.0, 129546.0, 130369.69630303765, 130406.83083875764, 132987.0, 1152.2798251093068, 1174.747429302687, 1194.5699548162654, 1198.5804968261214, 1200.0339726520235, 16201.32678108099, 17477.038762867654, 17764.733528996818, 18084.367047153286, 18265.634687306447, 55001.44998549963, 57045.0, 57174.7141264291, 58403.70798145982, 58408.70795645995, 78888.0, 79813.60093199497, 80012.0, 80371.0, 80476.59761701155, 8277.089520152898, 8712.39013269065, 8846.682494064726, 8876.51179185151, 8988.191062804379, 13683.452661893412, 13690.04169708111, 14058.578242652737, 14081.718365632834, 14087.577372678836, 11564.94217528907, 11702.239354441934, 12076.0, 12089.75820483603, 12131.696707582381, 10750.946245268724, 10755.677329680122, 10963.56145754161, 11254.94372528132, 11275.379854108103, 11471.369074700971, 11677.357745324089, 11987.940060299643, 12057.819132713192, 12376.257424554555, 8768.386212965032, 8791.296696264411, 8815.471071735716, 8860.246879015356, 8868.423552469068, 9868.950655246677, 11763.529458821893, 12014.879851201726, 12078.456469459072, 12105.213161144497], "value": 10184.253528676145, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1266.6769973656717, 1431.413120620546, 1451.579042077797, 1454.8763355114816, 1456.482948553263, 11107.278026928254, 11592.0, 11593.246438981481, 11602.419879006058, 11614.012808911231, 11017.779644407126, 11582.247153934988, 11699.239549429281, 11702.824457633142, 11714.238574492652, 2499.8750062496892, 2549.0950712497074, 2553.182981445938, 2553.4510080332725, 2562.449073449208, 2075.6367635663773, 2397.760223977597, 2500.2624225853324, 2513.9120130795427, 2519.496100779842, 2080.3758872338312, 2115.122224276923, 2137.8824164670937, 2513.836600620963, 2515.0317127905796, 2443.987780061106, 2462.7660372264695, 2474.1711526638596, 2474.5545801755675, 2480.441900572375, 2476.1828596563273, 2484.1181380609805, 2485.763852434016, 2486.8010559155223, 2487.2289590227088, 11355.659330220107, 11627.6511704649, 11632.941835290854, 11649.941750291278, 11663.300201987908, 6513.576617519893, 6768.593884366954, 6779.15260592426, 6786.151731033621, 6794.320567943166, 3917.823697933571, 4127.174565086964, 4332.545082766295, 4359.04101097758, 4366.410534577855, 1248.7377650693365, 1252.6179515247845, 1284.6980959474515, 1286.2411177405281, 1301.4338762638283, 16320.183990800531, 16437.424690135787, 16456.012639241682, 16461.506154815375, 16479.752803707954, 5321.521063104339, 5390.0, 5459.781608735686, 5460.34475862899, 5552.361478429952, 11739.530418783324, 11747.706307342385, 11749.4712737927, 11765.764684706259, 11770.411479425995, 5635.464630860061, 6517.706703198368, 6525.510586706016, 6535.085088087577, 6535.509836762262, 6011.849703757441, 6199.256089269316, 6215.160953271341, 6245.594036387711, 6282.842928926722, 4166.708330416842, 4301.935470967938, 4310.741355518679, 4362.083962367875, 4374.234508960919, 1077.4343469678324, 1104.4753741972659, 1260.615512268767, 1273.9490420383265, 1274.9426275817611, 630.369816959281, 683.2074793239818, 736.3372964332144, 806.6692656011124, 816.481534225759, 6476.740930362827, 6493.188351456068, 6658.800235992928, 6743.797686069426, 7003.92996070043, 596.436367632583, 597.9402059793986, 611.4619135161118, 616.5776443136466, 703.5040296590892, 3903.6096390360735, 4003.679705623543, 4149.585041495887, 4270.231358355526, 4363.890902727458, 14473.85526144725, 15022.924885375503, 15114.09315441077, 15114.94195406311, 15200.46798362052, 14324.14055156694, 14859.405623774928, 15071.321790519452, 15084.0, 15087.396504139931, 8445.1977062179, 8625.52559609215, 8634.827303454022, 8648.1784230498, 8653.394262401698, 5634.267545219259, 6676.799696009128, 6881.13985751781, 7091.539049961736, 7153.427725781821, 11890.346030968034, 12938.935305323414, 13471.393787279792, 13504.594862154152, 13612.65968350799, 13649.727005460034, 13713.108647937852, 13771.724565508433, 13894.513692020731, 14000.43998240059, 8167.959160204161, 9187.908120918974, 9496.525173741147, 9509.334346595948, 9514.762130946781, 10456.006679365448, 10584.841227381441, 10618.36289822613, 10703.036726694634, 10741.355518668905, 8868.467891926504, 8900.465972041698, 9083.0, 9126.634934602542, 9157.587908543997, 8703.825923481369, 8858.11418858109, 8898.288136949159, 8918.73243802687, 9000.774980625536, 8110.5944702763445, 8190.918090819016, 8191.959040204761, 8201.917980820115, 8219.917800821915, 5610.354809196994, 5638.802641907513, 5706.600537962303, 5775.1914731938405, 5793.449622285876, 5703.971480142573, 5907.084401917709, 6010.278766548042, 6045.063015232646, 6166.722497487714], "value": 5261.847406386346, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.7912369073319, 384.79798105994365, 407.35434336576526, 407.87355919664924, 408.16937532122137, 5843.941560584398, 5872.76508939643, 5894.970525147379, 5930.894532440986, 6095.238095238095, 5358.812441564546, 5512.641678290908, 5636.2954630671165, 5764.7982320618785, 5778.942210577893, 4196.769177695225, 4214.157168566284, 4215.620594146526, 4222.429971953778, 4236.40690303357, 3956.76259424434, 4152.774931395231, 4221.831126754926, 4232.936505952413, 4237.7669228192435, 3518.7009104226045, 3854.4603755474254, 3861.822144246004, 4198.559151289117, 4227.894302642443, 3510.368133735914, 4192.0, 4193.993441574031, 4198.6431153352005, 4209.2633789086785, 3457.772490765792, 3621.2576421833724, 3625.1299688074673, 3634.909127271813, 3644.4351125575577, 5079.891844884369, 5450.836474905759, 5572.275604171432, 5603.859903502404, 5625.5218306444, 4568.771561421949, 4642.883927901829, 4962.528559786851, 4964.702117872939, 4970.627202959792, 5395.325584301962, 5432.728363581845, 6092.238470191226, 6117.969410152965, 6157.322694503601, 4037.818298176589, 4080.6735461163034, 4105.486814148231, 4134.607212314825, 4146.647534959532, 6089.0, 6128.724207410677, 6265.2770488115675, 6398.616083035033, 6456.644884531349, 3599.3521166190335, 4083.4895638045246, 4108.055147316134, 4120.1553681495825, 4129.421880936671, 3855.51806024247, 3931.5282166140246, 3995.680345572347, 4188.895277618084, 4193.6645068394455, 4149.2738770715005, 4805.1590971579835, 4858.927116093261, 4859.586935110555, 4869.269609558594, 6108.419700128481, 6116.003158452415, 6137.987232106741, 6144.938550614526, 6188.412100850502, 1268.9428975696117, 1281.4425724809737, 1305.8573747970527, 1356.0, 1401.1453013661658, 920.9493477858782, 923.4690053219425, 939.7885475767897, 941.7692665296909, 941.7928055827707, 5010.448850626428, 5651.265335506358, 5715.656101362911, 5742.684152371576, 5768.9711551442815, 6341.968290158612, 6357.014662727284, 6363.568197155695, 6371.33101024395, 6406.6476343800605, 5526.253955716007, 5648.15277708347, 5659.405762394971, 5736.799212027559, 5748.683822389725, 2830.9433811323656, 3289.161263877696, 3292.2098696312714, 3301.8043001404276, 3321.983390083034, 5507.311586051744, 5744.712764361765, 6249.2192223704915, 6423.357664233539, 6447.516436267299, 5813.82558523245, 6254.21822272216, 6491.415772580396, 6497.480201583862, 6549.901751473732, 5695.686737229492, 6431.646259455775, 6530.706118224596, 6532.118164047888, 6536.444402225864, 5609.859753506195, 5814.342912269983, 6076.933842493397, 6308.905366419599, 6325.335839736761, 5353.384360798558, 5655.802046928337, 6021.591363454653, 6122.755089796537, 6161.599496032743, 6370.1718776558755, 6515.315891831289, 6552.3447655234095, 6553.279139294769, 6588.242352129567, 3460.290640418658, 3940.15286713358, 4094.3653733671326, 4108.835646574224, 4109.486314210723, 4849.0, 5417.5665946723375, 6286.5168258536705, 6337.0, 6384.3934826191435, 5788.507976822018, 6066.969665151646, 6077.11881777131, 6133.26400831903, 6160.9383906160365, 5452.91820622683, 5837.445442682938, 6022.939770602238, 6161.537884658758, 6191.752329906753, 6063.939360606338, 6075.453209211192, 6088.756449741961, 6098.939010609837, 6117.724702388314, 5691.630044047124, 5991.310999235144, 6025.8192254232445, 6174.567780255518, 6224.253089629274, 5006.324146240211, 5980.1328807321825, 6042.848928776816, 6047.969760151347, 6060.939390606038], "value": 4435.277641545145, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.5359089796185, 850.4259624753291, 852.1010334097529, 852.5694524265245, 867.4144952157292, 12885.291308978003, 15735.92132039341, 17292.913535432337, 17865.37471188507, 18362.35731749389, 16942.06818624975, 16946.406875759352, 17328.393506227254, 17590.472285831413, 17754.023528705915, 959.9568019439124, 971.4851128901659, 980.8332583460793, 981.5386768218925, 982.921366290695, 987.6888780034302, 1001.8998100189996, 1001.9649312274072, 1002.8595996560488, 1003.4832061488303, 669.6885948034163, 693.4071368979526, 995.2088089968456, 996.173176263703, 1019.2253887045824, 987.3039507147444, 988.5255077562738, 989.6931951095183, 990.2573070197352, 1027.522202175988, 723.0889079759488, 723.2405973727565, 723.9791893430238, 732.4360242613211, 751.1962200445525, 16090.919545402316, 16188.676226475405, 16221.513354599381, 16282.02307861532, 16399.91800040992, 16400.343986240536, 16524.66950660992, 16717.665646686997, 16866.83133168677, 16946.91526542372, 13700.588982330546, 13991.790123148161, 14022.719545609132, 14073.296335183302, 14129.576112716635, 3397.065806903097, 3422.4866270059692, 3426.109211605001, 3430.451127819537, 3431.879884204066, 119051.0, 120747.39626301812, 120821.0, 121208.0, 122136.38931805373, 12030.63908082759, 12119.212251203644, 12123.454444550016, 12127.696807579705, 13199.340032998312, 24630.13794517183, 25298.36754081163, 25430.0, 25514.938207415227, 26377.736222637526, 7965.761027169194, 8074.515529068275, 8087.47431416956, 8096.757097287091, 8104.959475202704, 3913.8434462621744, 3916.236333914916, 3923.509561304837, 3977.76133431995, 4018.3369743991916, 4297.441332626801, 4345.174416860787, 4371.256886329332, 4383.890402739957, 4405.31717583775, 912.8995810460844, 917.5504003038463, 929.8977112517617, 931.6832277025844, 935.1256575102166, 638.49239854315, 641.3266070625824, 646.8641585267146, 653.7875190563086, 686.4714170089004, 10617.946910265553, 10681.519331630096, 11191.32852028881, 11849.170558061025, 12122.696932576757, 650.1385663995226, 656.6060363781788, 659.8944168933044, 665.7869481765788, 686.9072675188886, 5329.0, 5442.700651464128, 5536.61584603849, 5653.604247702621, 5678.602497825113, 92044.0, 98926.5053674727, 103764.0, 111997.44001279942, 112421.43789281002, 92382.0, 92980.0, 92994.0, 94163.52918235365, 95575.044249558, 85514.57242713746, 86834.0, 86937.56531217303, 88196.1180388188, 88775.22449551102, 8988.775280618036, 10928.398938058483, 11166.88833111691, 11326.32042077478, 11504.309741415542, 42675.4649070181, 43037.78481107575, 43652.12695746131, 43662.0, 44445.55554444414, 45095.0, 46154.53845461502, 54568.727156363966, 54843.0, 55681.72159139178, 14205.786913196516, 14372.49696260626, 14392.640183995065, 14429.639259018608, 14461.710765784836, 14804.925975370053, 15268.083914965138, 17443.738343924597, 18559.16483758207, 18803.71794423112, 14711.117332960057, 15378.923105384401, 16967.981921084775, 17619.55951101233, 17699.82300177033, 16727.414540491023, 16873.746893796848, 17553.473395798148, 17649.029303388437, 17713.0, 16365.836341636432, 16630.25163867653, 16639.334426622798, 16857.747133792756, 16889.648828093475, 11565.653030409101, 11636.592719255124, 11818.29090254553, 11833.704157396134, 12053.0, 12025.218360806519, 12555.623331300076, 12624.621261362174, 12663.430145643653, 12673.310765334489], "value": 8224.154530296633, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1432.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 153.0, 154.0, 115.0, 109.0, 110.0, 110.0, 111.0, 110.0], "value": 119.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 107.0, 148.0, 111.0, 105.0, 108.0, 107.0, 133.0, 106.0], "value": 117.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 182.0, 181.0, 185.0, 184.0, 184.0, 183.0, 185.0, 182.0, 185.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 80.0, 53.0, 77.0, 49.0, 48.0, 79.0, 78.0, 97.0, 76.0], "value": 71.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 85.0, 70.0, 85.0, 94.0, 105.0, 93.0, 68.0, 95.0], "value": 85.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 88.0, 89.0, 89.0, 88.0, 89.0, 89.0, 89.0, 88.0], "value": 88.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 96.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 90.0, 136.0, 93.0, 83.0, 85.0, 86.0, 84.0, 86.0, 93.0], "value": 92.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 46.0, 46.0, 47.0, 48.0, 47.0, 48.0, 47.0, 48.0, 47.0], "value": 46.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 59.0, 57.0, 61.0, 52.0, 55.0, 57.0, 57.0, 55.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 80.0, 82.0, 84.0, 82.0, 83.0, 81.0, 83.0, 82.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 136.0, 137.0, 135.0, 133.0, 137.0, 134.0, 177.0, 150.0], "value": 141.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 224.0, 183.0, 183.0, 180.0, 177.0, 184.0, 179.0, 178.0, 193.0], "value": 186.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 66.0, 67.0, 69.0, 67.0, 67.0, 67.0, 67.0], "value": 67.1, "unit": "score"}]}]} 12:40:03 INFO - Return code: 0 12:40:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:40:03 ERROR - # TBPL SUCCESS # 12:40:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:40:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:40:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:40:03 INFO - 2017-04-29 12:40:03.893 screenresolution[1678:11134] starting screenresolution argv=screenresolution get 12:40:03 INFO - 2017-04-29 12:40:03.896 screenresolution[1678:11134] Display 0: 1600x1200x32@60 12:40:03 INFO - 2017-04-29 12:40:03.902 screenresolution[1679:11137] starting screenresolution argv=screenresolution list 12:40:03 INFO - Available Modes on Display 0 12:40:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:40:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:40:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:40:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:40:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:40:04 INFO - Intel Iris: 12:40:04 INFO - Chipset Model: Intel Iris 12:40:04 INFO - Type: GPU 12:40:04 INFO - Bus: Built-In 12:40:04 INFO - VRAM (Dynamic, Max): 1536 MB 12:40:04 INFO - Vendor: Intel (0x8086) 12:40:04 INFO - Device ID: 0x0a2e 12:40:04 INFO - Revision ID: 0x0009 12:40:04 INFO - Displays: 12:40:04 INFO - Display: 12:40:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:40:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:40:04 INFO - Display Serial Number: 1600x1200 60 12:40:04 INFO - Main Display: Yes 12:40:04 INFO - Mirror: Off 12:40:04 INFO - Online: Yes 12:40:04 INFO - Rotation: Supported 12:40:04 INFO - Return code: 0 12:40:04 INFO - Running post-action listener: _resource_record_post_action 12:40:04 INFO - [mozharness: 2017-04-29 19:40:04.152067Z] Finished run-tests step (success) 12:40:04 INFO - Running post-run listener: _resource_record_post_run 12:40:04 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 33152512; Write bytes: 507769856; Read time: 204; Write time: 1566 12:40:04 INFO - TinderboxPrint: CPU usage
53.6% 12:40:04 INFO - TinderboxPrint: I/O read bytes / time
33,152,512 / 204 12:40:04 INFO - TinderboxPrint: I/O write bytes / time
507,769,856 / 1,566 12:40:04 INFO - TinderboxPrint: CPU idle
2,226.2 (46.4%) 12:40:04 INFO - TinderboxPrint: CPU system
958.7 (20.0%) 12:40:04 INFO - TinderboxPrint: CPU user
1,616.9 (33.7%) 12:40:04 INFO - TinderboxPrint: Swap in / out
238,125,056 / 0 12:40:04 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206072320; Write bytes: 206960640; Read time: 15994; Write time: 424 12:40:04 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 31120896; Write bytes: 293960704; Read time: 185; Write time: 1115 12:40:04 INFO - Running post-run listener: _upload_blobber_files 12:40:04 INFO - Blob upload gear active. 12:40:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:40:04 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 12:40:04 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'] 12:40:04 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 12:40:05 INFO - (blobuploader) - INFO - Open directory for files ... 12:40:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:40:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:40:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:06 INFO - (blobuploader) - INFO - Done attempting. 12:40:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:40:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:40:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:07 INFO - (blobuploader) - INFO - Done attempting. 12:40:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:40:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:40:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:08 INFO - (blobuploader) - INFO - Done attempting. 12:40:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:40:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:40:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:40:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:40:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:40:10 INFO - (blobuploader) - INFO - Done attempting. 12:40:10 INFO - (blobuploader) - INFO - Iteration through files over. 12:40:10 INFO - Return code: 0 12:40:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:40:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:40:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e36985f26fb98c22aa041eb46dabf00c437a43b3650f3b714c59d33b43cedec79610a6a20ee829c794c645f41ae8d542f498a3e67f115547cfc1d25a1bc4437", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73bb605b07360660c38c4ae5fab2ba067a1dbe9fb945a22826328d746c872b7311921373dbadb7050a1c3f7db772c012d36861ad3015446f428136e85b85e794", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/981537252115ceab293a4e836058f4b63c50e0049c65cf36a599c8a7ab8fca2a8fdd37a8c517af551993dee914d0853c512c42c2f2167098b68a534dd7727d2c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aef6fa8d6a4fb893efa1e5c19c48f9614b3c0d7992b49deee3f73892197acb91636b32b70755406494aa37cd85865d4e416ea72b304eea00b49e333141bae90c"} 12:40:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:40:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:40:10 INFO - Contents: 12:40:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e36985f26fb98c22aa041eb46dabf00c437a43b3650f3b714c59d33b43cedec79610a6a20ee829c794c645f41ae8d542f498a3e67f115547cfc1d25a1bc4437", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73bb605b07360660c38c4ae5fab2ba067a1dbe9fb945a22826328d746c872b7311921373dbadb7050a1c3f7db772c012d36861ad3015446f428136e85b85e794", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/981537252115ceab293a4e836058f4b63c50e0049c65cf36a599c8a7ab8fca2a8fdd37a8c517af551993dee914d0853c512c42c2f2167098b68a534dd7727d2c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aef6fa8d6a4fb893efa1e5c19c48f9614b3c0d7992b49deee3f73892197acb91636b32b70755406494aa37cd85865d4e416ea72b304eea00b49e333141bae90c"} 12:40:10 INFO - Running post-run listener: copy_logs_to_upload_dir 12:40:10 INFO - Copying logs to upload dir... 12:40:10 INFO - mkdir: /builds/slave/test/build/upload/logs 12:40:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.687936 ========= master_lag: 0.42 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-29 12:40:10.445799) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-29 12:40:10.448957) ========= 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.7fRiPrGzn9/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.HEULhz1c0p/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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/9e36985f26fb98c22aa041eb46dabf00c437a43b3650f3b714c59d33b43cedec79610a6a20ee829c794c645f41ae8d542f498a3e67f115547cfc1d25a1bc4437", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73bb605b07360660c38c4ae5fab2ba067a1dbe9fb945a22826328d746c872b7311921373dbadb7050a1c3f7db772c012d36861ad3015446f428136e85b85e794", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/981537252115ceab293a4e836058f4b63c50e0049c65cf36a599c8a7ab8fca2a8fdd37a8c517af551993dee914d0853c512c42c2f2167098b68a534dd7727d2c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aef6fa8d6a4fb893efa1e5c19c48f9614b3c0d7992b49deee3f73892197acb91636b32b70755406494aa37cd85865d4e416ea72b304eea00b49e333141bae90c"} build_url:https://queue.taskcluster.net/v1/task/SJsRl0NPQEagXF5tqxGaqw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011100 build_url: 'https://queue.taskcluster.net/v1/task/SJsRl0NPQEagXF5tqxGaqw/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/9e36985f26fb98c22aa041eb46dabf00c437a43b3650f3b714c59d33b43cedec79610a6a20ee829c794c645f41ae8d542f498a3e67f115547cfc1d25a1bc4437", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73bb605b07360660c38c4ae5fab2ba067a1dbe9fb945a22826328d746c872b7311921373dbadb7050a1c3f7db772c012d36861ad3015446f428136e85b85e794", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/981537252115ceab293a4e836058f4b63c50e0049c65cf36a599c8a7ab8fca2a8fdd37a8c517af551993dee914d0853c512c42c2f2167098b68a534dd7727d2c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aef6fa8d6a4fb893efa1e5c19c48f9614b3c0d7992b49deee3f73892197acb91636b32b70755406494aa37cd85865d4e416ea72b304eea00b49e333141bae90c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-29 12:40:10.484899) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 12:40:10.485262) ========= 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.7fRiPrGzn9/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.HEULhz1c0p/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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.005045 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-29 12:40:10.534476) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-29 12:40:10.534820) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-29 12:40:10.535167) ========= ========= Total master_lag: 0.57 =========