builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0179 starttime: 1488800556.2 results: success (0) buildid: 20170306015217 builduid: 513fe45d12734742bd1642b2a606c987 revision: 7099e03837e84970d07d0c7fbdf6724643cc6f30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-06 03:42:36.204610) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-06 03:42:36.205070) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-06 03:42:36.205349) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-06 03:42:36.229613) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 03:42:36.230036) ========= 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.Z3QUTiEljk/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.GJRWnROGi0/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-06 03:42:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 194M=0s 2017-03-06 03:42:36 (194 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123812 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 03:42:36.377470) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 03:42:36.377953) ========= 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.Z3QUTiEljk/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.GJRWnROGi0/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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.028699 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 03:42:36.429367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-06 03:42:36.429752) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7099e03837e84970d07d0c7fbdf6724643cc6f30 --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 7099e03837e84970d07d0c7fbdf6724643cc6f30 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z3QUTiEljk/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.GJRWnROGi0/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-06 03:42:36,532 truncating revision to first 12 chars 2017-03-06 03:42:36,533 Setting DEBUG logging. 2017-03-06 03:42:36,533 attempt 1/10 2017-03-06 03:42:36,533 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7099e03837e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-06 03:42:37,905 unpacking tar archive at: mozilla-central-7099e03837e8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.662031 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-06 03:42:38.115571) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-06 03:42:38.115898) ========= script_repo_revision: 7099e03837e84970d07d0c7fbdf6724643cc6f30 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-06 03:42:38.116272) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-06 03:42:38.116656) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-06 03:42:38.136674) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-06 03:42:38.136963) ========= /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.Z3QUTiEljk/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.GJRWnROGi0/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 03:42:38 INFO - MultiFileLogger online at 20170306 03:42:38 in /builds/slave/test 03:42:38 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 03:42:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:42:38 INFO - {'append_to_log': False, 03:42:38 INFO - 'base_work_dir': '/builds/slave/test', 03:42:38 INFO - 'blob_upload_branch': 'Firefox', 03:42:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:42:38 INFO - 'branch': 'Firefox', 03:42:38 INFO - 'buildbot_json_path': 'buildprops.json', 03:42:38 INFO - 'config_files': ('talos/mac_config.py',), 03:42:38 INFO - 'default_actions': ('clobber', 03:42:38 INFO - 'read-buildbot-config', 03:42:38 INFO - 'download-and-extract', 03:42:38 INFO - 'populate-webroot', 03:42:38 INFO - 'create-virtualenv', 03:42:38 INFO - 'install', 03:42:38 INFO - 'run-tests'), 03:42:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:42:38 INFO - 'download_minidump_stackwalk': True, 03:42:38 INFO - 'download_symbols': 'ondemand', 03:42:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:42:38 INFO - 'tooltool.py': '/tools/tooltool.py', 03:42:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:42:38 INFO - '/tools/misc-python/virtualenv.py')}, 03:42:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:42:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:42:38 INFO - 'gecko_profile': False, 03:42:38 INFO - 'gecko_profile_interval': 0, 03:42:38 INFO - 'installer_path': 'installer.exe', 03:42:38 INFO - 'log_level': 'info', 03:42:38 INFO - 'log_name': 'talos', 03:42:38 INFO - 'log_to_console': True, 03:42:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:42:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:42:38 INFO - 'opt_config_files': (), 03:42:38 INFO - 'pip_index': False, 03:42:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:42:38 INFO - 'cmd': ('bash', 03:42:38 INFO - '-c', 03:42:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:42:38 INFO - 'enabled': True, 03:42:38 INFO - 'halt_on_failure': False, 03:42:38 INFO - 'name': 'check_screen_resolution'},), 03:42:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:42:38 INFO - 'cmd': ('bash', 03:42:38 INFO - '-c', 03:42:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:42:38 INFO - 'enabled': True, 03:42:38 INFO - 'halt_on_failure': False, 03:42:38 INFO - 'name': 'check_screen_resolution'},), 03:42:38 INFO - 'run_cmd_checks_enabled': True, 03:42:38 INFO - 'suite': 'dromaeojs', 03:42:38 INFO - 'system_bits': '32', 03:42:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:42:38 INFO - 'title': 't-yosemite-r7-0179', 03:42:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:42:38 INFO - 'use_talos_json': True, 03:42:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:42:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:42:38 INFO - 'work_dir': 'build'} 03:42:38 INFO - [mozharness: 2017-03-06 11:42:38.353706Z] Running clobber step. 03:42:38 INFO - Running pre-action listener: _resource_record_pre_action 03:42:38 INFO - Running main action method: clobber 03:42:38 INFO - rmtree: /builds/slave/test/build 03:42:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:42:41 INFO - Running post-action listener: _resource_record_post_action 03:42:41 INFO - [mozharness: 2017-03-06 11:42:41.207339Z] Finished clobber step (success) 03:42:41 INFO - [mozharness: 2017-03-06 11:42:41.207472Z] Running read-buildbot-config step. 03:42:41 INFO - Running pre-action listener: _resource_record_pre_action 03:42:41 INFO - Running main action method: read_buildbot_config 03:42:41 INFO - Using buildbot properties: 03:42:41 INFO - { 03:42:41 INFO - "project": "", 03:42:41 INFO - "product": "firefox", 03:42:41 INFO - "script_repo_revision": "production", 03:42:41 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 03:42:41 INFO - "repository": "", 03:42:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 03:42:41 INFO - "buildid": "20170306015217", 03:42:41 INFO - "pgo_build": "False", 03:42:41 INFO - "basedir": "/builds/slave/test", 03:42:41 INFO - "buildnumber": 16, 03:42:41 INFO - "slavename": "t-yosemite-r7-0179", 03:42:41 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:42:41 INFO - "platform": "yosemite_r7", 03:42:41 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:42:41 INFO - "branch": "mozilla-central", 03:42:41 INFO - "repo_path": "mozilla-central", 03:42:41 INFO - "revision": "7099e03837e84970d07d0c7fbdf6724643cc6f30", 03:42:41 INFO - "stage_platform": "macosx64", 03:42:41 INFO - "builduid": "513fe45d12734742bd1642b2a606c987", 03:42:41 INFO - "slavebuilddir": "test" 03:42:41 INFO - } 03:42:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 03:42:41 INFO - Running post-action listener: _resource_record_post_action 03:42:41 INFO - [mozharness: 2017-03-06 11:42:41.210857Z] Finished read-buildbot-config step (success) 03:42:41 INFO - [mozharness: 2017-03-06 11:42:41.210939Z] Running download-and-extract step. 03:42:41 INFO - Running pre-action listener: _resource_record_pre_action 03:42:41 INFO - Running main action method: download_and_extract 03:42:41 INFO - mkdir: /builds/slave/test/build/tests 03:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:42:41 INFO - trying https://queue.taskcluster.net/v1/task/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 03:42:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 03:42:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 03:42:41 INFO - Downloaded 1199 bytes. 03:42:41 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 03:42:41 INFO - Using the following test package requirements: 03:42:41 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 03:42:41 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:42:41 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 03:42:41 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:42:41 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 03:42:41 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:42:41 INFO - u'jsshell-mac.zip'], 03:42:41 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:42:41 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 03:42:41 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 03:42:41 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:42:41 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 03:42:41 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:42:41 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 03:42:41 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:42:41 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 03:42:41 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:42:41 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 03:42:41 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:42:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 03:42:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:42:41 INFO - Fetch https://queue.taskcluster.net/v1/task/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 03:42:43 INFO - Expected file size: 51776480 03:42:43 INFO - Obtained file size: 51776480 03:42:59 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:42:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 03:42:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:42:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 03:43:01 INFO - Expected file size: 51776480 03:43:01 INFO - Obtained file size: 51776480 03:43:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 03:43:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:43:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 03:43:17 INFO - Expected file size: 14404424 03:43:17 INFO - Obtained file size: 14404424 03:43:17 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')]} 03:43:17 INFO - trying https://queue.taskcluster.net/v1/task/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:43:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 03:43:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 03:43:19 INFO - Downloaded 75087687 bytes. 03:43:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:43:19 INFO - mkdir: /builds/slave/test/properties 03:43:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:43:19 INFO - Writing to file /builds/slave/test/properties/build_url 03:43:19 INFO - Contents: 03:43:19 INFO - build_url:https://queue.taskcluster.net/v1/task/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:43:20 INFO - Running post-action listener: _resource_record_post_action 03:43:20 INFO - Running post-action listener: set_extra_try_arguments 03:43:20 INFO - [mozharness: 2017-03-06 11:43:20.532832Z] Finished download-and-extract step (success) 03:43:20 INFO - [mozharness: 2017-03-06 11:43:20.532956Z] Running populate-webroot step. 03:43:20 INFO - Running pre-action listener: _resource_record_pre_action 03:43:20 INFO - Running main action method: populate_webroot 03:43:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:43:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:43:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:43:20 INFO - '--tppagecycles', 03:43:20 INFO - '7'], 03:43:20 INFO - 'tests': ['tsvgm']}}, 03:43:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:43:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:43:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:43:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:43:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:43:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:43:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:43:20 INFO - 'talos_options': ['--disable-e10s'], 03:43:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:43:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:43:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:43:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:43:20 INFO - 'talos_options': ['--disable-e10s'], 03:43:20 INFO - 'tests': ['damp', 'tps']}, 03:43:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:43:20 INFO - 'tests': ['damp', 'tps']}, 03:43:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:43:20 INFO - 'tests': ['dromaeo_dom']}, 03:43:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:43:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:43:20 INFO - 'tests': ['basic_compositor_video']}, 03:43:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:43:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:43:20 INFO - 'tests': ['a11yr', 03:43:20 INFO - 'ts_paint', 03:43:20 INFO - 'tpaint', 03:43:20 INFO - 'sessionrestore', 03:43:20 INFO - 'sessionrestore_no_auto_restore', 03:43:20 INFO - 'tabpaint']}, 03:43:20 INFO - 'other-e10s': {'tests': ['a11yr', 03:43:20 INFO - 'ts_paint', 03:43:20 INFO - 'tpaint', 03:43:20 INFO - 'sessionrestore', 03:43:20 INFO - 'sessionrestore_no_auto_restore', 03:43:20 INFO - 'tabpaint']}, 03:43:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:43:20 INFO - 'ts_paint', 03:43:20 INFO - 'tpaint', 03:43:20 INFO - 'sessionrestore', 03:43:20 INFO - 'sessionrestore_no_auto_restore', 03:43:20 INFO - 'tabpaint']}, 03:43:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:43:20 INFO - 'ts_paint', 03:43:20 INFO - 'tpaint', 03:43:20 INFO - 'sessionrestore', 03:43:20 INFO - 'sessionrestore_no_auto_restore', 03:43:20 INFO - 'tabpaint']}, 03:43:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:43:20 INFO - 'tests': ['a11yr', 03:43:20 INFO - 'ts_paint', 03:43:20 INFO - 'tpaint', 03:43:20 INFO - 'sessionrestore', 03:43:20 INFO - 'sessionrestore_no_auto_restore', 03:43:20 INFO - 'tabpaint']}, 03:43:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:43:20 INFO - 'tests': ['a11yr', 03:43:20 INFO - 'ts_paint', 03:43:20 INFO - 'tpaint', 03:43:20 INFO - 'sessionrestore', 03:43:20 INFO - 'sessionrestore_no_auto_restore', 03:43:20 INFO - 'tabpaint']}, 03:43:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:43:20 INFO - 'tests': ['tsvgx', 03:43:20 INFO - 'tsvgr_opacity', 03:43:20 INFO - 'tart', 03:43:20 INFO - 'tscrollx', 03:43:20 INFO - 'cart', 03:43:20 INFO - 'tsvg_static']}, 03:43:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:43:20 INFO - 'tsvgr_opacity', 03:43:20 INFO - 'tart', 03:43:20 INFO - 'tscrollx', 03:43:20 INFO - 'cart', 03:43:20 INFO - 'tsvg_static']}, 03:43:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:43:20 INFO - 'talos_options': ['--disable-e10s'], 03:43:20 INFO - 'tests': ['tp5o']}, 03:43:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:43:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:43:20 INFO - 'talos_options': ['--disable-e10s', 03:43:20 INFO - '--xperf_path', 03:43:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:43:20 INFO - 'tests': ['tp5n']}, 03:43:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:43:20 INFO - 'talos_options': ['--xperf_path', 03:43:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:43:20 INFO - 'tests': ['tp5n']}}, 03:43:20 INFO - 'talos.zip': {'path': '', 03:43:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:43:20 INFO - Running post-action listener: _resource_record_post_action 03:43:20 INFO - [mozharness: 2017-03-06 11:43:20.551355Z] Finished populate-webroot step (success) 03:43:20 INFO - [mozharness: 2017-03-06 11:43:20.551470Z] Running create-virtualenv step. 03:43:20 INFO - Running pre-action listener: _resource_record_pre_action 03:43:20 INFO - Running main action method: create_virtualenv 03:43:20 INFO - Creating virtualenv /builds/slave/test/build/venv 03:43:20 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 03:43:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:43:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:43:20 INFO - Using real prefix '/tools/python27' 03:43:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:43:21 INFO - Installing distribute.............................................................................................................................................................................................done. 03:43:24 INFO - Installing pip.................done. 03:43:24 INFO - Return code: 0 03:43:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:43:24 INFO - Reading from file tmpfile_stdout 03:43:24 INFO - Output received: 03:43:24 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) 03:43:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:43:24 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')]} 03:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:24 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')]} 03:43:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:24 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 0x1090b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94a0c6ee90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e97d30>, '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 0x108dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e8cbe8>, '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.Z3QUTiEljk/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.GJRWnROGi0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 03:43:24 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 03:43:24 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 03:43:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z3QUTiEljk/Render', 03:43:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:24 INFO - 'HOME': '/Users/cltbld', 03:43:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:24 INFO - 'LOGNAME': 'cltbld', 03:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:24 INFO - 'MOZ_NO_REMOTE': '1', 03:43:24 INFO - 'NO_EM_RESTART': '1', 03:43:24 INFO - 'PAGER': '/bin/cat', 03:43:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:24 INFO - 'PWD': '/builds/slave/test', 03:43:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:24 INFO - 'SHELL': '/bin/bash', 03:43:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GJRWnROGi0/Listeners', 03:43:24 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 03:43:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:24 INFO - 'USER': 'cltbld', 03:43:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:24 INFO - 'XPC_FLAGS': '0x0', 03:43:24 INFO - 'XPC_SERVICE_NAME': '0', 03:43:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:24 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 03:43:24 INFO - Cleaning up... 03:43:24 INFO - Return code: 0 03:43:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:43:24 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')]} 03:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:24 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')]} 03:43:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:24 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 0x1090b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94a0c6ee90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e97d30>, '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 0x108dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e8cbe8>, '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.Z3QUTiEljk/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.GJRWnROGi0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 03:43:24 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 03:43:24 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 03:43:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z3QUTiEljk/Render', 03:43:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:24 INFO - 'HOME': '/Users/cltbld', 03:43:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:24 INFO - 'LOGNAME': 'cltbld', 03:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:24 INFO - 'MOZ_NO_REMOTE': '1', 03:43:24 INFO - 'NO_EM_RESTART': '1', 03:43:24 INFO - 'PAGER': '/bin/cat', 03:43:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:24 INFO - 'PWD': '/builds/slave/test', 03:43:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:24 INFO - 'SHELL': '/bin/bash', 03:43:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GJRWnROGi0/Listeners', 03:43:24 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 03:43:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:24 INFO - 'USER': 'cltbld', 03:43:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:24 INFO - 'XPC_FLAGS': '0x0', 03:43:24 INFO - 'XPC_SERVICE_NAME': '0', 03:43:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:25 INFO - Downloading/unpacking psutil>=3.1.1 03:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:43:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:43:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:43:28 INFO - Installing collected packages: psutil 03:43:28 INFO - Running setup.py install for psutil 03:43:28 INFO - building 'psutil._psutil_osx' extension 03:43:28 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 03:43:29 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 03:43:29 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 03:43:29 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 03:43:29 INFO - building 'psutil._psutil_posix' extension 03:43:29 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 03:43:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:43:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:43:29 INFO - ^ 03:43:29 INFO - 1 warning generated. 03:43:29 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 03:43:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:43:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:43:29 INFO - Successfully installed psutil 03:43:29 INFO - Cleaning up... 03:43:29 INFO - Return code: 0 03:43:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:43:29 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')]} 03:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:29 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')]} 03:43:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:29 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 0x1090b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94a0c6ee90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e97d30>, '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 0x108dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e8cbe8>, '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.Z3QUTiEljk/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.GJRWnROGi0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 03:43:29 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 03:43:29 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 03:43:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z3QUTiEljk/Render', 03:43:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:29 INFO - 'HOME': '/Users/cltbld', 03:43:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:29 INFO - 'LOGNAME': 'cltbld', 03:43:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:29 INFO - 'MOZ_NO_REMOTE': '1', 03:43:29 INFO - 'NO_EM_RESTART': '1', 03:43:29 INFO - 'PAGER': '/bin/cat', 03:43:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:29 INFO - 'PWD': '/builds/slave/test', 03:43:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:29 INFO - 'SHELL': '/bin/bash', 03:43:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GJRWnROGi0/Listeners', 03:43:29 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 03:43:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:29 INFO - 'USER': 'cltbld', 03:43:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:29 INFO - 'XPC_FLAGS': '0x0', 03:43:29 INFO - 'XPC_SERVICE_NAME': '0', 03:43:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:43:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:43:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:43:32 INFO - Installing collected packages: mozsystemmonitor 03:43:32 INFO - Running setup.py install for mozsystemmonitor 03:43:32 INFO - Successfully installed mozsystemmonitor 03:43:32 INFO - Cleaning up... 03:43:32 INFO - Return code: 0 03:43:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:43:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:33 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')]} 03:43:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:33 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 0x1090b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94a0c6ee90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e97d30>, '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 0x108dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e8cbe8>, '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.Z3QUTiEljk/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.GJRWnROGi0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 03:43:33 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 03:43:33 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 03:43:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z3QUTiEljk/Render', 03:43:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:33 INFO - 'HOME': '/Users/cltbld', 03:43:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:33 INFO - 'LOGNAME': 'cltbld', 03:43:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:33 INFO - 'MOZ_NO_REMOTE': '1', 03:43:33 INFO - 'NO_EM_RESTART': '1', 03:43:33 INFO - 'PAGER': '/bin/cat', 03:43:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:33 INFO - 'PWD': '/builds/slave/test', 03:43:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:33 INFO - 'SHELL': '/bin/bash', 03:43:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GJRWnROGi0/Listeners', 03:43:33 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 03:43:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:33 INFO - 'USER': 'cltbld', 03:43:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:33 INFO - 'XPC_FLAGS': '0x0', 03:43:33 INFO - 'XPC_SERVICE_NAME': '0', 03:43:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:33 INFO - Downloading/unpacking jsonschema==2.5.1 03:43:33 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 03:43:33 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 03:43:33 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 03:43:33 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 03:43:33 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 03:43:33 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 03:43:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:43:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:43:37 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 03:43:37 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 03:43:37 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 03:43:37 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 03:43:37 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 03:43:37 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 03:43:37 INFO - Downloading functools32-3.2.3-2.tar.gz 03:43:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:43:37 INFO - warning: no files found matching '*.txt' 03:43:37 INFO - no previously-included directories found matching 'build' 03:43:37 INFO - no previously-included directories found matching 'dist' 03:43:37 INFO - no previously-included directories found matching '.git*' 03:43:37 INFO - Installing collected packages: jsonschema, functools32 03:43:37 INFO - Running setup.py install for functools32 03:43:37 INFO - warning: no files found matching '*.txt' 03:43:37 INFO - no previously-included directories found matching 'build' 03:43:37 INFO - no previously-included directories found matching 'dist' 03:43:37 INFO - no previously-included directories found matching '.git*' 03:43:37 INFO - Successfully installed jsonschema functools32 03:43:37 INFO - Cleaning up... 03:43:37 INFO - Return code: 0 03:43:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:43:37 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')]} 03:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:37 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')]} 03:43:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:37 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 0x1090b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94a0c6ee90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e97d30>, '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 0x108dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e8cbe8>, '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.Z3QUTiEljk/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.GJRWnROGi0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 03:43:37 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 03:43:37 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 03:43:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z3QUTiEljk/Render', 03:43:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:37 INFO - 'HOME': '/Users/cltbld', 03:43:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:37 INFO - 'LOGNAME': 'cltbld', 03:43:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:37 INFO - 'MOZ_NO_REMOTE': '1', 03:43:37 INFO - 'NO_EM_RESTART': '1', 03:43:37 INFO - 'PAGER': '/bin/cat', 03:43:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:37 INFO - 'PWD': '/builds/slave/test', 03:43:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:37 INFO - 'SHELL': '/bin/bash', 03:43:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GJRWnROGi0/Listeners', 03:43:37 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 03:43:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:37 INFO - 'USER': 'cltbld', 03:43:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:37 INFO - 'XPC_FLAGS': '0x0', 03:43:37 INFO - 'XPC_SERVICE_NAME': '0', 03:43:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:43:38 INFO - Cleaning up... 03:43:38 INFO - Return code: 0 03:43:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1090b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94a0c6ee90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e97d30>, '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 0x108dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e8cbe8>, '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.Z3QUTiEljk/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.GJRWnROGi0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 03:43:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:43:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:43:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z3QUTiEljk/Render', 03:43:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:38 INFO - 'HOME': '/Users/cltbld', 03:43:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:38 INFO - 'LOGNAME': 'cltbld', 03:43:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:38 INFO - 'MOZ_NO_REMOTE': '1', 03:43:38 INFO - 'NO_EM_RESTART': '1', 03:43:38 INFO - 'PAGER': '/bin/cat', 03:43:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:38 INFO - 'PWD': '/builds/slave/test', 03:43:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:38 INFO - 'SHELL': '/bin/bash', 03:43:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GJRWnROGi0/Listeners', 03:43:38 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 03:43:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:38 INFO - 'USER': 'cltbld', 03:43:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:38 INFO - 'XPC_FLAGS': '0x0', 03:43:38 INFO - 'XPC_SERVICE_NAME': '0', 03:43:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:38 INFO - Downloading/unpacking blobuploader==1.2.4 03:43:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:40 INFO - Downloading blobuploader-1.2.4.tar.gz 03:43:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:43:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:43: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 03:43: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 03:43: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 03:43: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 03:43: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 03:43: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 03:43:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:43:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:43:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:42 INFO - Downloading docopt-0.6.1.tar.gz 03:43:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:43:42 INFO - Installing collected packages: blobuploader, requests, docopt 03:43:42 INFO - Running setup.py install for blobuploader 03:43:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:43:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:43:42 INFO - Running setup.py install for requests 03:43:42 INFO - Running setup.py install for docopt 03:43:43 INFO - Successfully installed blobuploader requests docopt 03:43:43 INFO - Cleaning up... 03:43:43 INFO - Return code: 0 03:43:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:43:43 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')]} 03:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:43 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')]} 03:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:43 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 0x1090b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94a0c6ee90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e97d30>, '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 0x108dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e8cbe8>, '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.Z3QUTiEljk/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.GJRWnROGi0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 03:43:43 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 03:43:43 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 03:43:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z3QUTiEljk/Render', 03:43:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:43 INFO - 'HOME': '/Users/cltbld', 03:43:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:43 INFO - 'LOGNAME': 'cltbld', 03:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:43 INFO - 'MOZ_NO_REMOTE': '1', 03:43:43 INFO - 'NO_EM_RESTART': '1', 03:43:43 INFO - 'PAGER': '/bin/cat', 03:43:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:43 INFO - 'PWD': '/builds/slave/test', 03:43:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:43 INFO - 'SHELL': '/bin/bash', 03:43:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GJRWnROGi0/Listeners', 03:43:43 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 03:43:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:43 INFO - 'USER': 'cltbld', 03:43:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:43 INFO - 'XPC_FLAGS': '0x0', 03:43:43 INFO - 'XPC_SERVICE_NAME': '0', 03:43:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:43:43 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-vy_i87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:43:43 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-ZTjvH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:43:43 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-UPERy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:43:43 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-k_uD5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:43:43 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-6PByAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:43:43 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-lpukcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:43:44 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-UG9x4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:43:44 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-xhd0yN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:43:44 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-GnoGPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:43:44 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-ibwMDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:43:44 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-0CCZjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:43:44 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-KYOVg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:43:44 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-xlXmQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:43:44 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-A6IMKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:44 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-Wj61pJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:43:44 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-1jm6Mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:43:45 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-TgYYA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:43:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:43:45 INFO - Running setup.py install for manifestparser 03:43:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:43:45 INFO - Running setup.py install for mozcrash 03:43:45 INFO - Running setup.py install for mozdebug 03:43:45 INFO - Running setup.py install for mozdevice 03:43:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:43:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:43:45 INFO - Running setup.py install for mozfile 03:43:45 INFO - Running setup.py install for mozhttpd 03:43:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:43:46 INFO - Running setup.py install for mozinfo 03:43:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:43:46 INFO - Running setup.py install for mozInstall 03:43:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:43:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:43:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:43:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:43:46 INFO - Running setup.py install for mozleak 03:43:46 INFO - Running setup.py install for mozlog 03:43:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:43:46 INFO - Running setup.py install for moznetwork 03:43:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:43:46 INFO - Running setup.py install for mozprocess 03:43:46 INFO - Running setup.py install for mozprofile 03:43:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:43:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:43:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:43:47 INFO - Running setup.py install for mozrunner 03:43:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:43:47 INFO - Running setup.py install for mozscreenshot 03:43:47 INFO - Running setup.py install for moztest 03:43:47 INFO - Running setup.py install for mozversion 03:43:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:43:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:43:47 INFO - Cleaning up... 03:43:47 INFO - Return code: 0 03:43:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:43: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')]} 03:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43: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')]} 03:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:47 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 0x1090b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94a0c6ee90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e97d30>, '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 0x108dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e8cbe8>, '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.Z3QUTiEljk/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.GJRWnROGi0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 03:43:47 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 03:43:47 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 03:43:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z3QUTiEljk/Render', 03:43:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:47 INFO - 'HOME': '/Users/cltbld', 03:43:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:47 INFO - 'LOGNAME': 'cltbld', 03:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:47 INFO - 'MOZ_NO_REMOTE': '1', 03:43:47 INFO - 'NO_EM_RESTART': '1', 03:43:47 INFO - 'PAGER': '/bin/cat', 03:43:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:47 INFO - 'PWD': '/builds/slave/test', 03:43:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:47 INFO - 'SHELL': '/bin/bash', 03:43:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GJRWnROGi0/Listeners', 03:43:47 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 03:43:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:47 INFO - 'USER': 'cltbld', 03:43:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:47 INFO - 'XPC_FLAGS': '0x0', 03:43:47 INFO - 'XPC_SERVICE_NAME': '0', 03:43:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:43:47 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-eixqBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:43:48 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)) 03:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:43:48 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-bJsWxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:43:48 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)) 03:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:43:48 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-k5yh7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:43:48 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)) 03:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:43:48 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-oBrELG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:43:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:43:48 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-Pj7Jii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:43:48 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)) 03:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:43:48 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-J6q9a9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:43:48 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)) 03:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:43:48 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-KBYu6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:43:48 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)) 03:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:43:48 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-cXVgrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:43:48 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)) 03:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:43:48 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-dRZLEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:43:48 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)) 03:43:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:43:48 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-Z3x3Jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:43:49 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)) 03:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:43:49 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-c2bMVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:43:49 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)) 03:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:43:49 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-IzCq6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:43:49 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)) 03:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:43:49 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-Z124YD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:43:49 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)) 03:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:43:49 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-82Sxba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:43:49 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)) 03:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:49 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-4AZXmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:43:49 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)) 03:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:43:49 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-NkMJyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:43:49 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)) 03:43:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:43:49 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-mQxUPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:43:49 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)) 03:43:49 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)) 03:43:49 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)) 03:43:49 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)) 03:43:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:43:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:43:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:43:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:43:52 INFO - Downloading blessings-1.6.tar.gz 03:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:43:52 INFO - Installing collected packages: blessings 03:43:52 INFO - Running setup.py install for blessings 03:43:52 INFO - Successfully installed blessings 03:43:52 INFO - Cleaning up... 03:43:52 INFO - Return code: 0 03:43:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:43:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:43:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:43:53 INFO - Reading from file tmpfile_stdout 03:43:53 INFO - Current package versions: 03:43:53 INFO - blessings == 1.6 03:43:53 INFO - blobuploader == 1.2.4 03:43:53 INFO - docopt == 0.6.1 03:43:53 INFO - functools32 == 3.2.3-2 03:43:53 INFO - jsonschema == 2.5.1 03:43:53 INFO - manifestparser == 1.1 03:43:53 INFO - mozInstall == 1.12 03:43:53 INFO - mozcrash == 1.0 03:43:53 INFO - mozdebug == 0.1 03:43:53 INFO - mozdevice == 0.49 03:43:53 INFO - mozfile == 1.2 03:43:53 INFO - mozhttpd == 0.7 03:43:53 INFO - mozinfo == 0.9 03:43:53 INFO - mozleak == 0.1 03:43:53 INFO - mozlog == 3.4 03:43:53 INFO - moznetwork == 0.27 03:43:53 INFO - mozprocess == 0.25 03:43:53 INFO - mozprofile == 0.28 03:43:53 INFO - mozrunner == 6.13 03:43:53 INFO - mozscreenshot == 0.1 03:43:53 INFO - mozsystemmonitor == 0.3 03:43:53 INFO - moztest == 0.8 03:43:53 INFO - mozversion == 1.4 03:43:53 INFO - psutil == 3.1.1 03:43:53 INFO - requests == 1.2.3 03:43:53 INFO - wsgiref == 0.1.2 03:43:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:53 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 0x1090b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94a0c6ee90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e97d30>, '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 0x108dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e8cbe8>, '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.Z3QUTiEljk/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.GJRWnROGi0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 03:43:53 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 03:43:53 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 03:43:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z3QUTiEljk/Render', 03:43:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:53 INFO - 'HOME': '/Users/cltbld', 03:43:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:53 INFO - 'LOGNAME': 'cltbld', 03:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:53 INFO - 'MOZ_NO_REMOTE': '1', 03:43:53 INFO - 'NO_EM_RESTART': '1', 03:43:53 INFO - 'PAGER': '/bin/cat', 03:43:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:53 INFO - 'PWD': '/builds/slave/test', 03:43:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:53 INFO - 'SHELL': '/bin/bash', 03:43:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GJRWnROGi0/Listeners', 03:43:53 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 03:43:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:53 INFO - 'USER': 'cltbld', 03:43:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:53 INFO - 'XPC_FLAGS': '0x0', 03:43:53 INFO - 'XPC_SERVICE_NAME': '0', 03:43:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:53 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)) 03:43:53 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)) 03:43:53 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)) 03:43:53 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)) 03:43:53 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)) 03:43:53 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)) 03:43:53 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)) 03:43:53 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)) 03:43:53 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)) 03:43:53 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)) 03:43:53 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)) 03:43:53 INFO - Cleaning up... 03:43:53 INFO - Return code: 0 03:43:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:43:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:43:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:43:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:43:53 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 0x1090b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94a0c6ee90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e97d30>, '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 0x108dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e8cbe8>, '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.Z3QUTiEljk/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.GJRWnROGi0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 03:43:53 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 03:43:53 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 03:43:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z3QUTiEljk/Render', 03:43:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:43:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:43:53 INFO - 'HOME': '/Users/cltbld', 03:43:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:43:53 INFO - 'LOGNAME': 'cltbld', 03:43:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:53 INFO - 'MOZ_NO_REMOTE': '1', 03:43:53 INFO - 'NO_EM_RESTART': '1', 03:43:53 INFO - 'PAGER': '/bin/cat', 03:43:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:43:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:53 INFO - 'PWD': '/builds/slave/test', 03:43:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:43:53 INFO - 'SHELL': '/bin/bash', 03:43:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GJRWnROGi0/Listeners', 03:43:53 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 03:43:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:43:53 INFO - 'USER': 'cltbld', 03:43:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:43:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:43:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:53 INFO - 'XPC_FLAGS': '0x0', 03:43:53 INFO - 'XPC_SERVICE_NAME': '0', 03:43:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:43:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:43:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:43:53 INFO - Cleaning up... 03:43:53 INFO - Return code: 0 03:43:53 INFO - Running post-action listener: _resource_record_post_action 03:43:53 INFO - Running post-action listener: _start_resource_monitoring 03:43:53 INFO - Starting resource monitoring. 03:43:53 INFO - [mozharness: 2017-03-06 11:43:53.633245Z] Finished create-virtualenv step (success) 03:43:53 INFO - [mozharness: 2017-03-06 11:43:53.634205Z] Running install step. 03:43:53 INFO - Running pre-action listener: _resource_record_pre_action 03:43:53 INFO - Running main action method: install 03:43:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:43:53 INFO - Reading from file tmpfile_stdout 03:43:53 INFO - Detecting whether we're running mozinstall >=1.0... 03:43:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:43:53 INFO - Reading from file tmpfile_stdout 03:43:53 INFO - Output received: 03:43:53 INFO - Usage: mozinstall [options] installer 03:43:53 INFO - Options: 03:43:53 INFO - -h, --help show this help message and exit 03:43:53 INFO - -d DEST, --destination=DEST 03:43:53 INFO - Directory to install application into. [default: 03:43:53 INFO - "/builds/slave/test"] 03:43:53 INFO - --app=APP Application being installed. [default: firefox] 03:43:54 INFO - mkdir: /builds/slave/test/build/application 03:43:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:43:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:44:14 INFO - Reading from file tmpfile_stdout 03:44:14 INFO - Output received: 03:44:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:44:14 INFO - Running post-action listener: _resource_record_post_action 03:44:14 INFO - [mozharness: 2017-03-06 11:44:14.246000Z] Finished install step (success) 03:44:14 INFO - [mozharness: 2017-03-06 11:44:14.246140Z] Running run-tests step. 03:44:14 INFO - Running pre-action listener: _resource_record_pre_action 03:44:14 INFO - Running main action method: run_tests 03:44:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:44:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:44:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:44:14 INFO - 2017-03-06 03:44:14.260 screenresolution[1623:7434] starting screenresolution argv=screenresolution get 03:44:14 INFO - 2017-03-06 03:44:14.263 screenresolution[1623:7434] Display 0: 1600x1200x32@60 03:44:14 INFO - 2017-03-06 03:44:14.268 screenresolution[1624:7437] starting screenresolution argv=screenresolution list 03:44:14 INFO - Available Modes on Display 0 03:44:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:44:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:44:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:44:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:44:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:44:14 INFO - Intel Iris: 03:44:14 INFO - Chipset Model: Intel Iris 03:44:14 INFO - Type: GPU 03:44:14 INFO - Bus: Built-In 03:44:14 INFO - VRAM (Dynamic, Max): 1536 MB 03:44:14 INFO - Vendor: Intel (0x8086) 03:44:14 INFO - Device ID: 0x0a2e 03:44:14 INFO - Revision ID: 0x0009 03:44:14 INFO - Displays: 03:44:14 INFO - Display: 03:44:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:44:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:44:14 INFO - Display Serial Number: 1600x1200 60 03:44:14 INFO - Main Display: Yes 03:44:14 INFO - Mirror: Off 03:44:14 INFO - Online: Yes 03:44:14 INFO - Rotation: Supported 03:44:14 INFO - Return code: 0 03:44:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:44:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:44:14 INFO - Python 2.7.3 03:44:14 INFO - Return code: 0 03:44:14 INFO - grabbing minidump binary from tooltool 03:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:44:14 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 0x108e97d30>, '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 0x108dbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e8cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:44:14 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 03:44:14 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 03:44:14 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 03:44:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:44:14 INFO - Return code: 0 03:44:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:44:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:44:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:44:14 INFO - ENV: RUST_BACKTRACE is now 1 03:44:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:44:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:44:14 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/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0179', '--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 03:44:14 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/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0179 --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 03:44:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z3QUTiEljk/Render', 03:44:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:14 INFO - 'HOME': '/Users/cltbld', 03:44:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:14 INFO - 'LOGNAME': 'cltbld', 03:44:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:44:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:44:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:14 INFO - 'MOZ_NO_REMOTE': '1', 03:44:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:44:14 INFO - 'NO_EM_RESTART': '1', 03:44:14 INFO - 'PAGER': '/bin/cat', 03:44:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:14 INFO - 'PWD': '/builds/slave/test', 03:44:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:44:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:14 INFO - 'RUST_BACKTRACE': '1', 03:44:14 INFO - 'SHELL': '/bin/bash', 03:44:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GJRWnROGi0/Listeners', 03:44:14 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 03:44:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:14 INFO - 'USER': 'cltbld', 03:44:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:14 INFO - 'XPC_FLAGS': '0x0', 03:44:14 INFO - 'XPC_SERVICE_NAME': '0', 03:44:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:14 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/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0179', '--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 03:44:14 INFO - mozversion application_buildid: 20170306015217 03:44:14 INFO - mozversion application_changeset: 7099e03837e84970d07d0c7fbdf6724643cc6f30 03:44:14 INFO - mozversion application_display_name: Nightly 03:44:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:44:14 INFO - mozversion application_name: Firefox 03:44:14 INFO - mozversion application_remotingname: firefox 03:44:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:44:14 INFO - mozversion application_vendor: Mozilla 03:44:14 INFO - mozversion application_version: 54.0a1 03:44:14 INFO - mozversion platform_buildid: 20170306015217 03:44:14 INFO - mozversion platform_changeset: 7099e03837e84970d07d0c7fbdf6724643cc6f30 03:44:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:44:14 INFO - mozversion platform_version: 54.0a1 03:44:14 INFO - using testdate: 1488800654 03:44:14 INFO - actual date: 1488800654 03:44:14 INFO - starting webserver on 'localhost:49236' 03:44:14 INFO - SUITE-START | Running 2 tests 03:44:14 INFO - TEST-START | dromaeo_css 03:44:14 INFO - operating with platform_type : mac_ 03:44:14 INFO - Initialising browser for dromaeo_css test... 03:44:14 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/tmpcmNxis/profile http://localhost:49236/getInfo.html) 03:44:17 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 03:44:17 INFO - PROCESS | 1634 | colorDepth:24 03:44:17 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 03:44:17 INFO - PROCESS | 1634 | __metrics 03:44:17 INFO - PROCESS | 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:44:17 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:44:18 INFO - TEST-INFO | 1634: exit 0 03:44:18 INFO - Browser initialized. 03:44:18 INFO - Running cycle 1/1 for dromaeo_css test... 03:44:18 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/tmpcmNxis/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:44:30 INFO - PROCESS | 1635 | RSS: Main: 231858176 03:44:30 INFO - PROCESS | 1635 | 03:47:33 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 03:47:38 INFO - PROCESS | 1635 | RSS: Main: 460066816 03:47:38 INFO - PROCESS | 1635 | 03:49:19 INFO - PROCESS | 1635 | ************************* 03:49:19 INFO - PROCESS | 1635 | A coding exception was thrown and uncaught in a Task. 03:49:19 INFO - PROCESS | 1635 | 03:49:19 ERROR - PROCESS | 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:49:19 INFO - PROCESS | 1635 | Full stack: 03:49:19 INFO - PROCESS | 1635 | ************************* 03:50:41 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 03:50:41 INFO - PROCESS | 1635 | RSS: Main: 366739456 03:50:41 INFO - PROCESS | 1635 | 03:53:44 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 03:53:44 INFO - PROCESS | 1635 | RSS: Main: 357453824 03:53:44 INFO - PROCESS | 1635 | 03:56:47 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 03:56:48 INFO - PROCESS | 1635 | RSS: Main: 356888576 03:56:48 INFO - PROCESS | 1635 | 03:59:51 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 03:59:52 INFO - PROCESS | 1635 | RSS: Main: 335536128 03:59:52 INFO - PROCESS | 1635 | 04:02:55 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 04:02:55 INFO - PROCESS | 1635 | RSS: Main: 552079360 04:02:55 INFO - PROCESS | 1635 | 04:02:55 INFO - PROCESS | 1635 | __start_tp_report 04:02:55 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 04:02:55 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 04:02:55 INFO - PROCESS | 1635 | |i|pagename|runs| 04:02:55 INFO - PROCESS | 1635 | |0;dojo.html;2916.5187744022232;3321.638128367368;3339.2319766453725;3344.8460281202974;3407.1993081625815;5541.307336582927;5647.491725744682;5698.401667824875;5730.3123625165035;5775.047117225663;5625.1843482695085;5709.0580054290995;5749.568782341331;5795.739191736371;5848.766049358021;5101.948980510203;5124.128898087315;5152.690838549699;5172.250023746555;5210.114280572312;5276.525112739852;5307.548858347026;5323.866903327409;5331.813386531472;5374.032674118657;5091.516305950929;5135.229715542661;5193.324867767204;5212.713300768456;5288.682679039251;4651.209294419923;4943.01139772047;5185.792568297264;5207.921881171786;5213.791448342062;5104.106781313292;5154.948450515484;5171;5173.922391164136;5179.974100129475;5674.404187560329;5684.4315568443235;5686.60193786431;5687.573431992576;5713.457221563986;6166.81499555014;6169.259688837324;6171.7531298748;6185.8144255672405;6186.783462578833;5025.7235852028125;6153.861535615881;6183.721732522003;6225.377462253784;6239.126522286883;5353.9196912046355;5746.367899531048;5790.478856902857;5815.127730840408;5817.912731309034;6241.75032998684;6253.74985000604;6254.21822272216;6258.092576576462;6266.811995640138;6016.308124565643;6074.392560743979;6138.263408391022;6143.047827586731;6223.844403889939;6120.731300393959;6128.453176423585;6132.5707200495535;6139.921477737008;6148.815535533941;6115.188456275656;6115.949241104752;6122.8251069701855;6129.358790882686;6130.837764763411;5937.11212246587;6094.809245860337;6116.0010150213275;6122.581127188433;6143.372006418303;4386.561343865652;4821.349117869113;4988.700677959261;5066.214736715815;5100.0819852426175;4453.710508816916;4460.397846290709;4496.033352829158;4529.773511324421;4550.613197878151;5134;5568.303962004749;5731.942680573225;5768.278965129359;5786.392428795;6111.40942266768;6120.571559990758;6151.96924015377;6163.982942814475;6234.812955611339;5382.461753824587;5629.183768353566;5630.352509461382;5633.352164501053;5638.984982703153;4888.2178851383605;5415.756290966916;5416.322959630046;5427.6200665953;5436.483534064258;6137.570370074052;6182.1345011698395;6196.47329976939;6197.163382943245;6203.31763506023;3385.881494147693;6123.418275263843;6168.290646575521;6230.096635987847;6244.968775156095;6346.111544383883;6347.841303967438;6350.841228969312;6353.110564521063;6375.394337537927;6053.485453736482;6100.359462256399;6177.84555386119;6189.81430557084;6201.96899015502;6108.524204008529;6147.0779383092895;6147.877042459037;6151.846203844761;6151.98492248774;5898.528117750656;6067.575269731076;6067.878642427038;6071.757129714939;6085.786997455245;6033;6035.9094613579955;6057.242844644419;6066.332703402711;6077.361877003028;5848.590598658223;5932.525397968066;5934.732937017931;5958.731857066529;5964.224650795369;6068.757249709962;6072.757089716539;6091.451769340781;6101.084837274444;6102.115193297036;5955.3746856581165;5968.731407086605;5972.044472884491;5972.34304226526;5972.8805423892145 04:02:55 INFO - PROCESS | 1635 | |1;ext.html;713.3829237709381;731.9341259286663;736.0100664606105;752.6086435053772;755.7959350975237;39006.60993390069;41137.794311028476;41141.58858411415;41161.58838411615;41176;35293.94118176452;38840;40697.779066627976;41000.38499422511;41214;7570.77287681369;7680.731174408897;7711.807204819868;7712.922870771305;7716.189800070996;7604.505707129047;7697.576633285167;7701.8844717329;10452.216083793708;10801.675949721483;10795.946020269927;10823.512941917632;10827.29622574534;10845.783084338309;10946.288491248084;10756.78486430271;10793.352398856094;10798.514066866932;10798.920107989177;10816.080633146114;10373.481325933673;10435.16518678504;10453.581856725721;10459.477026148737;10471.79056418875;34278;34444.82777586121;34521.964341069805;34524.82737586321;34544.6545534544;3667.339878821811;3682.797446140461;3701.68535674468;3706.7590606610484;3728.440733889911;24735.50528989428;25091.24726258215;25978.83095260718;26373.604395934075;26522.33694157642;3004.5042567976257;3024.123004328742;3024.4555979923607;3055.8319292438905;3066.0801759472292;349210;350669.49330506625;351304;351529;351576;44137.89655258644;44263.336049959275;44295.114097717866;44325;44381.112377752266;35016;46281;46333;46338.76830615825;46498;12617.873821261854;12914.612561623166;12918.483260669467;12942.029347798765;12943.093983421259;11059.94930481603;11062.502187401586;11071.5571377144;11075.224734268524;11082.445877706083;9694.36986595869;11751;11900;11999.88000120005;12029.518819247307;5562.72186390687;5642.407547207484;5646.181303710939;5680.109125249218;5685.607026278588;971.6356366362614;1111.4609414433994;1114.8662160540625;1120.288616728367;1167.795635763738;21295.8935205323;26070.608940865903;26332.341691457485;26527.204183874514;26646.333841654116;1175.7295821960997;1198.1493139870615;1200.2378489658954;1200.765850659113;1255.253124390986;13621.318934053257;13682.863171368357;13729.862701372858;13855.376508057161;13900.721985560232;449075;573709;586312.7793386832;587198;587597;41212.58787412087;41793;43586.69239922807;49243.50756492461;50066.499335006185;1352.6415499892537;1356.5658989123583;1362.9591112266648;1375.7386096641605;1376.8141300924246;27012.968930261883;27181.86409067942;27640.861795690893;27674;27753.44493110167;41445;45535.77232113818;46699.06601867876;48809.0238195227;48868.5113148864;403712;405838;406819;406964;407293;30305.69694303029;30368.544471833382;30369.544456833606;30419.39161216719;30487;36796;37517.43723844199;37976.05059873525;38111.237775244896;38174.236515270095;21849.672254916506;25682.743172568782;30397;31442.21394465065;32783;30963.845180774853;31891.927024743316;32005.519917201727;32026.19934501656;32043.519347210276;31570;32224.677753223106;32247.516287256178;32268.677313226566;32346.514802278456;27189.86405067962;28157.577636335882;28193.71806281993;28466.28834279077;29309.12072637824;21554.568908622052;21715.239966601093;21751.891240543697;22001.789901555567;22080.2271920482 04:02:55 INFO - PROCESS | 1635 | |2;jquery.html;370.8349784345964;382.41681435810386;383.61638361638364;394.94865667463233;424.9893752656185;13795.310234488286;15859.36562537497;20631;21199.152033918643;21896.671549926763;18576;22085;22357.776422235773;22384.77615223847;22404.767737774415;6325.588836725621;6424.839379015515;6481.870362592746;6530.902036469457;6615.272320044815;6035.124906888498;6467.644279564622;6559.8032059038305;6592.769253076143;6594.835129121762;6265.655388953605;6858.211305699859;7203.387712044482;7335.669894854745;7394.815129621748;7074.115735533059;7191.496595238335;7245.8550828983125;7246.927530724678;7332.230115837813;7096.822579435504;7109.786706398816;7113.075300210991;7114.608696521689;7132.215456299803;24211.39471513226;24675.136370226955;25208.873955630286;25888.74111258882;26306.605400919;2775.88896444142;2838;2857.328527795987;2903.4097954122753;2944.484715174836;15032.098074115587;15048.548543543711;15054.849451505565;15628.92185539065;16015.51953441387;1591.4303017065981;1884.3498992847447;1894.9810501894942;1929.5465565592074;1951.9219231230734;145705;153907.9999999989;156778;158815;159678;18949.905250473934;19014.904925475283;19144.904275478813;19216.423507294803;19294;24705.135320263704;30288.8797784153;30329.090127295774;30377;30425.391492170034;8136.75589732309;9167.404118732262;9233.215176710055;9308.348415610842;9654.517274136266;7474.215207403253;7855.685772569148;7856;8038.437309388287;8043.477173983672;7405.629718514053;8892.3330750194;9049.864252036225;9062.818743625223;9126.543672816333;3248.480243161083;3554.2536067425613;3562.893113206556;3627.891163265106;3637.9636203637624;996.3025881882711;998.3959704378747;999.8550210219478;1015.5227043289642;1033.266380869576;17151.399701010403;19348.80651193498;20736.688949665768;20963.580728385652;21266.36200913975;848.8641817309201;941.2328951904313;972.5234635028785;1001.324106228293;1018.556927736437;10768.892311076788;10953.671389858317;11029.669109926715;11095.83356249657;11108.833367499494;672770;674136;678301;682260;689179.4066771287;139635;140999;142654;144104;147738;1117.335185564604;1139.1001109123865;1164.3072371938683;1171.707073231692;1175.26545908807;18177.363792267206;18503.259869605605;18523.81476185221;18683.065846707883;19162.329318473785;61704.38295617166;64488.03267951078;65403;65617.67191164014;67154;86299.56850215708;87195;88061;88174.55912720396;90255;9385.85921211196;9507.714768556954;10002.649907253211;10489.423081730272;11427.771444571228;12634.736526347291;12692.301923393932;13100.082994190316;13143;13170.07809453329;11240.325580465198;11250.606228781953;11541.653750387502;11564.94217528907;11577.884221157681;11000.834987475035;11247.66257012291;11422.971932526112;11470;11564.94217528907;11212.27120237182;11442;11586.768264634491;11634.709132271422;11942.701432464259;11180;11480;11535.942320288344;11541.076713862703;11560.01179593039;11094.334339939629;11161.832572511581;11434.771304573696;11567;11607 04:02:55 INFO - PROCESS | 1635 | |3;mootools.html;1327.1307293722602;1541.529833400813;1557.1046648177298;1565.1391734545996;1571.779950806887;9041.457512549252;9460.905390946089;9478.336516443844;9576;9582.520873956291;9352.672656457025;10385.948070259637;10723.517441715123;10752.301100428467;10791.62229321974;2288.9885550572226;2321.025169428844;2322.3497420722224;2324.1168356024773;2326.220716060122;2177.118267101818;2301.2175860207526;2306.5271619318;2308.1690591387087;2309.815214782813;1900.353879680915;1972.063269946771;1972.516733400319;1973.4868934077099;1978.4855937456293;1994.5911088226878;2014.4359579317816;2241.652543855705;2328.7787660172257;2335.649652552114;2288.656701494789;2291.5073259249175;2291.8510296830655;2297.7127859017623;2299.3329835869026;10852.565897364097;10953.452327383678;10985.395803230818;11028.558857645685;11034.558617655364;4255.553166917491;4888.169011268057;5064.5441910228255;5073.847784566469;5548.77804887804;3166.509191075387;3246.4643333849885;3406.2506248625264;3430.3482338355634;3592.335417947662;1158.3860553906443;1161.692151579832;1206.849143857018;1217.257472941505;1217.4764851114016;15042.548723538312;15196.468123615621;15198.772018419733;15199.392024319013;15232.543023709306;4540.931886021713;4764.785584648699;4843.128236917389;4852.393450818648;4878.902421951541;12562.120651554304;12568.308743019039;12605;12606.306653134166;12651.177673451197;5880.147378630075;5887.411258874164;5893.027650437715;5894.17481552583;5900.970495147582;4986.975065124651;5026.447090820006;5072.923906141411;5078.3905931287745;5148.794048238028;3829;3930.6265904739003;3954.1217921487637;4025.0138716014762;4084.7344922580533;1118.3234143343323;1121.7980763462492;1125.7185703574107;1134.82977553366;1136.9705076438518;870.7605408512583;907.7412937312835;911.981760364789;938.4463166731662;946.8248374050822;5840.707964601753;6004.027273814724;6047.274327080779;6185.226846644169;6208.751649934043;932.5477143585356;944.5956415502901;971.8833739951251;1026.984595231072;1036.3056751976194;2503.486785209028;3999.460072890181;4255;4353.36876152956;4367.2575662137515;10334.17326613869;12618.369081545887;12977.870221297666;13102.541411050568;13141.605751827461;13195.67010824737;13205.73588528224;13207.60377188686;13208.405621747044;13337.933310333387;9660.420374777535;9674.129328360481;9797.412155270707;9823.361481503822;9918.404895706137;6092.39076092405;6645.102911106938;6739.629320387426;6818.249992500921;6844.8973265402055;10723.785524289315;11815.17293789461;11865.5847045353;11957.641270761891;12126.696832579257;11660.41697915084;11920.463579138786;12030.819537707117;12123.696907577381;12140.93929530382;8754.21212090915;8795.032546420016;8886;8954.955225223832;8974.955125224333;9524.285678574273;9712.611495540099;9737.707868763948;9739;9747.463889486145;8062.193780621891;8093.757187284155;8435.704750333955;8648.481091134552;8758.211760941545;8517.403781735467;8535.658573656985;8548.829023419621;8589.441686290622;8671.783205419915;7655.272749088827;7656.846863062596;7693.307602315818;7696.345810606162;7697.422693297913;5584.190292407659;5731.627444216113;5786.913196302143;5811.4479124483105;5871.970640146943;5061.31672224245;5736.5984381094595;5758.568107392046;5887.293524777054;6119.785807496716 04:02:55 INFO - PROCESS | 1635 | |4;prototype.html;353.7506058228949;364.4424031232215;369.833574891299;369.97040236781044;374.0331243734945;4270;4874.488178741234;5094.109654731457;5108.4636113208135;5114.6164037697135;4344.391785150082;4422.722298016524;4660.976695116519;4906.484819093997;4969.676970996883;3797;3982.745435187921;4102;4107.979460102695;4126.381042843567;4148.900541356543;4169.83016983017;4178.56125106864;4184.644305234059;4211.18918864888;3708.128589781399;3971.8808435746973;4114.691398145136;4140.660526802362;4163.7501749894955;3483.7038851697635;3961.9405708914387;4066.247744167309;4076.084240407004;4111.691623128278;3395.015445520821;3657.8542453489977;3658.378075727106;3813.8474461021524;3853.171568112841;4128.4632997710105;4717.080169366975;4785.401824771903;4866.58634016109;4869.172240719086;4543.7728113594185;4711.725350881139;4742.913118228003;4778.061492182283;4780.450248221464;4947.82682606107;5002.674826136289;5346.759395827158;5361.115415956401;5384.300040994684;3730.7388482806214;3801.3727734923705;4135.400366946776;4273.50854651716;4343.609075183217;4262.760302170342;4617.9131468650485;4808.711477311373;5427.782888684448;5498.725063746797;4255.680823938155;4357.433533640607;4382.926183085165;4409.404730361424;4437.334399839985;4391.6504670001395;4477.350784136282;4487.439070116236;4508.5040645529625;4516.909661806745;3926;4283.22901877665;4420.563316922014;4456.952616135206;4668.649851261169;4446.82212711488;4655.511171326962;4783.617310615143;5206.505381988705;5228.163493840967;1427.414759948416;1431.7257640699786;1482.35517549864;1496.835348111707;1518.4837155367006;952.7141857442739;1081.1891081688734;1125.791728530208;1128.8485744540524;1134.9659510214706;4254.638355739735;4401.801918913592;4807.6394270429855;4826.372571565744;4880.902381952341;5179.249008893765;5235.947640523546;5421.566274698014;5432.809851655252;5531.834044978657;4045.7370270932297;4430.645548356124;4732.7055016827535;4829.673128202066;4913.975430122827;2586.8447893126095;2814.4230432761233;2823.054276817289;2831.688514263429;2871.798974071795;5064.772085256099;5535.501804837584;5577.860553486195;5592.888142237132;5696.3733989261145;4581.885452863705;4961.040389046379;5494.269305168859;5502.724863756876;5641.717914104278;4842.661013729005;4971.428285747185;5254.710990895537;5443.265159203457;5552.888942221133;4467.843625473093;4918.336024636628;5377.247185394126;5441.143399715181;5486.615936884539;4880.633952453652;4919.458859525378;4962.255661650781;5077;5099.974500127476;4594.887575619869;4858.873888048143;4936.8777071146;5344.78620855177;5578;3764.3788774852937;3874.709396795195;4239.300515414922;4254.957535403846;4283.95716042848;4636.350910872548;4896.755162241945;4929.950700493093;5306.708131052829;5441.347038355423;4460.9107817844115;4674.439067311944;4718.0799744050955;5056;5124.948750512447;4321;4623.69945953512;5172.818951336685;5191.506806853343;5231.450697676689;4536.9565000049515;4631.814727410866;4902.485239049991;5043.36957880265;5158.071547121404;4321.805518751601;4979.377577802775;5203.661761985459;5221.869453263699;5258.8948221036135;4143.02638879869;4807.010181549236;4975.97992411562;5086.440491546001;5113.846584602468 04:02:55 INFO - PROCESS | 1635 | |5;yui.html;696.6029363262936;730.4959577891254;750.4221749253076;812.7358608452253;813.4305985809933;14365.784513232296;15143;15175.317110730017;15176.468823591176;15180.696386072272;13191.868081319184;13613;13674.794878076811;13706;14137.010409271355;874.7856775090112;912.5209265135791;915.5834095486538;918.1231923513029;918.6555041859302;922.3681777982071;930.6044930904372;931.0084759730898;933.785229397239;935.6631612619485;997.6059456514672;1006.6979906028199;1007.1489591295343;1010.8736407949007;1011.9392836429801;1000.604761119361;1003.508280942333;1004.1264100232771;1004.8743907011624;1004.9346792458467;742.0909386002158;742.3022358982539;742.8440027594212;742.8662840688728;743.3681370834802;14760.409583616642;15246.618834529114;15312.770308445382;15429.30568124437;15455.149966751824;13274.388914220002;13713.725725485434;13816.585502434944;14113;14152.221627810466;10499.265051446402;11210.215284930058;11382.804805495469;11453.198276120675;11664.833516648352;3258.0877354340823;3604.2431089471243;3667.2665466906724;3785.280796648628;3786.2427514496935;107899.86688138505;111469;112086.31870521948;114288.42855785668;114946;10509.264351495474;10530.104941080093;10658.307210031478;10786.46067696612;11137.832932506019;21928.342149735534;22387;22412.66381004286;22436.990335434944;22456.43858903508;7387.8153046174275;7460.589667568227;7475.439342049368;7578.658960346797;7658.349040331635;4111.939444878207;4174.478190226222;4175.645070169009;4210.179015092028;4217.198732240864;3300.85146168423;3337.299167174872;3391.8134502602593;3396.711279541267;3396.997885623747;600.9399060093956;605.4581149870841;610.4810910725847;620.3455354600849;624.9156363890817;603.3935894426073;616.6207782213996;639.4916041746823;647.5337756815086;674.8346655069539;8488.872666910001;8597.484150950962;9818.165455936325;9837.409755414697;10030.297879148535;607.419913982146;631.5452873930763;665.0722242471821;682.6552590941543;701.9227884932756;4540.296254080623;4719.10337035962;4723.7874295656775;4778.856634300976;4791.856244312677;75240;89513;91049;91730;94058.5297073524;73140.90288645675;73361.53276934431;77983;78826.21173788303;79875.20124798793;66537.66731166506;68051.27794888247;68425;68959.27601809894;69835.65082174659;10097.141742951637;10655.413952232702;10660.680179594625;10809.459527023775;10885.836712449161;36414.63585364113;46631.53368466272;46688;48652.5134748648;49410;53708.73145634403;59616;61577.38422615896;61790;62254;10092;11800.409979501163;11807.763844722886;11941.46263418131;12079.698007549881;11834.940825295818;13732.244726540137;13751.703420767088;13919.860801391857;14088.22514761657;10626;12469.161030507441;12933.870661293267;13075.992521719867;13146.079774415699;12950.287734174712;13015.869841301466;13055.733248040804;13157.868421316047;13250.867491324963;10366.792664146826;12830.422630981815;12859.292738899076;12940.676483087622;13198.406071726604;10599.674084787523;10621.309614875317;10621.313428965905;10772.622958196738;10784.19118566095;8044.477108987897;9831.508424578886;10286.845697314697;10482.21383396233;10500.159987200852 04:02:55 INFO - PROCESS | 1635 | __end_tp_report 04:02:55 INFO - PROCESS | 1635 | __start_cc_report 04:02:55 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,4041 04:02:55 INFO - PROCESS | 1635 | __end_cc_report 04:02:55 INFO - PROCESS | 1635 | __startTimestamp1488801775835__endTimestamp 04:02:55 INFO - PROCESS | 1635 | 04:02:55 INFO - PROCESS | 1635 | ------- Summary: start ------- 04:02:55 INFO - PROCESS | 1635 | Number of tests: 6 04:02:55 INFO - PROCESS | 1635 | 04:02:55 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5677.30 Median:5955.37 stddev:666.02 (11.2%) stddev-sans-first:631.86 04:02:55 INFO - PROCESS | 1635 | Values: 2916.5 3321.6 3339.2 3344.8 3407.2 5541.3 5647.5 5698.4 5730.3 5775.0 5625.2 5709.1 5749.6 5795.7 5848.8 5101.9 5124.1 5152.7 5172.3 5210.1 5276.5 5307.5 5323.9 5331.8 5374.0 5091.5 5135.2 5193.3 5212.7 5288.7 4651.2 4943.0 5185.8 5207.9 5213.8 5104.1 5154.9 5171.0 5173.9 5180.0 5674.4 5684.4 5686.6 5687.6 5713.5 6166.8 6169.3 6171.8 6185.8 6186.8 5025.7 6153.9 6183.7 6225.4 6239.1 5353.9 5746.4 5790.5 5815.1 5817.9 6241.8 6253.7 6254.2 6258.1 6266.8 6016.3 6074.4 6138.3 6143.0 6223.8 6120.7 6128.5 6132.6 6139.9 6148.8 6115.2 6115.9 6122.8 6129.4 6130.8 5937.1 6094.8 6116.0 6122.6 6143.4 4386.6 4821.3 4988.7 5066.2 5100.1 4453.7 4460.4 4496.0 4529.8 4550.6 5134.0 5568.3 5731.9 5768.3 5786.4 6111.4 6120.6 6152.0 6164.0 6234.8 5382.5 5629.2 5630.4 5633.4 5639.0 4888.2 5415.8 5416.3 5427.6 5436.5 6137.6 6182.1 6196.5 6197.2 6203.3 3385.9 6123.4 6168.3 6230.1 6245.0 6346.1 6347.8 6350.8 6353.1 6375.4 6053.5 6100.4 6177.8 6189.8 6202.0 6108.5 6147.1 6147.9 6151.8 6152.0 5898.5 6067.6 6067.9 6071.8 6085.8 6033.0 6035.9 6057.2 6066.3 6077.4 5848.6 5932.5 5934.7 5958.7 5964.2 6068.8 6072.8 6091.5 6101.1 6102.1 5955.4 5968.7 5972.0 5972.3 5972.9 04:02:55 INFO - PROCESS | 1635 | 04:02:55 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:55884.74 Median:31730.96 stddev:119447.00 (376.4%) stddev-sans-first:119710.25 04:02:55 INFO - PROCESS | 1635 | Values: 713.4 731.9 736.0 752.6 755.8 39006.6 41137.8 41141.6 41161.6 41176.0 35293.9 38840.0 40697.8 41000.4 41214.0 7570.8 7680.7 7711.8 7712.9 7716.2 7604.5 7697.6 7701.9 10452.2 10801.7 10795.9 10823.5 10827.3 10845.8 10946.3 10756.8 10793.4 10798.5 10798.9 10816.1 10373.5 10435.2 10453.6 10459.5 10471.8 34278.0 34444.8 34522.0 34524.8 34544.7 3667.3 3682.8 3701.7 3706.8 3728.4 24735.5 25091.2 25978.8 26373.6 26522.3 3004.5 3024.1 3024.5 3055.8 3066.1 349210.0 350669.5 351304.0 351529.0 351576.0 44137.9 44263.3 44295.1 44325.0 44381.1 35016.0 46281.0 46333.0 46338.8 46498.0 12617.9 12914.6 12918.5 12942.0 12943.1 11059.9 11062.5 11071.6 11075.2 11082.4 9694.4 11751.0 11900.0 11999.9 12029.5 5562.7 5642.4 5646.2 5680.1 5685.6 971.6 1111.5 1114.9 1120.3 1167.8 21295.9 26070.6 26332.3 26527.2 26646.3 1175.7 1198.1 1200.2 1200.8 1255.3 13621.3 13682.9 13729.9 13855.4 13900.7 449075.0 573709.0 586312.8 587198.0 587597.0 41212.6 41793.0 43586.7 49243.5 50066.5 1352.6 1356.6 1363.0 1375.7 1376.8 27013.0 27181.9 27640.9 27674.0 27753.4 41445.0 45535.8 46699.1 48809.0 48868.5 403712.0 405838.0 406819.0 406964.0 407293.0 30305.7 30368.5 30369.5 30419.4 30487.0 36796.0 37517.4 37976.1 38111.2 38174.2 21849.7 25682.7 30397.0 31442.2 32783.0 30963.8 31891.9 32005.5 32026.2 32043.5 31570.0 32224.7 32247.5 32268.7 32346.5 27189.9 28157.6 28193.7 28466.3 29309.1 21554.6 21715.2 21751.9 22001.8 22080.2 04:02:55 INFO - PROCESS | 1635 | 04:02:55 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:40579.50 Median:22394.77 stddev:113834.63 (508.3%) stddev-sans-first:114113.93 04:02:55 INFO - PROCESS | 1635 | Values: 370.8 382.4 383.6 394.9 425.0 13795.3 15859.4 20631.0 21199.2 21896.7 18576.0 22085.0 22357.8 22384.8 22404.8 6325.6 6424.8 6481.9 6530.9 6615.3 6035.1 6467.6 6559.8 6592.8 6594.8 6265.7 6858.2 7203.4 7335.7 7394.8 7074.1 7191.5 7245.9 7246.9 7332.2 7096.8 7109.8 7113.1 7114.6 7132.2 24211.4 24675.1 25208.9 25888.7 26306.6 2775.9 2838.0 2857.3 2903.4 2944.5 15032.1 15048.5 15054.8 15628.9 16015.5 1591.4 1884.3 1895.0 1929.5 1951.9 145705.0 153908.0 156778.0 158815.0 159678.0 18949.9 19014.9 19144.9 19216.4 19294.0 24705.1 30288.9 30329.1 30377.0 30425.4 8136.8 9167.4 9233.2 9308.3 9654.5 7474.2 7855.7 7856.0 8038.4 8043.5 7405.6 8892.3 9049.9 9062.8 9126.5 3248.5 3554.3 3562.9 3627.9 3638.0 996.3 998.4 999.9 1015.5 1033.3 17151.4 19348.8 20736.7 20963.6 21266.4 848.9 941.2 972.5 1001.3 1018.6 10768.9 10953.7 11029.7 11095.8 11108.8 672770.0 674136.0 678301.0 682260.0 689179.4 139635.0 140999.0 142654.0 144104.0 147738.0 1117.3 1139.1 1164.3 1171.7 1175.3 18177.4 18503.3 18523.8 18683.1 19162.3 61704.4 64488.0 65403.0 65617.7 67154.0 86299.6 87195.0 88061.0 88174.6 90255.0 9385.9 9507.7 10002.6 10489.4 11427.8 12634.7 12692.3 13100.1 13143.0 13170.1 11240.3 11250.6 11541.7 11564.9 11577.9 11000.8 11247.7 11423.0 11470.0 11564.9 11212.3 11442.0 11586.8 11634.7 11942.7 11180.0 11480.0 11535.9 11541.1 11560.0 11094.3 11161.8 11434.8 11567.0 11607.0 04:02:55 INFO - PROCESS | 1635 | 04:02:55 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:6492.97 Median:4012.24 stddev:4095.22 (102.1%) stddev-sans-first:4088.31 04:02:55 INFO - PROCESS | 1635 | Values: 1327.1 1541.5 1557.1 1565.1 1571.8 9041.5 9460.9 9478.3 9576.0 9582.5 9352.7 10385.9 10723.5 10752.3 10791.6 2289.0 2321.0 2322.3 2324.1 2326.2 2177.1 2301.2 2306.5 2308.2 2309.8 1900.4 1972.1 1972.5 1973.5 1978.5 1994.6 2014.4 2241.7 2328.8 2335.6 2288.7 2291.5 2291.9 2297.7 2299.3 10852.6 10953.5 10985.4 11028.6 11034.6 4255.6 4888.2 5064.5 5073.8 5548.8 3166.5 3246.5 3406.3 3430.3 3592.3 1158.4 1161.7 1206.8 1217.3 1217.5 15042.5 15196.5 15198.8 15199.4 15232.5 4540.9 4764.8 4843.1 4852.4 4878.9 12562.1 12568.3 12605.0 12606.3 12651.2 5880.1 5887.4 5893.0 5894.2 5901.0 4987.0 5026.4 5072.9 5078.4 5148.8 3829.0 3930.6 3954.1 4025.0 4084.7 1118.3 1121.8 1125.7 1134.8 1137.0 870.8 907.7 912.0 938.4 946.8 5840.7 6004.0 6047.3 6185.2 6208.8 932.5 944.6 971.9 1027.0 1036.3 2503.5 3999.5 4255.0 4353.4 4367.3 10334.2 12618.4 12977.9 13102.5 13141.6 13195.7 13205.7 13207.6 13208.4 13337.9 9660.4 9674.1 9797.4 9823.4 9918.4 6092.4 6645.1 6739.6 6818.2 6844.9 10723.8 11815.2 11865.6 11957.6 12126.7 11660.4 11920.5 12030.8 12123.7 12140.9 8754.2 8795.0 8886.0 8955.0 8975.0 9524.3 9712.6 9737.7 9739.0 9747.5 8062.2 8093.8 8435.7 8648.5 8758.2 8517.4 8535.7 8548.8 8589.4 8671.8 7655.3 7656.8 7693.3 7696.3 7697.4 5584.2 5731.6 5786.9 5811.4 5872.0 5061.3 5736.6 5758.6 5887.3 6119.8 04:02:55 INFO - PROCESS | 1635 | 04:02:55 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4332.40 Median:4645.93 stddev:1181.24 (25.4%) stddev-sans-first:1146.18 04:02:55 INFO - PROCESS | 1635 | Values: 353.8 364.4 369.8 370.0 374.0 4270.0 4874.5 5094.1 5108.5 5114.6 4344.4 4422.7 4661.0 4906.5 4969.7 3797.0 3982.7 4102.0 4108.0 4126.4 4148.9 4169.8 4178.6 4184.6 4211.2 3708.1 3971.9 4114.7 4140.7 4163.8 3483.7 3961.9 4066.2 4076.1 4111.7 3395.0 3657.9 3658.4 3813.8 3853.2 4128.5 4717.1 4785.4 4866.6 4869.2 4543.8 4711.7 4742.9 4778.1 4780.5 4947.8 5002.7 5346.8 5361.1 5384.3 3730.7 3801.4 4135.4 4273.5 4343.6 4262.8 4617.9 4808.7 5427.8 5498.7 4255.7 4357.4 4382.9 4409.4 4437.3 4391.7 4477.4 4487.4 4508.5 4516.9 3926.0 4283.2 4420.6 4457.0 4668.6 4446.8 4655.5 4783.6 5206.5 5228.2 1427.4 1431.7 1482.4 1496.8 1518.5 952.7 1081.2 1125.8 1128.8 1135.0 4254.6 4401.8 4807.6 4826.4 4880.9 5179.2 5235.9 5421.6 5432.8 5531.8 4045.7 4430.6 4732.7 4829.7 4914.0 2586.8 2814.4 2823.1 2831.7 2871.8 5064.8 5535.5 5577.9 5592.9 5696.4 4581.9 4961.0 5494.3 5502.7 5641.7 4842.7 4971.4 5254.7 5443.3 5552.9 4467.8 4918.3 5377.2 5441.1 5486.6 4880.6 4919.5 4962.3 5077.0 5100.0 4594.9 4858.9 4936.9 5344.8 5578.0 3764.4 3874.7 4239.3 4255.0 4284.0 4636.4 4896.8 4930.0 5306.7 5441.3 4460.9 4674.4 4718.1 5056.0 5124.9 4321.0 4623.7 5172.8 5191.5 5231.5 4537.0 4631.8 4902.5 5043.4 5158.1 4321.8 4979.4 5203.7 5221.9 5258.9 4143.0 4807.0 4976.0 5086.4 5113.8 04:02:55 INFO - PROCESS | 1635 | 04:02:55 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:19081.59 Median:3364.56 stddev:27191.56 (808.2%) stddev-sans-first:27232.80 04:02:55 INFO - PROCESS | 1635 | Values: 696.6 730.5 750.4 812.7 813.4 14365.8 15143.0 15175.3 15176.5 15180.7 13191.9 13613.0 13674.8 13706.0 14137.0 874.8 912.5 915.6 918.1 918.7 922.4 930.6 931.0 933.8 935.7 997.6 1006.7 1007.1 1010.9 1011.9 1000.6 1003.5 1004.1 1004.9 1004.9 742.1 742.3 742.8 742.9 743.4 14760.4 15246.6 15312.8 15429.3 15455.1 13274.4 13713.7 13816.6 14113.0 14152.2 10499.3 11210.2 11382.8 11453.2 11664.8 3258.1 3604.2 3667.3 3785.3 3786.2 107899.9 111469.0 112086.3 114288.4 114946.0 10509.3 10530.1 10658.3 10786.5 11137.8 21928.3 22387.0 22412.7 22437.0 22456.4 7387.8 7460.6 7475.4 7578.7 7658.3 4111.9 4174.5 4175.6 4210.2 4217.2 3300.9 3337.3 3391.8 3396.7 3397.0 600.9 605.5 610.5 620.3 624.9 603.4 616.6 639.5 647.5 674.8 8488.9 8597.5 9818.2 9837.4 10030.3 607.4 631.5 665.1 682.7 701.9 4540.3 4719.1 4723.8 4778.9 4791.9 75240.0 89513.0 91049.0 91730.0 94058.5 73140.9 73361.5 77983.0 78826.2 79875.2 66537.7 68051.3 68425.0 68959.3 69835.7 10097.1 10655.4 10660.7 10809.5 10885.8 36414.6 46631.5 46688.0 48652.5 49410.0 53708.7 59616.0 61577.4 61790.0 62254.0 10092.0 11800.4 11807.8 11941.5 12079.7 11834.9 13732.2 13751.7 13919.9 14088.2 10626.0 12469.2 12933.9 13076.0 13146.1 12950.3 13015.9 13055.7 13157.9 13250.9 10366.8 12830.4 12859.3 12940.7 13198.4 10599.7 10621.3 10621.3 10772.6 10784.2 8044.5 9831.5 10286.8 10482.2 10500.2 04:02:55 INFO - PROCESS | 1635 | -------- Summary: end -------- 04:02:55 INFO - PROCESS | 1635 | 04:02:56 INFO - TEST-INFO | 1635: exit 0 04:02:56 INFO - TEST-OK | dromaeo_css | took 1121697ms 04:02:56 INFO - TEST-START | kraken 04:02:56 INFO - operating with platform_type : mac_ 04:02:56 INFO - Initialising browser for kraken test... 04:02:56 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/tmpFMgSox/profile http://localhost:49236/getInfo.html) 04:02:58 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 04:02:58 INFO - PROCESS | 1648 | colorDepth:24 04:02:58 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 04:02:58 INFO - PROCESS | 1648 | __metrics 04:02:58 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:02:58 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:02:59 INFO - TEST-INFO | 1648: exit 0 04:02:59 INFO - Browser initialized. 04:02:59 INFO - Running cycle 1/1 for kraken test... 04:02:59 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/tmpFMgSox/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:03:11 INFO - PROCESS | 1649 | RSS: Main: 231702528 04:03:11 INFO - PROCESS | 1649 | 04:03:14 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 04:03:15 INFO - PROCESS | 1649 | RSS: Main: 282251264 04:03:15 INFO - PROCESS | 1649 | 04:03:18 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 04:03:18 INFO - PROCESS | 1649 | RSS: Main: 285581312 04:03:18 INFO - PROCESS | 1649 | 04:03:22 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 04:03:22 INFO - PROCESS | 1649 | RSS: Main: 377155584 04:03:22 INFO - PROCESS | 1649 | 04:03:24 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 04:03:25 INFO - PROCESS | 1649 | RSS: Main: 278052864 04:03:25 INFO - PROCESS | 1649 | 04:03:27 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:03:28 INFO - PROCESS | 1649 | RSS: Main: 282288128 04:03:28 INFO - PROCESS | 1649 | 04:03:31 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 04:03:31 INFO - PROCESS | 1649 | RSS: Main: 325849088 04:03:31 INFO - PROCESS | 1649 | 04:03:35 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 04:03:35 INFO - PROCESS | 1649 | RSS: Main: 326971392 04:03:35 INFO - PROCESS | 1649 | 04:03:38 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 04:03:39 INFO - PROCESS | 1649 | RSS: Main: 325591040 04:03:39 INFO - PROCESS | 1649 | 04:03:41 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:03:41 INFO - PROCESS | 1649 | RSS: Main: 297963520 04:03:41 INFO - PROCESS | 1649 | 04:03:43 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:03:44 INFO - PROCESS | 1649 | RSS: Main: 302600192 04:03:44 INFO - PROCESS | 1649 | 04:03:46 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:03:47 INFO - PROCESS | 1649 | RSS: Main: 310480896 04:03:47 INFO - PROCESS | 1649 | 04:03:50 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:03:50 INFO - PROCESS | 1649 | RSS: Main: 324206592 04:03:50 INFO - PROCESS | 1649 | 04:03:53 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:03:54 INFO - PROCESS | 1649 | RSS: Main: 317734912 04:03:54 INFO - PROCESS | 1649 | 04:03:56 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 04:03:56 INFO - PROCESS | 1649 | RSS: Main: 362401792 04:03:56 INFO - PROCESS | 1649 | 04:03:56 INFO - PROCESS | 1649 | __start_tp_report 04:03:56 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 04:03:56 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 04:03:56 INFO - PROCESS | 1649 | |i|pagename|runs| 04:03:56 INFO - PROCESS | 1649 | |0;ai-astar;116;117;115;116;115;115;116;115;116;116 04:03:56 INFO - PROCESS | 1649 | |1;audio-beat-detection;149;112;109;152;110;112;112;111;130;110 04:03:56 INFO - PROCESS | 1649 | |2;audio-dft;185;188;186;188;181;185;185;185;183;185 04:03:56 INFO - PROCESS | 1649 | |3;audio-fft;79;60;63;91;62;61;58;60;79;59 04:03:56 INFO - PROCESS | 1649 | |4;audio-oscillator;91;73;113;97;96;76;85;69;69;83 04:03:56 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;90;88;89;88;88;88;92;89;88;88 04:03:56 INFO - PROCESS | 1649 | |6;imaging-darkroom;98;96;98;97;96;96;97;96;111;144 04:03:56 INFO - PROCESS | 1649 | |7;imaging-desaturate;86;85;86;87;86;85;81;85;85;87 04:03:56 INFO - PROCESS | 1649 | |8;json-parse-financial;64;61;59;60;61;61;62;63;61;61 04:03:56 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;55;69;67;64;63;59;59;59;58;58 04:03:56 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;87;89;90;89;96;98;99;98;90;91 04:03:56 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;127;144;151;142;139;140;142;142;192;145 04:03:56 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;171;173;170;167;169;172;172;176;168;167 04:03:56 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;66;67;66;66;67;66;66;66;67;67 04:03:56 INFO - PROCESS | 1649 | __end_tp_report 04:03:56 INFO - PROCESS | 1649 | __start_cc_report 04:03:56 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2179 04:03:56 INFO - PROCESS | 1649 | __end_cc_report 04:03:56 INFO - PROCESS | 1649 | __startTimestamp1488801836391__endTimestamp 04:03:56 INFO - PROCESS | 1649 | 04:03:56 INFO - PROCESS | 1649 | ------- Summary: start ------- 04:03:56 INFO - PROCESS | 1649 | Number of tests: 14 04:03:56 INFO - PROCESS | 1649 | 04:03:56 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:115.70 Median:116.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 04:03:56 INFO - PROCESS | 1649 | Values: 116.0 117.0 115.0 116.0 115.0 115.0 116.0 115.0 116.0 116.0 04:03:56 INFO - PROCESS | 1649 | 04:03:56 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:120.70 Median:112.00 stddev:16.85 (15.0%) stddev-sans-first:14.42 04:03:56 INFO - PROCESS | 1649 | Values: 149.0 112.0 109.0 152.0 110.0 112.0 112.0 111.0 130.0 110.0 04:03:56 INFO - PROCESS | 1649 | 04:03:56 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:185.10 Median:185.00 stddev:2.08 (1.1%) stddev-sans-first:2.20 04:03:56 INFO - PROCESS | 1649 | Values: 185.0 188.0 186.0 188.0 181.0 185.0 185.0 185.0 183.0 185.0 04:03:56 INFO - PROCESS | 1649 | 04:03:56 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:67.20 Median:62.50 stddev:11.47 (18.3%) stddev-sans-first:11.34 04:03:56 INFO - PROCESS | 1649 | Values: 79.0 60.0 63.0 91.0 62.0 61.0 58.0 60.0 79.0 59.0 04:03:56 INFO - PROCESS | 1649 | 04:03:56 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:85.20 Median:84.00 stddev:14.24 (17.0%) stddev-sans-first:14.95 04:03:56 INFO - PROCESS | 1649 | Values: 91.0 73.0 113.0 97.0 96.0 76.0 85.0 69.0 69.0 83.0 04:03:56 INFO - PROCESS | 1649 | 04:03:56 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:88.50 stddev:1.32 (1.5%) stddev-sans-first:1.32 04:03:56 INFO - PROCESS | 1649 | Values: 90.0 88.0 89.0 88.0 88.0 88.0 92.0 89.0 88.0 88.0 04:03:56 INFO - PROCESS | 1649 | 04:03:56 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:102.90 Median:96.50 stddev:15.14 (15.7%) stddev-sans-first:15.95 04:03:56 INFO - PROCESS | 1649 | Values: 98.0 96.0 98.0 97.0 96.0 96.0 97.0 96.0 111.0 144.0 04:03:56 INFO - PROCESS | 1649 | 04:03:56 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:86.00 stddev:1.70 (2.0%) stddev-sans-first:1.79 04:03:56 INFO - PROCESS | 1649 | Values: 86.0 85.0 86.0 87.0 86.0 85.0 81.0 85.0 85.0 87.0 04:03:56 INFO - PROCESS | 1649 | 04:03:56 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:61.00 stddev:1.42 (2.3%) stddev-sans-first:1.12 04:03:56 INFO - PROCESS | 1649 | Values: 64.0 61.0 59.0 60.0 61.0 61.0 62.0 63.0 61.0 61.0 04:03:56 INFO - PROCESS | 1649 | 04:03:56 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:4.46 (7.3%) stddev-sans-first:4.15 04:03:56 INFO - PROCESS | 1649 | Values: 55.0 69.0 67.0 64.0 63.0 59.0 59.0 59.0 58.0 58.0 04:03:56 INFO - PROCESS | 1649 | 04:03:56 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:92.70 Median:93.50 stddev:4.52 (4.8%) stddev-sans-first:4.30 04:03:56 INFO - PROCESS | 1649 | Values: 87.0 89.0 90.0 89.0 96.0 98.0 99.0 98.0 90.0 91.0 04:03:56 INFO - PROCESS | 1649 | 04:03:56 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:146.40 Median:143.00 stddev:17.12 (12.0%) stddev-sans-first:16.66 04:03:56 INFO - PROCESS | 1649 | Values: 127.0 144.0 151.0 142.0 139.0 140.0 142.0 142.0 192.0 145.0 04:03:56 INFO - PROCESS | 1649 | 04:03:56 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:171.50 stddev:2.88 (1.7%) stddev-sans-first:3.05 04:03:56 INFO - PROCESS | 1649 | Values: 171.0 173.0 170.0 167.0 169.0 172.0 172.0 176.0 168.0 167.0 04:03:56 INFO - PROCESS | 1649 | 04:03:56 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 04:03:56 INFO - PROCESS | 1649 | Values: 66.0 67.0 66.0 66.0 67.0 66.0 66.0 66.0 67.0 67.0 04:03:56 INFO - PROCESS | 1649 | -------- Summary: end -------- 04:03:56 INFO - PROCESS | 1649 | 04:03:57 INFO - TEST-INFO | 1649: exit 0 04:03:57 INFO - TEST-OK | kraken | took 60864ms 04:03:57 INFO - SUITE-END | took 1182s 04:03:57 INFO - Completed test suite (00:19:42) 04:03:57 INFO - javascript benchmark 04:03:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7385.206465972786, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2916.5187744022232, 3321.638128367368, 3339.2319766453725, 3344.8460281202974, 3407.1993081625815, 5541.307336582927, 5647.491725744682, 5698.401667824875, 5730.3123625165035, 5775.047117225663, 5625.1843482695085, 5709.0580054290995, 5749.568782341331, 5795.739191736371, 5848.766049358021, 5101.948980510203, 5124.128898087315, 5152.690838549699, 5172.250023746555, 5210.114280572312, 5276.525112739852, 5307.548858347026, 5323.866903327409, 5331.813386531472, 5374.032674118657, 5091.516305950929, 5135.229715542661, 5193.324867767204, 5212.713300768456, 5288.682679039251, 4651.209294419923, 4943.01139772047, 5185.792568297264, 5207.921881171786, 5213.791448342062, 5104.106781313292, 5154.948450515484, 5171.0, 5173.922391164136, 5179.974100129475, 5674.404187560329, 5684.4315568443235, 5686.60193786431, 5687.573431992576, 5713.457221563986, 6166.81499555014, 6169.259688837324, 6171.7531298748, 6185.8144255672405, 6186.783462578833, 5025.7235852028125, 6153.861535615881, 6183.721732522003, 6225.377462253784, 6239.126522286883, 5353.9196912046355, 5746.367899531048, 5790.478856902857, 5815.127730840408, 5817.912731309034, 6241.75032998684, 6253.74985000604, 6254.21822272216, 6258.092576576462, 6266.811995640138, 6016.308124565643, 6074.392560743979, 6138.263408391022, 6143.047827586731, 6223.844403889939, 6120.731300393959, 6128.453176423585, 6132.5707200495535, 6139.921477737008, 6148.815535533941, 6115.188456275656, 6115.949241104752, 6122.8251069701855, 6129.358790882686, 6130.837764763411, 5937.11212246587, 6094.809245860337, 6116.0010150213275, 6122.581127188433, 6143.372006418303, 4386.561343865652, 4821.349117869113, 4988.700677959261, 5066.214736715815, 5100.0819852426175, 4453.710508816916, 4460.397846290709, 4496.033352829158, 4529.773511324421, 4550.613197878151, 5134.0, 5568.303962004749, 5731.942680573225, 5768.278965129359, 5786.392428795, 6111.40942266768, 6120.571559990758, 6151.96924015377, 6163.982942814475, 6234.812955611339, 5382.461753824587, 5629.183768353566, 5630.352509461382, 5633.352164501053, 5638.984982703153, 4888.2178851383605, 5415.756290966916, 5416.322959630046, 5427.6200665953, 5436.483534064258, 6137.570370074052, 6182.1345011698395, 6196.47329976939, 6197.163382943245, 6203.31763506023, 3385.881494147693, 6123.418275263843, 6168.290646575521, 6230.096635987847, 6244.968775156095, 6346.111544383883, 6347.841303967438, 6350.841228969312, 6353.110564521063, 6375.394337537927, 6053.485453736482, 6100.359462256399, 6177.84555386119, 6189.81430557084, 6201.96899015502, 6108.524204008529, 6147.0779383092895, 6147.877042459037, 6151.846203844761, 6151.98492248774, 5898.528117750656, 6067.575269731076, 6067.878642427038, 6071.757129714939, 6085.786997455245, 6033.0, 6035.9094613579955, 6057.242844644419, 6066.332703402711, 6077.361877003028, 5848.590598658223, 5932.525397968066, 5934.732937017931, 5958.731857066529, 5964.224650795369, 6068.757249709962, 6072.757089716539, 6091.451769340781, 6101.084837274444, 6102.115193297036, 5955.3746856581165, 5968.731407086605, 5972.044472884491, 5972.34304226526, 5972.8805423892145], "value": 5636.395104816248, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.3829237709381, 731.9341259286663, 736.0100664606105, 752.6086435053772, 755.7959350975237, 39006.60993390069, 41137.794311028476, 41141.58858411415, 41161.58838411615, 41176.0, 35293.94118176452, 38840.0, 40697.779066627976, 41000.38499422511, 41214.0, 7570.77287681369, 7680.731174408897, 7711.807204819868, 7712.922870771305, 7716.189800070996, 7604.505707129047, 7697.576633285167, 7701.8844717329, 10452.216083793708, 10801.675949721483, 10795.946020269927, 10823.512941917632, 10827.29622574534, 10845.783084338309, 10946.288491248084, 10756.78486430271, 10793.352398856094, 10798.514066866932, 10798.920107989177, 10816.080633146114, 10373.481325933673, 10435.16518678504, 10453.581856725721, 10459.477026148737, 10471.79056418875, 34278.0, 34444.82777586121, 34521.964341069805, 34524.82737586321, 34544.6545534544, 3667.339878821811, 3682.797446140461, 3701.68535674468, 3706.7590606610484, 3728.440733889911, 24735.50528989428, 25091.24726258215, 25978.83095260718, 26373.604395934075, 26522.33694157642, 3004.5042567976257, 3024.123004328742, 3024.4555979923607, 3055.8319292438905, 3066.0801759472292, 349210.0, 350669.49330506625, 351304.0, 351529.0, 351576.0, 44137.89655258644, 44263.336049959275, 44295.114097717866, 44325.0, 44381.112377752266, 35016.0, 46281.0, 46333.0, 46338.76830615825, 46498.0, 12617.873821261854, 12914.612561623166, 12918.483260669467, 12942.029347798765, 12943.093983421259, 11059.94930481603, 11062.502187401586, 11071.5571377144, 11075.224734268524, 11082.445877706083, 9694.36986595869, 11751.0, 11900.0, 11999.88000120005, 12029.518819247307, 5562.72186390687, 5642.407547207484, 5646.181303710939, 5680.109125249218, 5685.607026278588, 971.6356366362614, 1111.4609414433994, 1114.8662160540625, 1120.288616728367, 1167.795635763738, 21295.8935205323, 26070.608940865903, 26332.341691457485, 26527.204183874514, 26646.333841654116, 1175.7295821960997, 1198.1493139870615, 1200.2378489658954, 1200.765850659113, 1255.253124390986, 13621.318934053257, 13682.863171368357, 13729.862701372858, 13855.376508057161, 13900.721985560232, 449075.0, 573709.0, 586312.7793386832, 587198.0, 587597.0, 41212.58787412087, 41793.0, 43586.69239922807, 49243.50756492461, 50066.499335006185, 1352.6415499892537, 1356.5658989123583, 1362.9591112266648, 1375.7386096641605, 1376.8141300924246, 27012.968930261883, 27181.86409067942, 27640.861795690893, 27674.0, 27753.44493110167, 41445.0, 45535.77232113818, 46699.06601867876, 48809.0238195227, 48868.5113148864, 403712.0, 405838.0, 406819.0, 406964.0, 407293.0, 30305.69694303029, 30368.544471833382, 30369.544456833606, 30419.39161216719, 30487.0, 36796.0, 37517.43723844199, 37976.05059873525, 38111.237775244896, 38174.236515270095, 21849.672254916506, 25682.743172568782, 30397.0, 31442.21394465065, 32783.0, 30963.845180774853, 31891.927024743316, 32005.519917201727, 32026.19934501656, 32043.519347210276, 31570.0, 32224.677753223106, 32247.516287256178, 32268.677313226566, 32346.514802278456, 27189.86405067962, 28157.577636335882, 28193.71806281993, 28466.28834279077, 29309.12072637824, 21554.568908622052, 21715.239966601093, 21751.891240543697, 22001.789901555567, 22080.2271920482], "value": 17803.840162654622, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.8349784345964, 382.41681435810386, 383.61638361638364, 394.94865667463233, 424.9893752656185, 13795.310234488286, 15859.36562537497, 20631.0, 21199.152033918643, 21896.671549926763, 18576.0, 22085.0, 22357.776422235773, 22384.77615223847, 22404.767737774415, 6325.588836725621, 6424.839379015515, 6481.870362592746, 6530.902036469457, 6615.272320044815, 6035.124906888498, 6467.644279564622, 6559.8032059038305, 6592.769253076143, 6594.835129121762, 6265.655388953605, 6858.211305699859, 7203.387712044482, 7335.669894854745, 7394.815129621748, 7074.115735533059, 7191.496595238335, 7245.8550828983125, 7246.927530724678, 7332.230115837813, 7096.822579435504, 7109.786706398816, 7113.075300210991, 7114.608696521689, 7132.215456299803, 24211.39471513226, 24675.136370226955, 25208.873955630286, 25888.74111258882, 26306.605400919, 2775.88896444142, 2838.0, 2857.328527795987, 2903.4097954122753, 2944.484715174836, 15032.098074115587, 15048.548543543711, 15054.849451505565, 15628.92185539065, 16015.51953441387, 1591.4303017065981, 1884.3498992847447, 1894.9810501894942, 1929.5465565592074, 1951.9219231230734, 145705.0, 153907.9999999989, 156778.0, 158815.0, 159678.0, 18949.905250473934, 19014.904925475283, 19144.904275478813, 19216.423507294803, 19294.0, 24705.135320263704, 30288.8797784153, 30329.090127295774, 30377.0, 30425.391492170034, 8136.75589732309, 9167.404118732262, 9233.215176710055, 9308.348415610842, 9654.517274136266, 7474.215207403253, 7855.685772569148, 7856.0, 8038.437309388287, 8043.477173983672, 7405.629718514053, 8892.3330750194, 9049.864252036225, 9062.818743625223, 9126.543672816333, 3248.480243161083, 3554.2536067425613, 3562.893113206556, 3627.891163265106, 3637.9636203637624, 996.3025881882711, 998.3959704378747, 999.8550210219478, 1015.5227043289642, 1033.266380869576, 17151.399701010403, 19348.80651193498, 20736.688949665768, 20963.580728385652, 21266.36200913975, 848.8641817309201, 941.2328951904313, 972.5234635028785, 1001.324106228293, 1018.556927736437, 10768.892311076788, 10953.671389858317, 11029.669109926715, 11095.83356249657, 11108.833367499494, 672770.0, 674136.0, 678301.0, 682260.0, 689179.4066771287, 139635.0, 140999.0, 142654.0, 144104.0, 147738.0, 1117.335185564604, 1139.1001109123865, 1164.3072371938683, 1171.707073231692, 1175.26545908807, 18177.363792267206, 18503.259869605605, 18523.81476185221, 18683.065846707883, 19162.329318473785, 61704.38295617166, 64488.03267951078, 65403.0, 65617.67191164014, 67154.0, 86299.56850215708, 87195.0, 88061.0, 88174.55912720396, 90255.0, 9385.85921211196, 9507.714768556954, 10002.649907253211, 10489.423081730272, 11427.771444571228, 12634.736526347291, 12692.301923393932, 13100.082994190316, 13143.0, 13170.07809453329, 11240.325580465198, 11250.606228781953, 11541.653750387502, 11564.94217528907, 11577.884221157681, 11000.834987475035, 11247.66257012291, 11422.971932526112, 11470.0, 11564.94217528907, 11212.27120237182, 11442.0, 11586.768264634491, 11634.709132271422, 11942.701432464259, 11180.0, 11480.0, 11535.942320288344, 11541.076713862703, 11560.01179593039, 11094.334339939629, 11161.832572511581, 11434.771304573696, 11567.0, 11607.0], "value": 11205.29008829693, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.1307293722602, 1541.529833400813, 1557.1046648177298, 1565.1391734545996, 1571.779950806887, 9041.457512549252, 9460.905390946089, 9478.336516443844, 9576.0, 9582.520873956291, 9352.672656457025, 10385.948070259637, 10723.517441715123, 10752.301100428467, 10791.62229321974, 2288.9885550572226, 2321.025169428844, 2322.3497420722224, 2324.1168356024773, 2326.220716060122, 2177.118267101818, 2301.2175860207526, 2306.5271619318, 2308.1690591387087, 2309.815214782813, 1900.353879680915, 1972.063269946771, 1972.516733400319, 1973.4868934077099, 1978.4855937456293, 1994.5911088226878, 2014.4359579317816, 2241.652543855705, 2328.7787660172257, 2335.649652552114, 2288.656701494789, 2291.5073259249175, 2291.8510296830655, 2297.7127859017623, 2299.3329835869026, 10852.565897364097, 10953.452327383678, 10985.395803230818, 11028.558857645685, 11034.558617655364, 4255.553166917491, 4888.169011268057, 5064.5441910228255, 5073.847784566469, 5548.77804887804, 3166.509191075387, 3246.4643333849885, 3406.2506248625264, 3430.3482338355634, 3592.335417947662, 1158.3860553906443, 1161.692151579832, 1206.849143857018, 1217.257472941505, 1217.4764851114016, 15042.548723538312, 15196.468123615621, 15198.772018419733, 15199.392024319013, 15232.543023709306, 4540.931886021713, 4764.785584648699, 4843.128236917389, 4852.393450818648, 4878.902421951541, 12562.120651554304, 12568.308743019039, 12605.0, 12606.306653134166, 12651.177673451197, 5880.147378630075, 5887.411258874164, 5893.027650437715, 5894.17481552583, 5900.970495147582, 4986.975065124651, 5026.447090820006, 5072.923906141411, 5078.3905931287745, 5148.794048238028, 3829.0, 3930.6265904739003, 3954.1217921487637, 4025.0138716014762, 4084.7344922580533, 1118.3234143343323, 1121.7980763462492, 1125.7185703574107, 1134.82977553366, 1136.9705076438518, 870.7605408512583, 907.7412937312835, 911.981760364789, 938.4463166731662, 946.8248374050822, 5840.707964601753, 6004.027273814724, 6047.274327080779, 6185.226846644169, 6208.751649934043, 932.5477143585356, 944.5956415502901, 971.8833739951251, 1026.984595231072, 1036.3056751976194, 2503.486785209028, 3999.460072890181, 4255.0, 4353.36876152956, 4367.2575662137515, 10334.17326613869, 12618.369081545887, 12977.870221297666, 13102.541411050568, 13141.605751827461, 13195.67010824737, 13205.73588528224, 13207.60377188686, 13208.405621747044, 13337.933310333387, 9660.420374777535, 9674.129328360481, 9797.412155270707, 9823.361481503822, 9918.404895706137, 6092.39076092405, 6645.102911106938, 6739.629320387426, 6818.249992500921, 6844.8973265402055, 10723.785524289315, 11815.17293789461, 11865.5847045353, 11957.641270761891, 12126.696832579257, 11660.41697915084, 11920.463579138786, 12030.819537707117, 12123.696907577381, 12140.93929530382, 8754.21212090915, 8795.032546420016, 8886.0, 8954.955225223832, 8974.955125224333, 9524.285678574273, 9712.611495540099, 9737.707868763948, 9739.0, 9747.463889486145, 8062.193780621891, 8093.757187284155, 8435.704750333955, 8648.481091134552, 8758.211760941545, 8517.403781735467, 8535.658573656985, 8548.829023419621, 8589.441686290622, 8671.783205419915, 7655.272749088827, 7656.846863062596, 7693.307602315818, 7696.345810606162, 7697.422693297913, 5584.190292407659, 5731.627444216113, 5786.913196302143, 5811.4479124483105, 5871.970640146943, 5061.31672224245, 5736.5984381094595, 5758.568107392046, 5887.293524777054, 6119.785807496716], "value": 4950.625546696687, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.7506058228949, 364.4424031232215, 369.833574891299, 369.97040236781044, 374.0331243734945, 4270.0, 4874.488178741234, 5094.109654731457, 5108.4636113208135, 5114.6164037697135, 4344.391785150082, 4422.722298016524, 4660.976695116519, 4906.484819093997, 4969.676970996883, 3797.0, 3982.745435187921, 4102.0, 4107.979460102695, 4126.381042843567, 4148.900541356543, 4169.83016983017, 4178.56125106864, 4184.644305234059, 4211.18918864888, 3708.128589781399, 3971.8808435746973, 4114.691398145136, 4140.660526802362, 4163.7501749894955, 3483.7038851697635, 3961.9405708914387, 4066.247744167309, 4076.084240407004, 4111.691623128278, 3395.015445520821, 3657.8542453489977, 3658.378075727106, 3813.8474461021524, 3853.171568112841, 4128.4632997710105, 4717.080169366975, 4785.401824771903, 4866.58634016109, 4869.172240719086, 4543.7728113594185, 4711.725350881139, 4742.913118228003, 4778.061492182283, 4780.450248221464, 4947.82682606107, 5002.674826136289, 5346.759395827158, 5361.115415956401, 5384.300040994684, 3730.7388482806214, 3801.3727734923705, 4135.400366946776, 4273.50854651716, 4343.609075183217, 4262.760302170342, 4617.9131468650485, 4808.711477311373, 5427.782888684448, 5498.725063746797, 4255.680823938155, 4357.433533640607, 4382.926183085165, 4409.404730361424, 4437.334399839985, 4391.6504670001395, 4477.350784136282, 4487.439070116236, 4508.5040645529625, 4516.909661806745, 3926.0, 4283.22901877665, 4420.563316922014, 4456.952616135206, 4668.649851261169, 4446.82212711488, 4655.511171326962, 4783.617310615143, 5206.505381988705, 5228.163493840967, 1427.414759948416, 1431.7257640699786, 1482.35517549864, 1496.835348111707, 1518.4837155367006, 952.7141857442739, 1081.1891081688734, 1125.791728530208, 1128.8485744540524, 1134.9659510214706, 4254.638355739735, 4401.801918913592, 4807.6394270429855, 4826.372571565744, 4880.902381952341, 5179.249008893765, 5235.947640523546, 5421.566274698014, 5432.809851655252, 5531.834044978657, 4045.7370270932297, 4430.645548356124, 4732.7055016827535, 4829.673128202066, 4913.975430122827, 2586.8447893126095, 2814.4230432761233, 2823.054276817289, 2831.688514263429, 2871.798974071795, 5064.772085256099, 5535.501804837584, 5577.860553486195, 5592.888142237132, 5696.3733989261145, 4581.885452863705, 4961.040389046379, 5494.269305168859, 5502.724863756876, 5641.717914104278, 4842.661013729005, 4971.428285747185, 5254.710990895537, 5443.265159203457, 5552.888942221133, 4467.843625473093, 4918.336024636628, 5377.247185394126, 5441.143399715181, 5486.615936884539, 4880.633952453652, 4919.458859525378, 4962.255661650781, 5077.0, 5099.974500127476, 4594.887575619869, 4858.873888048143, 4936.8777071146, 5344.78620855177, 5578.0, 3764.3788774852937, 3874.709396795195, 4239.300515414922, 4254.957535403846, 4283.95716042848, 4636.350910872548, 4896.755162241945, 4929.950700493093, 5306.708131052829, 5441.347038355423, 4460.9107817844115, 4674.439067311944, 4718.0799744050955, 5056.0, 5124.948750512447, 4321.0, 4623.69945953512, 5172.818951336685, 5191.506806853343, 5231.450697676689, 4536.9565000049515, 4631.814727410866, 4902.485239049991, 5043.36957880265, 5158.071547121404, 4321.805518751601, 4979.377577802775, 5203.661761985459, 5221.869453263699, 5258.8948221036135, 4143.02638879869, 4807.010181549236, 4975.97992411562, 5086.440491546001, 5113.846584602468], "value": 3991.1043146095762, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.6029363262936, 730.4959577891254, 750.4221749253076, 812.7358608452253, 813.4305985809933, 14365.784513232296, 15143.0, 15175.317110730017, 15176.468823591176, 15180.696386072272, 13191.868081319184, 13613.0, 13674.794878076811, 13706.0, 14137.010409271355, 874.7856775090112, 912.5209265135791, 915.5834095486538, 918.1231923513029, 918.6555041859302, 922.3681777982071, 930.6044930904372, 931.0084759730898, 933.785229397239, 935.6631612619485, 997.6059456514672, 1006.6979906028199, 1007.1489591295343, 1010.8736407949007, 1011.9392836429801, 1000.604761119361, 1003.508280942333, 1004.1264100232771, 1004.8743907011624, 1004.9346792458467, 742.0909386002158, 742.3022358982539, 742.8440027594212, 742.8662840688728, 743.3681370834802, 14760.409583616642, 15246.618834529114, 15312.770308445382, 15429.30568124437, 15455.149966751824, 13274.388914220002, 13713.725725485434, 13816.585502434944, 14113.0, 14152.221627810466, 10499.265051446402, 11210.215284930058, 11382.804805495469, 11453.198276120675, 11664.833516648352, 3258.0877354340823, 3604.2431089471243, 3667.2665466906724, 3785.280796648628, 3786.2427514496935, 107899.86688138505, 111469.0, 112086.31870521948, 114288.42855785668, 114946.0, 10509.264351495474, 10530.104941080093, 10658.307210031478, 10786.46067696612, 11137.832932506019, 21928.342149735534, 22387.0, 22412.66381004286, 22436.990335434944, 22456.43858903508, 7387.8153046174275, 7460.589667568227, 7475.439342049368, 7578.658960346797, 7658.349040331635, 4111.939444878207, 4174.478190226222, 4175.645070169009, 4210.179015092028, 4217.198732240864, 3300.85146168423, 3337.299167174872, 3391.8134502602593, 3396.711279541267, 3396.997885623747, 600.9399060093956, 605.4581149870841, 610.4810910725847, 620.3455354600849, 624.9156363890817, 603.3935894426073, 616.6207782213996, 639.4916041746823, 647.5337756815086, 674.8346655069539, 8488.872666910001, 8597.484150950962, 9818.165455936325, 9837.409755414697, 10030.297879148535, 607.419913982146, 631.5452873930763, 665.0722242471821, 682.6552590941543, 701.9227884932756, 4540.296254080623, 4719.10337035962, 4723.7874295656775, 4778.856634300976, 4791.856244312677, 75240.0, 89513.0, 91049.0, 91730.0, 94058.5297073524, 73140.90288645675, 73361.53276934431, 77983.0, 78826.21173788303, 79875.20124798793, 66537.66731166506, 68051.27794888247, 68425.0, 68959.27601809894, 69835.65082174659, 10097.141742951637, 10655.413952232702, 10660.680179594625, 10809.459527023775, 10885.836712449161, 36414.63585364113, 46631.53368466272, 46688.0, 48652.5134748648, 49410.0, 53708.73145634403, 59616.0, 61577.38422615896, 61790.0, 62254.0, 10092.0, 11800.409979501163, 11807.763844722886, 11941.46263418131, 12079.698007549881, 11834.940825295818, 13732.244726540137, 13751.703420767088, 13919.860801391857, 14088.22514761657, 10626.0, 12469.161030507441, 12933.870661293267, 13075.992521719867, 13146.079774415699, 12950.287734174712, 13015.869841301466, 13055.733248040804, 13157.868421316047, 13250.867491324963, 10366.792664146826, 12830.422630981815, 12859.292738899076, 12940.676483087622, 13198.406071726604, 10599.674084787523, 10621.309614875317, 10621.313428965905, 10772.622958196738, 10784.19118566095, 8044.477108987897, 9831.508424578886, 10286.845697314697, 10482.21383396233, 10500.159987200852], "value": 7301.987713097008, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1449.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 115.0, 116.0, 115.0, 115.0, 116.0, 115.0, 116.0, 116.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 112.0, 109.0, 152.0, 110.0, 112.0, 112.0, 111.0, 130.0, 110.0], "value": 120.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 188.0, 186.0, 188.0, 181.0, 185.0, 185.0, 185.0, 183.0, 185.0], "value": 185.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 63.0, 91.0, 62.0, 61.0, 58.0, 60.0, 79.0, 59.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 73.0, 113.0, 97.0, 96.0, 76.0, 85.0, 69.0, 69.0, 83.0], "value": 85.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 89.0, 88.0, 88.0, 88.0, 92.0, 89.0, 88.0, 88.0], "value": 88.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 98.0, 97.0, 96.0, 96.0, 97.0, 96.0, 111.0, 144.0], "value": 102.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 87.0, 86.0, 85.0, 81.0, 85.0, 85.0, 87.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 59.0, 60.0, 61.0, 61.0, 62.0, 63.0, 61.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 69.0, 67.0, 64.0, 63.0, 59.0, 59.0, 59.0, 58.0, 58.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 90.0, 89.0, 96.0, 98.0, 99.0, 98.0, 90.0, 91.0], "value": 92.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 144.0, 151.0, 142.0, 139.0, 140.0, 142.0, 142.0, 192.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 170.0, 167.0, 169.0, 172.0, 172.0, 176.0, 168.0, 167.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 67.0, 67.0], "value": 66.4, "unit": "score"}]}]} 04:03:57 INFO - Return code: 0 04:03:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:03:57 ERROR - # TBPL SUCCESS # 04:03:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:03:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:03:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:03:57 INFO - 2017-03-06 04:03:57.734 screenresolution[1653:10170] starting screenresolution argv=screenresolution get 04:03:57 INFO - 2017-03-06 04:03:57.737 screenresolution[1653:10170] Display 0: 1600x1200x32@60 04:03:57 INFO - 2017-03-06 04:03:57.744 screenresolution[1654:10173] starting screenresolution argv=screenresolution list 04:03:57 INFO - Available Modes on Display 0 04:03:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:03:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:03:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:03:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:03:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:03:57 INFO - Intel Iris: 04:03:57 INFO - Chipset Model: Intel Iris 04:03:57 INFO - Type: GPU 04:03:57 INFO - Bus: Built-In 04:03:57 INFO - VRAM (Dynamic, Max): 1536 MB 04:03:57 INFO - Vendor: Intel (0x8086) 04:03:57 INFO - Device ID: 0x0a2e 04:03:57 INFO - Revision ID: 0x0009 04:03:57 INFO - Displays: 04:03:57 INFO - Display: 04:03:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:03:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:03:57 INFO - Display Serial Number: 1600x1200 60 04:03:57 INFO - Main Display: Yes 04:03:57 INFO - Mirror: Off 04:03:57 INFO - Online: Yes 04:03:57 INFO - Rotation: Supported 04:03:57 INFO - Return code: 0 04:03:57 INFO - Running post-action listener: _resource_record_post_action 04:03:57 INFO - [mozharness: 2017-03-06 12:03:57.995010Z] Finished run-tests step (success) 04:03:57 INFO - Running post-run listener: _resource_record_post_run 04:03:58 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 43095040; Write bytes: 508527616; Read time: 457; Write time: 1563 04:03:58 INFO - TinderboxPrint: CPU usage
53.9% 04:03:58 INFO - TinderboxPrint: I/O read bytes / time
43,095,040 / 457 04:03:58 INFO - TinderboxPrint: I/O write bytes / time
508,527,616 / 1,563 04:03:58 INFO - TinderboxPrint: CPU idle
2,217.7 (46.1%) 04:03:58 INFO - TinderboxPrint: CPU system
955.7 (19.9%) 04:03:58 INFO - TinderboxPrint: CPU user
1,640.3 (34.1%) 04:03:58 INFO - TinderboxPrint: Swap in / out
248,479,744 / 0 04:03:58 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203811328; Write bytes: 204048384; Read time: 15563; Write time: 428 04:03:58 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 41165824; Write bytes: 293714944; Read time: 435; Write time: 1101 04:03:58 INFO - Running post-run listener: _upload_blobber_files 04:03:58 INFO - Blob upload gear active. 04:03:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:03:58 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 04:03:58 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'] 04:03:58 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 04:03:58 INFO - (blobuploader) - INFO - Open directory for files ... 04:03:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:03:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:03:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:03:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:03:59 INFO - (blobuploader) - INFO - Done attempting. 04:03:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:03:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:03:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:04:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:00 INFO - (blobuploader) - INFO - Done attempting. 04:04:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:04:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:04:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:02 INFO - (blobuploader) - INFO - Done attempting. 04:04:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:04:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:04:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:04:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:04:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:04:04 INFO - (blobuploader) - INFO - Done attempting. 04:04:04 INFO - (blobuploader) - INFO - Iteration through files over. 04:04:04 INFO - Return code: 0 04:04:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:04:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:04:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9e53c0953721e8b4a25ecc43475a9fcf7de0b87f924dba5bb3247f4e12b9d9d6e424f57b67f211a16063a1c7811f6cdbc81c922b6ff0ec00bf3cd14bf630bf8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c77d3d77132839c4f462e791554aec4f5874dece10b63f195d85dd093bb181650f82ebb9ec24389339a43459a1d6622e231a4cb3d54e9a3bbf4c590ac622de10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a4bb66511840a3543baf09c80486a17ee6000981aae706d4da39b7caff0de519a3856df7e62fac8da7245e2b3953fd4b9a97f9f271aa4cb07e31d945d45ce68", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2eea2edacf5e828953321b330fbf191c4b72d216bb704a1bc229557e7c8bf329b51a529ac1186f5cc26c64b2785e58f52679ac5b553411ef4339af88da974252"} 04:04:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:04:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:04:04 INFO - Contents: 04:04:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9e53c0953721e8b4a25ecc43475a9fcf7de0b87f924dba5bb3247f4e12b9d9d6e424f57b67f211a16063a1c7811f6cdbc81c922b6ff0ec00bf3cd14bf630bf8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c77d3d77132839c4f462e791554aec4f5874dece10b63f195d85dd093bb181650f82ebb9ec24389339a43459a1d6622e231a4cb3d54e9a3bbf4c590ac622de10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a4bb66511840a3543baf09c80486a17ee6000981aae706d4da39b7caff0de519a3856df7e62fac8da7245e2b3953fd4b9a97f9f271aa4cb07e31d945d45ce68", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2eea2edacf5e828953321b330fbf191c4b72d216bb704a1bc229557e7c8bf329b51a529ac1186f5cc26c64b2785e58f52679ac5b553411ef4339af88da974252"} 04:04:04 INFO - Running post-run listener: copy_logs_to_upload_dir 04:04:04 INFO - Copying logs to upload dir... 04:04:04 INFO - mkdir: /builds/slave/test/build/upload/logs 04:04:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.252581 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-06 04:04:04.436235) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-06 04:04:04.440220) ========= 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.Z3QUTiEljk/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.GJRWnROGi0/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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/b9e53c0953721e8b4a25ecc43475a9fcf7de0b87f924dba5bb3247f4e12b9d9d6e424f57b67f211a16063a1c7811f6cdbc81c922b6ff0ec00bf3cd14bf630bf8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c77d3d77132839c4f462e791554aec4f5874dece10b63f195d85dd093bb181650f82ebb9ec24389339a43459a1d6622e231a4cb3d54e9a3bbf4c590ac622de10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a4bb66511840a3543baf09c80486a17ee6000981aae706d4da39b7caff0de519a3856df7e62fac8da7245e2b3953fd4b9a97f9f271aa4cb07e31d945d45ce68", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2eea2edacf5e828953321b330fbf191c4b72d216bb704a1bc229557e7c8bf329b51a529ac1186f5cc26c64b2785e58f52679ac5b553411ef4339af88da974252"} build_url:https://queue.taskcluster.net/v1/task/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011114 build_url: 'https://queue.taskcluster.net/v1/task/Dy7FcvsFRHKN3PWmRM_--A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9e53c0953721e8b4a25ecc43475a9fcf7de0b87f924dba5bb3247f4e12b9d9d6e424f57b67f211a16063a1c7811f6cdbc81c922b6ff0ec00bf3cd14bf630bf8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c77d3d77132839c4f462e791554aec4f5874dece10b63f195d85dd093bb181650f82ebb9ec24389339a43459a1d6622e231a4cb3d54e9a3bbf4c590ac622de10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a4bb66511840a3543baf09c80486a17ee6000981aae706d4da39b7caff0de519a3856df7e62fac8da7245e2b3953fd4b9a97f9f271aa4cb07e31d945d45ce68", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2eea2edacf5e828953321b330fbf191c4b72d216bb704a1bc229557e7c8bf329b51a529ac1186f5cc26c64b2785e58f52679ac5b553411ef4339af88da974252"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-06 04:04:04.475509) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 04:04:04.475875) ========= 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.Z3QUTiEljk/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.GJRWnROGi0/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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.005160 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-06 04:04:04.524582) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-06 04:04:04.524949) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-06 04:04:04.525294) ========= ========= Total master_lag: 0.18 =========