builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0064 starttime: 1475246120.9 results: success (0) buildid: 20160930013320 builduid: aa5c9bca12eb4c9481f5747ff57287d7 revision: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:20.896499) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:20.896953) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:20.897247) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:21.208694) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:21.208985) ========= 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.eO1tUUr6Pl/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.pCtf15JojL/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 --2016-09-30 07:35:21-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-09-30 07:35:21 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.594115 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:21.842669) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:21.842949) ========= 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.eO1tUUr6Pl/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.pCtf15JojL/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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.029919 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:21.892017) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 07:35:21.892338) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eO1tUUr6Pl/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.pCtf15JojL/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 2016-09-30 07:35:21,965 truncating revision to first 12 chars 2016-09-30 07:35:21,965 Setting DEBUG logging. 2016-09-30 07:35:21,965 attempt 1/10 2016-09-30 07:35:21,965 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/805d5fc3d66c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 07:35:23,060 unpacking tar archive at: mozilla-aurora-805d5fc3d66c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.371382 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 07:35:23.286098) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:23.289453) ========= script_repo_revision: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:23.289855) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:23.290141) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:23.310416) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-30 07:35:23.310684) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eO1tUUr6Pl/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.pCtf15JojL/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 07:35:23 INFO - MultiFileLogger online at 20160930 07:35:23 in /builds/slave/test 07:35:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:35:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:35:23 INFO - {'append_to_log': False, 07:35:23 INFO - 'base_work_dir': '/builds/slave/test', 07:35:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:35:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:35:23 INFO - 'branch': 'Mozilla-Aurora', 07:35:23 INFO - 'buildbot_json_path': 'buildprops.json', 07:35:23 INFO - 'config_files': ('talos/mac_config.py',), 07:35:23 INFO - 'default_actions': ('clobber', 07:35:23 INFO - 'read-buildbot-config', 07:35:23 INFO - 'download-and-extract', 07:35:23 INFO - 'populate-webroot', 07:35:23 INFO - 'create-virtualenv', 07:35:23 INFO - 'install', 07:35:23 INFO - 'run-tests'), 07:35:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:35:23 INFO - 'download_minidump_stackwalk': True, 07:35:23 INFO - 'download_symbols': 'ondemand', 07:35:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:35:23 INFO - 'tooltool.py': '/tools/tooltool.py', 07:35:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:35:23 INFO - '/tools/misc-python/virtualenv.py')}, 07:35:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:35:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:35:23 INFO - 'installer_path': 'installer.exe', 07:35:23 INFO - 'log_level': 'info', 07:35:23 INFO - 'log_name': 'talos', 07:35:23 INFO - 'log_to_console': True, 07:35:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:35:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:35:23 INFO - 'opt_config_files': (), 07:35:23 INFO - 'pip_index': False, 07:35:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:35:23 INFO - 'cmd': ('bash', 07:35:23 INFO - '-c', 07:35:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:35:23 INFO - 'enabled': True, 07:35:23 INFO - 'halt_on_failure': False, 07:35:23 INFO - 'name': 'check_screen_resolution'},), 07:35:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:35:23 INFO - 'cmd': ('bash', 07:35:23 INFO - '-c', 07:35:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:35:23 INFO - 'enabled': True, 07:35:23 INFO - 'halt_on_failure': False, 07:35:23 INFO - 'name': 'check_screen_resolution'},), 07:35:23 INFO - 'run_cmd_checks_enabled': True, 07:35:23 INFO - 'sps_profile': False, 07:35:23 INFO - 'sps_profile_interval': 0, 07:35:23 INFO - 'suite': 'dromaeojs', 07:35:23 INFO - 'system_bits': '32', 07:35:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:35:23 INFO - 'title': 't-yosemite-r7-0064', 07:35:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:35:23 INFO - 'use_talos_json': True, 07:35:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:35:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:35:23 INFO - 'work_dir': 'build'} 07:35:23 INFO - [mozharness: 2016-09-30 14:35:23.510172Z] Running clobber step. 07:35:23 INFO - Running pre-action listener: _resource_record_pre_action 07:35:23 INFO - Running main action method: clobber 07:35:23 INFO - rmtree: /builds/slave/test/build 07:35:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:35:25 INFO - Running post-action listener: _resource_record_post_action 07:35:25 INFO - [mozharness: 2016-09-30 14:35:25.570903Z] Finished clobber step (success) 07:35:25 INFO - [mozharness: 2016-09-30 14:35:25.571079Z] Running read-buildbot-config step. 07:35:25 INFO - Running pre-action listener: _resource_record_pre_action 07:35:25 INFO - Running main action method: read_buildbot_config 07:35:25 INFO - Using buildbot properties: 07:35:25 INFO - { 07:35:25 INFO - "project": "", 07:35:25 INFO - "product": "firefox", 07:35:25 INFO - "script_repo_revision": "production", 07:35:25 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:35:25 INFO - "repository": "", 07:35:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:35:25 INFO - "buildid": "20160930013320", 07:35:25 INFO - "pgo_build": "False", 07:35:25 INFO - "basedir": "/builds/slave/test", 07:35:25 INFO - "buildnumber": 59, 07:35:25 INFO - "slavename": "t-yosemite-r7-0064", 07:35:25 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:35:25 INFO - "platform": "yosemite_r7", 07:35:25 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:35:25 INFO - "branch": "mozilla-aurora", 07:35:25 INFO - "repo_path": "releases/mozilla-aurora", 07:35:25 INFO - "revision": "805d5fc3d66c4fa585a3de407b1e0b055f78eb58", 07:35:25 INFO - "stage_platform": "macosx64", 07:35:25 INFO - "builduid": "aa5c9bca12eb4c9481f5747ff57287d7", 07:35:25 INFO - "slavebuilddir": "test" 07:35:25 INFO - } 07:35:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 07:35:25 INFO - Running post-action listener: _resource_record_post_action 07:35:25 INFO - [mozharness: 2016-09-30 14:35:25.574349Z] Finished read-buildbot-config step (success) 07:35:25 INFO - [mozharness: 2016-09-30 14:35:25.574480Z] Running download-and-extract step. 07:35:25 INFO - Running pre-action listener: _resource_record_pre_action 07:35:25 INFO - Running main action method: download_and_extract 07:35:25 INFO - mkdir: /builds/slave/test/build/tests 07:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:25 INFO - trying https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 07:35:25 INFO - Downloading https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:35:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 07:35:26 INFO - Downloaded 1199 bytes. 07:35:26 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:35:26 INFO - Using the following test package requirements: 07:35:26 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:35:26 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 07:35:26 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 07:35:26 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'jsshell-mac.zip'], 07:35:26 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 07:35:26 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:35:26 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 07:35:26 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 07:35:26 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 07:35:26 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 07:35:26 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:35:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:35:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:35:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:35:27 INFO - Expected file size: 16433807 07:35:34 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:35:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:35:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:35:34 INFO - Fetch https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:35:35 INFO - Expected file size: 16433807 07:35:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 07:35:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:35:41 INFO - Fetch https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 07:35:42 INFO - Expected file size: 14414059 07:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:42 INFO - trying https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:35:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 07:35:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 07:35:45 INFO - Downloaded 115275136 bytes. 07:35:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:35:45 INFO - mkdir: /builds/slave/test/properties 07:35:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:35:45 INFO - Writing to file /builds/slave/test/properties/build_url 07:35:45 INFO - Contents: 07:35:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:35:46 INFO - Running post-action listener: _resource_record_post_action 07:35:46 INFO - Running post-action listener: set_extra_try_arguments 07:35:46 INFO - [mozharness: 2016-09-30 14:35:46.386530Z] Finished download-and-extract step (success) 07:35:46 INFO - [mozharness: 2016-09-30 14:35:46.386638Z] Running populate-webroot step. 07:35:46 INFO - Running pre-action listener: _resource_record_pre_action 07:35:46 INFO - Running main action method: populate_webroot 07:35:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:35:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:35:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:35:46 INFO - '--tppagecycles', 07:35:46 INFO - '7'], 07:35:46 INFO - 'tests': ['tsvgm']}}, 07:35:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:35:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:35:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:35:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:35:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['damp', 'tps']}, 07:35:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'tests': ['damp', 'tps']}, 07:35:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['dromaeo_dom']}, 07:35:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:35:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['basic_compositor_video']}, 07:35:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:35:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['a11yr', 07:35:46 INFO - 'ts_paint', 07:35:46 INFO - 'tpaint', 07:35:46 INFO - 'sessionrestore', 07:35:46 INFO - 'sessionrestore_no_auto_restore', 07:35:46 INFO - 'tabpaint']}, 07:35:46 INFO - 'other-e10s': {'tests': ['a11yr', 07:35:46 INFO - 'ts_paint', 07:35:46 INFO - 'tpaint', 07:35:46 INFO - 'sessionrestore', 07:35:46 INFO - 'sessionrestore_no_auto_restore', 07:35:46 INFO - 'tabpaint']}, 07:35:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:35:46 INFO - 'ts_paint', 07:35:46 INFO - 'tpaint', 07:35:46 INFO - 'sessionrestore', 07:35:46 INFO - 'sessionrestore_no_auto_restore', 07:35:46 INFO - 'tabpaint']}, 07:35:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:35:46 INFO - 'ts_paint', 07:35:46 INFO - 'tpaint', 07:35:46 INFO - 'sessionrestore', 07:35:46 INFO - 'sessionrestore_no_auto_restore', 07:35:46 INFO - 'tabpaint']}, 07:35:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['a11yr', 07:35:46 INFO - 'ts_paint', 07:35:46 INFO - 'tpaint', 07:35:46 INFO - 'sessionrestore', 07:35:46 INFO - 'sessionrestore_no_auto_restore', 07:35:46 INFO - 'tabpaint']}, 07:35:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['a11yr', 07:35:46 INFO - 'ts_paint', 07:35:46 INFO - 'tpaint', 07:35:46 INFO - 'sessionrestore', 07:35:46 INFO - 'sessionrestore_no_auto_restore', 07:35:46 INFO - 'tabpaint']}, 07:35:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['tsvgx', 07:35:46 INFO - 'tsvgr_opacity', 07:35:46 INFO - 'tart', 07:35:46 INFO - 'tscrollx', 07:35:46 INFO - 'cart']}, 07:35:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:35:46 INFO - 'tsvgr_opacity', 07:35:46 INFO - 'tart', 07:35:46 INFO - 'tscrollx', 07:35:46 INFO - 'cart']}, 07:35:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'talos_options': ['--disable-e10s'], 07:35:46 INFO - 'tests': ['tp5o']}, 07:35:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'tests': ['tp5o']}, 07:35:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'talos_options': ['--disable-e10s', 07:35:46 INFO - '--xperf_path', 07:35:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:46 INFO - 'tests': ['tp5n']}, 07:35:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:46 INFO - 'talos_options': ['--xperf_path', 07:35:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:46 INFO - 'tests': ['tp5n']}}, 07:35:46 INFO - 'talos.zip': {'path': '', 07:35:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:35:46 INFO - Running post-action listener: _resource_record_post_action 07:35:46 INFO - [mozharness: 2016-09-30 14:35:46.405567Z] Finished populate-webroot step (success) 07:35:46 INFO - [mozharness: 2016-09-30 14:35:46.405707Z] Running create-virtualenv step. 07:35:46 INFO - Running pre-action listener: _resource_record_pre_action 07:35:46 INFO - Running main action method: create_virtualenv 07:35:46 INFO - Creating virtualenv /builds/slave/test/build/venv 07:35:46 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 07:35:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:35:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:35:46 INFO - Using real prefix '/tools/python27' 07:35:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:35:47 INFO - Installing distribute.............................................................................................................................................................................................done. 07:35:50 INFO - Installing pip.................done. 07:35:50 INFO - Return code: 0 07:35:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:50 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 0x10ddf8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff93b56af70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc0cd30>, '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 0x10da72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc04b20>, '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.eO1tUUr6Pl/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.pCtf15JojL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 07:35:50 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 07:35:50 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 07:35:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eO1tUUr6Pl/Render', 07:35:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:50 INFO - 'HOME': '/Users/cltbld', 07:35:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:50 INFO - 'LOGNAME': 'cltbld', 07:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:50 INFO - 'MOZ_NO_REMOTE': '1', 07:35:50 INFO - 'NO_EM_RESTART': '1', 07:35:50 INFO - 'PAGER': '/bin/cat', 07:35:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:50 INFO - 'PWD': '/builds/slave/test', 07:35:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:50 INFO - 'SHELL': '/bin/bash', 07:35:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pCtf15JojL/Listeners', 07:35:50 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 07:35:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:50 INFO - 'USER': 'cltbld', 07:35:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:50 INFO - 'XPC_FLAGS': '0x0', 07:35:50 INFO - 'XPC_SERVICE_NAME': '0', 07:35:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:50 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 07:35:50 INFO - Cleaning up... 07:35:50 INFO - Return code: 0 07:35:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:50 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 0x10ddf8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff93b56af70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc0cd30>, '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 0x10da72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc04b20>, '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.eO1tUUr6Pl/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.pCtf15JojL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 07:35:50 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 07:35:50 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 07:35:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eO1tUUr6Pl/Render', 07:35:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:50 INFO - 'HOME': '/Users/cltbld', 07:35:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:50 INFO - 'LOGNAME': 'cltbld', 07:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:50 INFO - 'MOZ_NO_REMOTE': '1', 07:35:50 INFO - 'NO_EM_RESTART': '1', 07:35:50 INFO - 'PAGER': '/bin/cat', 07:35:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:50 INFO - 'PWD': '/builds/slave/test', 07:35:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:50 INFO - 'SHELL': '/bin/bash', 07:35:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pCtf15JojL/Listeners', 07:35:50 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 07:35:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:50 INFO - 'USER': 'cltbld', 07:35:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:50 INFO - 'XPC_FLAGS': '0x0', 07:35:50 INFO - 'XPC_SERVICE_NAME': '0', 07:35:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:50 INFO - Downloading/unpacking psutil>=3.1.1 07:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:35:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:54 INFO - Installing collected packages: psutil 07:35:54 INFO - Running setup.py install for psutil 07:35:54 INFO - building 'psutil._psutil_osx' extension 07:35:54 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 07:35:54 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 07:35:54 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 07:35:55 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 07:35:55 INFO - building 'psutil._psutil_posix' extension 07:35:55 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 07:35:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:35:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:35:55 INFO - ^ 07:35:55 INFO - 1 warning generated. 07:35:55 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 07:35:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:55 INFO - Successfully installed psutil 07:35:55 INFO - Cleaning up... 07:35:55 INFO - Return code: 0 07:35:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:55 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 0x10ddf8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff93b56af70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc0cd30>, '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 0x10da72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc04b20>, '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.eO1tUUr6Pl/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.pCtf15JojL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 07:35:55 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 07:35:55 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 07:35:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eO1tUUr6Pl/Render', 07:35:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:55 INFO - 'HOME': '/Users/cltbld', 07:35:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:55 INFO - 'LOGNAME': 'cltbld', 07:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:55 INFO - 'MOZ_NO_REMOTE': '1', 07:35:55 INFO - 'NO_EM_RESTART': '1', 07:35:55 INFO - 'PAGER': '/bin/cat', 07:35:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:55 INFO - 'PWD': '/builds/slave/test', 07:35:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:55 INFO - 'SHELL': '/bin/bash', 07:35:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pCtf15JojL/Listeners', 07:35:55 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 07:35:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:55 INFO - 'USER': 'cltbld', 07:35:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:55 INFO - 'XPC_FLAGS': '0x0', 07:35:55 INFO - 'XPC_SERVICE_NAME': '0', 07:35:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:35:55 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 07:35:55 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 07:35:55 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 07:35:55 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 07:35:55 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 07:35:55 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 07:35:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:35:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:35:58 INFO - Installing collected packages: mozsystemmonitor 07:35:58 INFO - Running setup.py install for mozsystemmonitor 07:35:58 INFO - Successfully installed mozsystemmonitor 07:35:58 INFO - Cleaning up... 07:35:58 INFO - Return code: 0 07:35:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:35:58 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')]} 07:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:58 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')]} 07:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:58 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 0x10ddf8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff93b56af70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc0cd30>, '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 0x10da72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc04b20>, '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.eO1tUUr6Pl/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.pCtf15JojL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 07:35:58 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 07:35:58 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 07:35:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eO1tUUr6Pl/Render', 07:35:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:58 INFO - 'HOME': '/Users/cltbld', 07:35:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:58 INFO - 'LOGNAME': 'cltbld', 07:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:58 INFO - 'MOZ_NO_REMOTE': '1', 07:35:58 INFO - 'NO_EM_RESTART': '1', 07:35:58 INFO - 'PAGER': '/bin/cat', 07:35:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:58 INFO - 'PWD': '/builds/slave/test', 07:35:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:58 INFO - 'SHELL': '/bin/bash', 07:35:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pCtf15JojL/Listeners', 07:35:58 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 07:35:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:58 INFO - 'USER': 'cltbld', 07:35:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:58 INFO - 'XPC_FLAGS': '0x0', 07:35:58 INFO - 'XPC_SERVICE_NAME': '0', 07:35:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:58 INFO - Downloading/unpacking jsonschema==2.5.1 07:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:36:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:36:01 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 07:36:01 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 07:36:01 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 07:36:01 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 07:36:01 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 07:36:01 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 07:36:01 INFO - Downloading functools32-3.2.3-2.tar.gz 07:36:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:36:01 INFO - warning: no files found matching '*.txt' 07:36:01 INFO - no previously-included directories found matching 'build' 07:36:01 INFO - no previously-included directories found matching 'dist' 07:36:01 INFO - no previously-included directories found matching '.git*' 07:36:01 INFO - Installing collected packages: jsonschema, functools32 07:36:01 INFO - Running setup.py install for functools32 07:36:01 INFO - warning: no files found matching '*.txt' 07:36:01 INFO - no previously-included directories found matching 'build' 07:36:01 INFO - no previously-included directories found matching 'dist' 07:36:01 INFO - no previously-included directories found matching '.git*' 07:36:01 INFO - Successfully installed jsonschema functools32 07:36:01 INFO - Cleaning up... 07:36:02 INFO - Return code: 0 07:36:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ddf8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff93b56af70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc0cd30>, '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 0x10da72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc04b20>, '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.eO1tUUr6Pl/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.pCtf15JojL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 07:36:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:36:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eO1tUUr6Pl/Render', 07:36:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:02 INFO - 'HOME': '/Users/cltbld', 07:36:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:02 INFO - 'LOGNAME': 'cltbld', 07:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:02 INFO - 'MOZ_NO_REMOTE': '1', 07:36:02 INFO - 'NO_EM_RESTART': '1', 07:36:02 INFO - 'PAGER': '/bin/cat', 07:36:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:02 INFO - 'PWD': '/builds/slave/test', 07:36:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:02 INFO - 'SHELL': '/bin/bash', 07:36:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pCtf15JojL/Listeners', 07:36:02 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 07:36:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:02 INFO - 'USER': 'cltbld', 07:36:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:02 INFO - 'XPC_FLAGS': '0x0', 07:36:02 INFO - 'XPC_SERVICE_NAME': '0', 07:36:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:36:02 INFO - Cleaning up... 07:36:02 INFO - Return code: 0 07:36:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ddf8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff93b56af70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc0cd30>, '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 0x10da72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc04b20>, '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.eO1tUUr6Pl/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.pCtf15JojL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 07:36:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:36:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eO1tUUr6Pl/Render', 07:36:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:02 INFO - 'HOME': '/Users/cltbld', 07:36:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:02 INFO - 'LOGNAME': 'cltbld', 07:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:02 INFO - 'MOZ_NO_REMOTE': '1', 07:36:02 INFO - 'NO_EM_RESTART': '1', 07:36:02 INFO - 'PAGER': '/bin/cat', 07:36:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:02 INFO - 'PWD': '/builds/slave/test', 07:36:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:02 INFO - 'SHELL': '/bin/bash', 07:36:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pCtf15JojL/Listeners', 07:36:02 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 07:36:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:02 INFO - 'USER': 'cltbld', 07:36:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:02 INFO - 'XPC_FLAGS': '0x0', 07:36:02 INFO - 'XPC_SERVICE_NAME': '0', 07:36:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:02 INFO - Downloading/unpacking blobuploader==1.2.4 07:36:02 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 07:36:02 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 07:36:02 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 07:36:02 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 07:36:02 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 07:36:02 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 07:36:04 INFO - Downloading blobuploader-1.2.4.tar.gz 07:36:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:36:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:36:05 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 07:36:05 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 07:36:05 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 07:36:05 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 07:36:05 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 07:36:05 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 07:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:36:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:36:05 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 07:36:05 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 07:36:05 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 07:36:05 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 07:36:05 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 07:36:05 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 07:36:06 INFO - Downloading docopt-0.6.1.tar.gz 07:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:36:06 INFO - Installing collected packages: blobuploader, requests, docopt 07:36:06 INFO - Running setup.py install for blobuploader 07:36:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:36:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:36:06 INFO - Running setup.py install for requests 07:36:06 INFO - Running setup.py install for docopt 07:36:07 INFO - Successfully installed blobuploader requests docopt 07:36:07 INFO - Cleaning up... 07:36:07 INFO - Return code: 0 07:36:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:07 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')]} 07:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:07 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')]} 07:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:07 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 0x10ddf8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff93b56af70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc0cd30>, '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 0x10da72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc04b20>, '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.eO1tUUr6Pl/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.pCtf15JojL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 07:36:07 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 07:36:07 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 07:36:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eO1tUUr6Pl/Render', 07:36:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:07 INFO - 'HOME': '/Users/cltbld', 07:36:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:07 INFO - 'LOGNAME': 'cltbld', 07:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:07 INFO - 'MOZ_NO_REMOTE': '1', 07:36:07 INFO - 'NO_EM_RESTART': '1', 07:36:07 INFO - 'PAGER': '/bin/cat', 07:36:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:07 INFO - 'PWD': '/builds/slave/test', 07:36:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:07 INFO - 'SHELL': '/bin/bash', 07:36:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pCtf15JojL/Listeners', 07:36:07 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 07:36:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:07 INFO - 'USER': 'cltbld', 07:36:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:07 INFO - 'XPC_FLAGS': '0x0', 07:36:07 INFO - 'XPC_SERVICE_NAME': '0', 07:36:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:07 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-IEPoh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:07 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-89nota-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:07 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-60hemm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:07 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-7BQM20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:07 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-A_cgzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:07 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-mpizGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:08 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-x4HH_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:08 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-owxQlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:08 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-fl2e2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:08 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-A4fesi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:08 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-D2naEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:08 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-wzEOG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:08 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-DBtBWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:08 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-9lIajX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:08 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-vkxvG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:08 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-GDuycp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:09 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-nXVBea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:36:09 INFO - Running setup.py install for manifestparser 07:36:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:36:09 INFO - Running setup.py install for mozcrash 07:36:09 INFO - Running setup.py install for mozdebug 07:36:09 INFO - Running setup.py install for mozdevice 07:36:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:36:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:36:09 INFO - Running setup.py install for mozfile 07:36:09 INFO - Running setup.py install for mozhttpd 07:36:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:36:10 INFO - Running setup.py install for mozinfo 07:36:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:36:10 INFO - Running setup.py install for mozInstall 07:36:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:36:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:36:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:36:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:36:10 INFO - Running setup.py install for mozleak 07:36:10 INFO - Running setup.py install for mozlog 07:36:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:36:10 INFO - Running setup.py install for moznetwork 07:36:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:36:10 INFO - Running setup.py install for mozprocess 07:36:10 INFO - Running setup.py install for mozprofile 07:36:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for mozrunner 07:36:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for mozscreenshot 07:36:11 INFO - Running setup.py install for moztest 07:36:11 INFO - Running setup.py install for mozversion 07:36:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:36:11 INFO - Cleaning up... 07:36:11 INFO - Return code: 0 07:36:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:11 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')]} 07:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:11 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')]} 07:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:11 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 0x10ddf8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff93b56af70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc0cd30>, '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 0x10da72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc04b20>, '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.eO1tUUr6Pl/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.pCtf15JojL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 07:36:11 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 07:36:11 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 07:36:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eO1tUUr6Pl/Render', 07:36:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:11 INFO - 'HOME': '/Users/cltbld', 07:36:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:11 INFO - 'LOGNAME': 'cltbld', 07:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:11 INFO - 'MOZ_NO_REMOTE': '1', 07:36:11 INFO - 'NO_EM_RESTART': '1', 07:36:11 INFO - 'PAGER': '/bin/cat', 07:36:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:11 INFO - 'PWD': '/builds/slave/test', 07:36:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:11 INFO - 'SHELL': '/bin/bash', 07:36:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pCtf15JojL/Listeners', 07:36:11 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 07:36:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:11 INFO - 'USER': 'cltbld', 07:36:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:11 INFO - 'XPC_FLAGS': '0x0', 07:36:11 INFO - 'XPC_SERVICE_NAME': '0', 07:36:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:12 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-4QxDsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:12 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)) 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:12 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-88s8gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:12 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-KvwVBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:12 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)) 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:12 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-NT7c2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:12 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-4qhSJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:12 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)) 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:12 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-G2zSfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:12 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)) 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:12 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-crq1_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:12 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)) 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:12 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-klj8n1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:12 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)) 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:12 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-zPdBsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:13 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:13 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-AvWSwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:13 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:13 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-XDEyyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:13 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:13 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-Axjtks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:13 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-nIlsJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:13 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:13 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-vuIh3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:13 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-6yX9xR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:13 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:13 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-ffWSyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:13 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-ujS0bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:13 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)) 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:36:13 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)) 07:36:13 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:36:13 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:36:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:16 INFO - Downloading blessings-1.6.tar.gz 07:36:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:36:16 INFO - Installing collected packages: blessings 07:36:16 INFO - Running setup.py install for blessings 07:36:16 INFO - Successfully installed blessings 07:36:16 INFO - Cleaning up... 07:36:16 INFO - Return code: 0 07:36:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:36:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:17 INFO - Reading from file tmpfile_stdout 07:36:17 INFO - Current package versions: 07:36:17 INFO - blessings == 1.6 07:36:17 INFO - blobuploader == 1.2.4 07:36:17 INFO - docopt == 0.6.1 07:36:17 INFO - functools32 == 3.2.3-2 07:36:17 INFO - jsonschema == 2.5.1 07:36:17 INFO - manifestparser == 1.1 07:36:17 INFO - mozInstall == 1.12 07:36:17 INFO - mozcrash == 0.17 07:36:17 INFO - mozdebug == 0.1 07:36:17 INFO - mozdevice == 0.48 07:36:17 INFO - mozfile == 1.2 07:36:17 INFO - mozhttpd == 0.7 07:36:17 INFO - mozinfo == 0.9 07:36:17 INFO - mozleak == 0.1 07:36:17 INFO - mozlog == 3.4 07:36:17 INFO - moznetwork == 0.27 07:36:17 INFO - mozprocess == 0.23 07:36:17 INFO - mozprofile == 0.28 07:36:17 INFO - mozrunner == 6.12 07:36:17 INFO - mozscreenshot == 0.1 07:36:17 INFO - mozsystemmonitor == 0.3 07:36:17 INFO - moztest == 0.7 07:36:17 INFO - mozversion == 1.4 07:36:17 INFO - psutil == 3.1.1 07:36:17 INFO - requests == 1.2.3 07:36:17 INFO - wsgiref == 0.1.2 07:36:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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')]} 07:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:17 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 0x10ddf8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff93b56af70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc0cd30>, '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 0x10da72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc04b20>, '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.eO1tUUr6Pl/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.pCtf15JojL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 07:36:17 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 07:36:17 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 07:36:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eO1tUUr6Pl/Render', 07:36:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:17 INFO - 'HOME': '/Users/cltbld', 07:36:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:17 INFO - 'LOGNAME': 'cltbld', 07:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:17 INFO - 'MOZ_NO_REMOTE': '1', 07:36:17 INFO - 'NO_EM_RESTART': '1', 07:36:17 INFO - 'PAGER': '/bin/cat', 07:36:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:17 INFO - 'PWD': '/builds/slave/test', 07:36:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:17 INFO - 'SHELL': '/bin/bash', 07:36:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pCtf15JojL/Listeners', 07:36:17 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 07:36:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:17 INFO - 'USER': 'cltbld', 07:36:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:17 INFO - 'XPC_FLAGS': '0x0', 07:36:17 INFO - 'XPC_SERVICE_NAME': '0', 07:36:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:17 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)) 07:36:17 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)) 07:36:17 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)) 07:36:17 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)) 07:36:17 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)) 07:36:17 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)) 07:36:17 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)) 07:36:17 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)) 07:36:17 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)) 07:36:17 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)) 07:36:17 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)) 07:36:17 INFO - Cleaning up... 07:36:17 INFO - Return code: 0 07:36:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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')]} 07:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:17 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 0x10ddf8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd6e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff93b56af70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc0cd30>, '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 0x10da72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc04b20>, '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.eO1tUUr6Pl/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.pCtf15JojL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 07:36:17 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 07:36:17 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 07:36:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eO1tUUr6Pl/Render', 07:36:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:17 INFO - 'HOME': '/Users/cltbld', 07:36:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:17 INFO - 'LOGNAME': 'cltbld', 07:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:17 INFO - 'MOZ_NO_REMOTE': '1', 07:36:17 INFO - 'NO_EM_RESTART': '1', 07:36:17 INFO - 'PAGER': '/bin/cat', 07:36:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:17 INFO - 'PWD': '/builds/slave/test', 07:36:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:17 INFO - 'SHELL': '/bin/bash', 07:36:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pCtf15JojL/Listeners', 07:36:17 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 07:36:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:17 INFO - 'USER': 'cltbld', 07:36:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:17 INFO - 'XPC_FLAGS': '0x0', 07:36:17 INFO - 'XPC_SERVICE_NAME': '0', 07:36:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:36:17 INFO - Cleaning up... 07:36:17 INFO - Return code: 0 07:36:17 INFO - Running post-action listener: _resource_record_post_action 07:36:17 INFO - Running post-action listener: _start_resource_monitoring 07:36:17 INFO - Starting resource monitoring. 07:36:17 INFO - [mozharness: 2016-09-30 14:36:17.590447Z] Finished create-virtualenv step (success) 07:36:17 INFO - [mozharness: 2016-09-30 14:36:17.591401Z] Running install step. 07:36:17 INFO - Running pre-action listener: _resource_record_pre_action 07:36:17 INFO - Running main action method: install 07:36:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:17 INFO - Reading from file tmpfile_stdout 07:36:17 INFO - Detecting whether we're running mozinstall >=1.0... 07:36:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:36:17 INFO - Reading from file tmpfile_stdout 07:36:17 INFO - Output received: 07:36:17 INFO - Usage: mozinstall [options] installer 07:36:17 INFO - Options: 07:36:17 INFO - -h, --help show this help message and exit 07:36:17 INFO - -d DEST, --destination=DEST 07:36:17 INFO - Directory to install application into. [default: 07:36:17 INFO - "/builds/slave/test"] 07:36:17 INFO - --app=APP Application being installed. [default: firefox] 07:36:17 INFO - mkdir: /builds/slave/test/build/application 07:36:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:36:49 INFO - Reading from file tmpfile_stdout 07:36:49 INFO - Output received: 07:36:49 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:36:49 INFO - Running post-action listener: _resource_record_post_action 07:36:49 INFO - [mozharness: 2016-09-30 14:36:49.792965Z] Finished install step (success) 07:36:49 INFO - [mozharness: 2016-09-30 14:36:49.793137Z] Running run-tests step. 07:36:49 INFO - Running pre-action listener: _resource_record_pre_action 07:36:49 INFO - Running main action method: run_tests 07:36:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:36:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:36:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:36:49 INFO - 2016-09-30 07:36:49.807 screenresolution[1643:8762] starting screenresolution argv=screenresolution get 07:36:49 INFO - 2016-09-30 07:36:49.810 screenresolution[1643:8762] Display 0: 1600x1200x32@60 07:36:49 INFO - 2016-09-30 07:36:49.816 screenresolution[1644:8765] starting screenresolution argv=screenresolution list 07:36:49 INFO - Available Modes on Display 0 07:36:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:36:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:36:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:36:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:36:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:36:50 INFO - Intel Iris: 07:36:50 INFO - Chipset Model: Intel Iris 07:36:50 INFO - Type: GPU 07:36:50 INFO - Bus: Built-In 07:36:50 INFO - VRAM (Dynamic, Max): 1536 MB 07:36:50 INFO - Vendor: Intel (0x8086) 07:36:50 INFO - Device ID: 0x0a2e 07:36:50 INFO - Revision ID: 0x0009 07:36:50 INFO - Displays: 07:36:50 INFO - Display: 07:36:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:36:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:36:50 INFO - Display Serial Number: 1600x1200 60 07:36:50 INFO - Main Display: Yes 07:36:50 INFO - Mirror: Off 07:36:50 INFO - Online: Yes 07:36:50 INFO - Rotation: Supported 07:36:50 INFO - Return code: 0 07:36:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:36:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:36:50 INFO - Python 2.7.3 07:36:50 INFO - Return code: 0 07:36:50 INFO - grabbing minidump binary from tooltool 07:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:50 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 0x10dc0cd30>, '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 0x10da72db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc04b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:36:50 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 07:36:50 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 07:36:50 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 07:36:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:36:50 INFO - Return code: 0 07:36:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:36:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:36:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:36:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:36:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:36:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0064', '--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 07:36:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0064 --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 07:36:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eO1tUUr6Pl/Render', 07:36:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:50 INFO - 'HOME': '/Users/cltbld', 07:36:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:50 INFO - 'LOGNAME': 'cltbld', 07:36:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:36:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:50 INFO - 'MOZ_NO_REMOTE': '1', 07:36:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:36:50 INFO - 'NO_EM_RESTART': '1', 07:36:50 INFO - 'PAGER': '/bin/cat', 07:36:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:50 INFO - 'PWD': '/builds/slave/test', 07:36:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:36:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:50 INFO - 'SHELL': '/bin/bash', 07:36:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pCtf15JojL/Listeners', 07:36:50 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 07:36:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:50 INFO - 'USER': 'cltbld', 07:36:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:50 INFO - 'XPC_FLAGS': '0x0', 07:36:50 INFO - 'XPC_SERVICE_NAME': '0', 07:36:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0064', '--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 07:36:50 INFO - mozversion application_buildid: 20160930013320 07:36:50 INFO - mozversion application_changeset: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 07:36:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:36:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:36:50 INFO - mozversion application_name: Firefox 07:36:50 INFO - mozversion application_remotingname: firefox-dev 07:36:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:36:50 INFO - mozversion application_vendor: Mozilla 07:36:50 INFO - mozversion application_version: 51.0a2 07:36:50 INFO - mozversion platform_buildid: 20160930013320 07:36:50 INFO - mozversion platform_changeset: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 07:36:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:36:50 INFO - mozversion platform_version: 51.0a2 07:36:50 INFO - using testdate: 1475246210 07:36:50 INFO - actual date: 1475246210 07:36:50 INFO - starting webserver on 'localhost:49267' 07:36:50 INFO - SUITE-START | Running 2 tests 07:36:50 INFO - TEST-START | dromaeo_css 07:36:50 INFO - operating with platform_type : mac_ 07:36:50 INFO - Initialising browser for dromaeo_css test... 07:36:50 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmpYDsORW/profile http://localhost:49267/getInfo.html) 07:36:52 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 07:36:52 INFO - PROCESS | 1654 | colorDepth:24 07:36:52 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 07:36:52 INFO - PROCESS | 1654 | __metrics 07:36:52 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:36:52 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:36:53 INFO - TEST-INFO | 1654: exit 0 07:36:53 INFO - Browser initialized. 07:36:53 INFO - Running cycle 1/1 for dromaeo_css test... 07:36:53 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmpYDsORW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:05 INFO - PROCESS | 1657 | RSS: Main: 218886144 07:37:05 INFO - PROCESS | 1657 | 07:37:56 INFO - PROCESS | 1657 | 1475246276656 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:40:08 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 07:40:10 INFO - PROCESS | 1657 | RSS: Main: 323403776 07:40:10 INFO - PROCESS | 1657 | 07:43:13 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 07:43:13 INFO - PROCESS | 1657 | RSS: Main: 348360704 07:43:13 INFO - PROCESS | 1657 | 07:46:15 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 07:46:16 INFO - PROCESS | 1657 | RSS: Main: 319696896 07:46:16 INFO - PROCESS | 1657 | 07:49:18 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 07:49:19 INFO - PROCESS | 1657 | RSS: Main: 323477504 07:49:19 INFO - PROCESS | 1657 | 07:52:22 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 07:52:23 INFO - PROCESS | 1657 | RSS: Main: 308830208 07:52:23 INFO - PROCESS | 1657 | 07:55:26 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 07:55:26 INFO - PROCESS | 1657 | RSS: Main: 363614208 07:55:26 INFO - PROCESS | 1657 | 07:55:26 INFO - PROCESS | 1657 | __start_tp_report 07:55:26 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 07:55:26 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 07:55:26 INFO - PROCESS | 1657 | |i|pagename|runs| 07:55:26 INFO - PROCESS | 1657 | |0;dojo.html;3139.8901038463655;3357.127146941795;3385.424477838769;3391.372596069729;3395.236071883825;5696.515796157327;5765.567582431314;5778.219940308057;5814;5827.854303642411;5691.943080569204;5753.424657534244;5755.165501002352;5760.884782304352;5764.827055188341;4982.77577509013;5220.216967454884;5237.973810130944;5269.235960785683;5310.495502927235;4705.858824235278;5174.844754657347;5177.119889618755;5187.040397526451;5347.866303342428;5214.270002199676;5253.185756207775;5255.474452554733;5262.079136151177;5270.4729527047375;5241.580673546107;5252.448492908266;5313.070212712799;5317.920231196496;5320.707361095138;5134.383873935114;5181.481851814826;5262.7631756571045;5265.815696450606;5287.021900948298;4616.6537509686905;5644.576656750719;5652.208690783294;5691.630044047124;5741.110127930177;6142.355052719445;6197.504199664016;6205.906911396332;6270.529710271748;6290.370962903673;6137.966867168923;6267.05994100884;6316.589421687576;6342.953412686901;6359.427651511386;5745.597808153431;5789.2763404574425;5839.474447299764;5845.386234445322;5849.822906727577;6302.560757621733;6322.557420980487;6345.777897773556;6346.777862774873;6348.428641422294;6023.45788879003;6211.689415529206;6223.719932603044;6224.439800417984;6237.500999919996;6157.476614487819;6164.044573091178;6192.349803270682;6230.376962303824;6230.937690623035;6180.443760061616;6240.875182496416;6241.063840423882;6246.469050130699;6248.9062664060075;5233.241180028951;6191.97832357665;6213.906791398133;6267.529935254783;6282.340354262737;4849.393825771778;4891.706497610155;4911.238757992517;4920.360353154067;4943.431505376856;4415.624671902924;4421.579949904753;4454.064646424287;4458.487273963536;4460.286354183315;5838;5848.2689663792025;5851.795187168429;5862.443067908542;5873.941260587425;6177.783777567854;6301.684915754194;6345.968270158712;6360.236771587439;6360.936390636127;4491.8203271869415;5720.799772007959;5782.421757824184;5839.737211825478;5980.953333166678;5447.319085114361;5451.373092094381;5455.781768729285;5460.481254280837;5476.726163691799;6327.778527751599;6340.682965851781;6345.746170153327;6353.491720662336;6361.427471527492;6094.878102438015;6106.206193195034;6125.754381768298;6232.906506402498;6268.905966410599;6324.30432652417;6332.841678958063;6342.651154186564;6349.460295874902;6350.4919606432295;6183.598066125867;6251.4061164189325;6252.218472690914;6263.749450021948;6272.529560282906;6133.671320645445;6195.349488303663;6219.129321895029;6293.622382657055;6333;4911.926321105115;5909.5863289569315;6146.661933593517;6173.043178307369;6181.783637572664;6071.51427885777;6139.355367686508;6145.262568491809;6147.047207682816;6156.569040167145;4958.677685950402;5816.767329306949;5860.648361098348;5936.703164841827;5973.820785376446;6060.333363329942;6062.605930614496;6073.726682299395;6146.231721034871;6150.169727086786;5962.016267316018;5964.910526342195;5971.820845374646;5984.1921340618455;6007.789727359522 07:55:26 INFO - PROCESS | 1657 | |1;ext.html;476.4354240225333;496.31756335039296;515.1551455612794;515.1808624287382;555.3086407422759;25691.357716057086;38919.610803891985;40546.189076218456;40548.79725601368;40656;42265;42757.931051723725;42810;42812.571874281246;42947.570524294744;9544.90455095447;9720.07659272368;9722.416655000687;9729.56216970238;9735.36720113194;8583.871241931376;8781.56092195391;8788.033316335199;8911.910880891173;8955;11660.591879284228;11921.94039029808;11927.224730392496;12095.455704493319;12174.878251217508;11826.349550774705;11910.761784764343;11921;11924.403779811062;11932.985696215788;8609.31125509964;8817.867731984026;11360.204785665006;11725.70685732855;11806.409679516075;31906.361872762416;39912.802615921566;39925.80037099825;39998.00004999869;40073.39889901625;3292.703656670887;3340.632530421676;3610.819459027038;3867.207222519377;3930.155016671429;30215.395692086036;30647;30739.38521229563;30914.845425772728;31233.37533249345;3116.750659947199;3194.5847039884666;3201.10369096651;3231.8060916345094;3288.62180849203;541212;543820;548593.999999996;549764;593547;50963;51515;51617.70955726137;51756.706082348246;60725.39274607286;60769.08846367308;63187.6840615794;63706.362936370046;63721.68139159275;63776;16671.33314667424;16852.57868553296;16869.662606747796;16870.409535666193;16889.98660080399;12936.482540698455;13015.934920325337;13028.41372138256;13032.934835325763;13044.217346959023;15955.601109972344;16177.272022759003;16230.51308460748;18321.900685958884;18359.17383717736;6677.632730199788;6914.7872680742685;7343.559386436831;7354.77935661931;7660.5403675779635;838.3335248477475;983.6311383231289;999.2355847776457;1017.9236557258236;1026.2405819693374;31153.221169470944;31577.842110789297;32119;32240.83879580634;33190.33619327648;845.6110189312985;891.7592250092569;1037.9775920718237;1084.6854412220525;1108.3349990005931;14017.299135043208;14784.778228326584;14829.406823727146;15095.773563396559;15108.773368399483;736394;742061;742769;743480;745359;55102.724486378116;55530.33408997737;55593.88812223733;55657.72171139118;55715.16427253594;1212.7028877924965;1260.3068312428127;1339.189790176929;1343.8387393512646;1380.2546624822685;29563.40873182567;30148.09555713332;30404.39191216119;30661.693383065885;31025.534616981215;48274;49063.75468122637;49073.75463122661;49101.75449122874;49151.50848491612;561956.1902190463;574521;578314;578955;582109;26594.468110638067;27340.316492087062;27453.72546274512;28278.85860570684;28331.150065498066;47711;47969.520304796504;48250.03499929912;48412.273815892084;49025.26462103143;38642.61357386503;38841.805790970866;39118;39436.60563394329;40759;38321.808390958984;38430.80784596059;38885;39443.605563943995;39954.60045399509;37961.671341502915;38184.80907595444;38883;39058.41412378873;39179.41230881482;33311.333773324885;33857.66142338545;34440.82779586086;34515.82742086273;34611.13472163216;25206.74793252044;25693.3576660585;25813.741862581133;26205.868970655025;26376 07:55:26 INFO - PROCESS | 1657 | |2;jquery.html;355.7936396889804;371.7249235565682;373.75145528223726;381.3117323231568;399.25339614920085;15069.321880515376;15305.617359566002;16620.418285360014;20236.8988155059;20906.581868362624;11939.522419103247;15478.922605386986;19585;20189.798102018976;20371.49071273219;5201.349831271082;5444.455554444564;5446.673199608016;5453.072977593819;5462.071447853855;5174.327337446127;5320.600954928376;5331.893362132755;5368.1679339702405;5371.892562148755;5364.812231571896;5369.140937450009;5370.731463426832;5372;5373.032854086263;5368.543673787733;5402.270693456372;5878.118282257653;5944.197533333031;5944.286685597713;5259.5529380002745;5259.86850328741;5264.105102132647;5264.263003179558;5264.473552644705;12850.228986260854;12961.41673624689;12962.80555791664;12984.805227921588;14986.025908315925;2380.4524959259293;2478.603423452239;2719.415325704963;2793.622860913771;2944.838033908134;9710.90289097107;9821.312508124434;10214.540345684461;10227.590896364136;10284.897151028543;1767.2577517442705;1817.3275887921554;1819.6079998800928;1850.9907450462797;1859.0425930645729;84522;114313.85587648576;118787.40606296914;122956;130611.69388306186;11021.669349919515;11347.602833900773;11567.190296679151;11594.826077608843;11793.938545530944;14865.777013344808;14879.70240595182;14882.776758348633;14898.106113633217;14942.327595258239;7210;8361.205685459872;8595.742127736177;8612.18184272493;8721.738347849574;8600.22597966186;8615.6984505542;8623.482591044558;8774.473531588124;8782.912170878337;4416;4474.619657329098;4501.729896206238;4552.954470455253;4581.518940511265;1864.515226041239;1898.9810101898804;1921.5580416504283;1923.1538123225737;1930.4401723500027;817.6198067898337;860.9956950215334;895.4627223665749;914.9222316103205;1002.5763415949369;16506.83493165077;21206.46983825417;21228.044737986827;21228.150873965176;21648;827.5034979012544;964.358701463533;995.9253056020827;1020.4234607446768;1032.850236715672;10373.429461379546;11030.007299343097;11070.612528561462;11076.778464430667;11126.332420054823;646647;648803;658764;669574;674636;135686;135717;138059;140994;147466;966.3477152921749;974.8001659659752;975.4732444480044;996.352370958868;996.6561536269975;17452.73820892713;17967.281308747504;18684.719729204346;18699.008158695087;18751.437456876316;52643;52827.943441131734;54440;55855.32434026986;56024.439755601925;77595.6120219418;79019;79726;80350.59824700838;81248;6909.30906909305;6928;7990.121086680344;8108.75673729789;8163.551004694561;11024.118070554176;12399.25604463735;12497.062720295833;12734.172278801849;12768.6807829805;8988.820223595621;10470.21473389514;10567.735806604896;10697.57209711634;11013.724656883642;10547.525361358605;10587.20595955322;10674;10746.408947507962;10828.079613232963;10632.787344253225;10658.507808906914;10830.783384332111;10981.231313807957;11135.276207046516;7759.413222479806;7953.6818527260575;8245.95877020611;8289.088200298083;8368.874466883124;9571.521423928914;10127.544260508148;10273.195901813913;10742.355458672504;10851.023407893012 07:55:26 INFO - PROCESS | 1657 | |3;mootools.html;1370.0546622830252;1538.5076775431862;1541.6916616676665;1740.5561581796649;1889.754331936848;7994.800129996753;8518.701845435411;8871.86692199616;9080.364374493787;9099.77250568736;8961.32790040748;9066.818663626724;9068.229200517964;9069;9085;2327.3483424641086;2366.6450032495177;2370.0519792083132;2371;2377.762223777626;2384.988075059622;2413.8672373019476;2428;2428.878556072198;2428.9271321860374;2388.9283321500384;2407.337982054931;2412.372783076404;2421.4551725861716;2428.344347026302;2019.707142464349;2360.929172124839;2381.0832829360734;2393.7247216569967;2393.7366889642126;2332.24202134307;2338.263447014185;2369.5024044950583;2371.34787933318;2373.121944880388;8971.865422018675;9075.001749807516;9077.954610226972;9078.319126065571;9099.317551183687;4654.394928659286;5319.388270348921;5325.334333208349;5482.533984611313;5489.972550137224;3548.3967725486473;3611.4763359313015;3632.8910132695796;3637.345277849986;3640.890773276806;1080.4921686807188;1092.8306112552489;1118.3792994887833;1121.7476067884743;1124.0782558302196;12080.697982550419;12156.817647735379;12178.878211217863;12198.39008049594;12200.145989780718;4351.3472979053395;4549.931751023737;4822.831200907952;4884.1941079722155;4996.425411077773;9410;9481.810363792823;9502.192313653417;9502.857457138149;9509.5720692569;5289.867753306198;5292.100342941709;5299.6025298102795;5300.522952934178;5305.628605997543;4491.865244042684;4638.304254361873;4927.926081108786;4931.802727890844;5025.346704928409;3808.7905165215625;3860.2472517858746;3918.5689574146822;3943.3296339622334;3957.6240257175523;1159.7854396936593;1162.6570161802288;1177.2347973816916;1182.9231099978474;1191.2614179208772;765.8353454007415;832.5545832979327;895.1540793949655;902.8510295801251;950.1591091883732;5937.287525496881;5944.673042982591;6006.069059295816;6117.449429551273;6154.230721159855;860.9569521523899;875.8554838451712;880.2693764175718;887.7691800131882;916.683744108295;3895.3962135868987;3901.668358189586;4015.0966032643005;4015.6586690131667;4130.235906357333;10719.571217151226;11215.55137794479;11225.326480411202;11225.60710375133;11234.15743819217;11150.832737508943;11163.106951443864;11165.38590377537;11222.719432014102;11234.49444774987;7996.440249182501;8278;8280.83438331242;8362.372822038371;8391.95804020976;5626.9027539631015;5988.610740301867;6058.27300723916;6130.386961303834;6173.876522469615;9572.521373931415;9942.602295908082;10534.262601617813;10556.472176391304;10571.62999295021;10560.894391055992;10562.260641755003;10589.152867770406;10596.841047384141;10620.946895265473;7102.573845569283;7290.198078211499;7306.96346518264;7688;7860.6069696513805;7173.497855150089;8444.66221351139;8570.828583428422;8687.522186279815;8689.435186712843;7553.357964572853;7671.61641917913;7679.654415551202;7715.1513333534385;7811.726589569338;7337.74317898871;7356.705731770669;7425.888611670721;7500.549967001997;7669.424793140425;7090.255523170199;7227.349538541556;7231.927680723125;7237.855242895218;7261.891071634035;5035.219540971156;5064.9746751267485;5149.455163450875;5209.374875015023;5236.476352364733;5077.492250774893;5113.744312784272;5130.743462826769;5201.1678131498775;5327.786888524571 07:55:26 INFO - PROCESS | 1657 | |4;prototype.html;298.1681109703926;300.2733385207797;305.8914085499647;312.1509494175841;313.24507935874544;4060.451839001734;5079.822206222783;5263.552598029162;5299.867503312415;5408.215808707735;5044.520770526794;5143.588512918966;5148.48515148485;5176.456472070435;5188.273641690166;4063.8577649782264;4074.612911773384;4084.9371067610964;4087.448194493735;4125.443065186191;3615.0420138663276;3736.607656196101;4068.715189936691;4076.61272179144;4113.341865301552;3986.3821107728204;4002.319605667029;4041.4746083009168;4049.6355328020472;4087.1825634872994;3970.166265084336;3996.4804575405155;4016.9196616067807;4037.37420699792;4083.3262511685534;3134.5768321276564;3318.369509793132;3410.7441941854213;3469.9132521686906;3548.556430446194;4636.768161591907;4868.756562171877;5055.620828437882;5138.768755406016;5217.608679349026;4517.457905051382;4519.322101684741;4526.932096018562;4535.977320113411;4558.931616025729;4371.650267978586;4917.754112294371;5267.499587539178;5355.858375959084;5558.832645144525;3767.830447629863;3769.98210483168;3796.1838204785827;3796.544414670257;3800.1829606634706;4898.387701537308;5807.506361959238;5828.939806601526;5834.2998840139035;5865.149553314788;3095.2880837407524;3319.887837574391;3807.7715337079862;3828.4257361395457;3863.16941857502;3311.0894504011108;3728.9440658390145;3895.8052097395016;3926.450296958371;3942.1327307992196;3959.426372857608;4442.97811503356;4527.728336299767;4534.77326133692;4538.503822897394;4822.469528351879;5505.421930697299;5530.589699626569;5600.4959553639555;5626.465485778845;1267.2649863079575;1276.7318863038681;1279.4562311017967;1288.1498211180576;1344.4017412251649;681.417388133149;723.735836419703;734.6877577029741;761.7333933123473;813.5728742410282;3695.464157697119;4035.757854528738;4185.748855068706;4349.391085248068;4393.045094932788;4248.256555102845;4571.748553829571;4851.6954446637565;4893.461719210955;4910.575932979467;3879.9612003880166;4271.8718438446895;4341.522432532419;4359;4362.105768317488;2076.979230207709;2126.6278401279715;2209.414505156135;2554.3231043773417;2558.475512519929;4696.051138777438;4793.9041219176115;4859.441164266154;4976.353074100344;5016.799328026911;4652.324913174938;4754.809807607726;4948.8762780930765;4972.801087956514;5002.623753717028;4614.238650622609;4660.5106463821485;5023.372078490115;5068.239764035424;5117.880106514292;4331.5451877552405;4404.9119017620105;4772.785224664829;4832.63755218353;4855.499417799765;4318.9352159718255;4607.539246075366;4617.215073437456;4650.256153942271;4655.441347038377;4285.91428171441;4573.395143875264;4843.75781210931;4946.452576922816;5086.202588576194;3384.949225761566;3394.250656967864;3397.5560386835;3607.8917632471066;3753.2922520253765;4567.921595674027;4775.71345719258;5566.749496272597;5742.640555275211;5802.65184088956;5545.694986775766;5624.803131890364;5630.324361076697;5676.310398241177;5725.942740572541;5252.44849290819;5538.806141785019;5554.472325129106;5583.441655834384;5635.746391412315;4670.369500117441;5492.418563275254;5504.9174262385295;5514.3732598882625;5538.86753599875;5643.391633384465;5651.915221271766;5653.547716182778;5657.349404818498;5663.545237405262;5072.188449848007;5223.112070947872;5532.917006244829;5558.805441809517;5560.888782224414 07:55:26 INFO - PROCESS | 1657 | |5;yui.html;609.1532769450464;701.2636731431995;776.4215659333797;784.5567254501207;813.3127507256366;14997.95014348996;16105.35578576857;16139.11234882081;16143.677126457464;16185;12110.212836165665;14371.78442323366;14597.708045839077;14603.78094328586;14665.853341466582;658.7957733102729;675.3617831149566;790.9881351779728;822.461287856452;827.5448503323148;832.7252006837759;837.6105111123327;837.6774941647479;840.6427268410931;840.9789755256106;887.0641473245723;888.9776756729748;889.6308032166643;893.3121496447732;893.8301722672671;684.2268236892305;684.8664510420446;717.6232477949067;858.1161403754144;878.152582757642;630.9747610095591;656.4518626946506;660.686174067319;662.4104546953215;663.0154220981838;14730.705385892223;14759.966802323841;14788.260586970608;14788.926055369655;14812.925935370362;13253.13854599448;13541.1198272112;13560.321983900765;13672.384742686503;13896.235707036109;10113;12099.939500302531;12227.643895638355;12422.56521021769;12919.031072669493;4426.667999900021;4434.977825110886;4478.619317357996;4729.810807567693;4731.1720448921305;86253;109962.45018774855;114860;114963;115443;10892.019718225398;10895.564177432814;11042.613508527164;11049;11231.606893758679;21855.562888742137;21875.78124218769;21895.890520547295;21895.890520547615;21926.794026328385;7609.695612175451;7656.885146722803;7963.721269755531;8095.311898488577;8126.10612832588;4083.959160408417;4165.229432554987;4171.249175148441;4171.728837625545;4174.436451079066;3429.4341433663167;3557.9822100889846;3559.430491121408;3562.07386079616;3565.4830049642655;612.1307743004944;647.6243778608396;654.1365397675023;660.3693472733528;675.5338816216795;525.836990532936;605.0621536618224;612.9693515324306;617.6479406738206;621.2948303675361;8374;9536.28477864163;9645.951770241103;9808.313418060667;9969.202463802878;629.2417636747708;655.8721049395322;672.0270001985348;697.553565717941;699.0981633692581;4596.4024676791805;4646.442426908792;4689.7655117244;4762.333273341735;4766.642501812378;168387.1580642089;168447;170712;171497;172051.27948720602;137345.93981090293;143189;146057;148639.51360486256;152312;101588;101946.47080293801;110446;126079;126123.73876261304;9557.90442095598;9967.302288839712;10017.799644006933;10352.792944141225;10363.06732394088;59414;64446.67776661087;64487.355126448136;65120.674396629605;65789.34210657832;71177.64411177911;79060.60469697615;91260;96597;97896;10539.367637941748;13314.600561983156;13506.59480215595;13663.385147668578;13777.298329165727;14674.926625366805;14817.629559261104;14926.179060151362;15144.924275378553;15421.074735515906;13120.409581569043;13134.211947283193;13139.60581182566;13579.981501387238;14298.57104286873;13866.376013079234;14183.716325673635;14711.485098021518;14876.181810000553;14951.700965980837;13828.654283642989;14020.228887411291;14049.36777844979;14595.635109122357;14610.342534586182;10349.74125646865;10521.421321827373;11132;11153.219274650697;11288.492017859051;8502.319814414956;11063.668089957315;11100.278481898651;11140.665780026613;11166.776664466503 07:55:26 INFO - PROCESS | 1657 | __end_tp_report 07:55:26 INFO - PROCESS | 1657 | __start_cc_report 07:55:26 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1067 07:55:26 INFO - PROCESS | 1657 | __end_cc_report 07:55:26 INFO - PROCESS | 1657 | __startTimestamp1475247326749__endTimestamp 07:55:26 INFO - PROCESS | 1657 | 07:55:26 INFO - PROCESS | 1657 | ------- Summary: start ------- 07:55:26 INFO - PROCESS | 1657 | Number of tests: 6 07:55:26 INFO - PROCESS | 1657 | 07:55:26 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5738.20 Median:5964.91 stddev:667.15 (11.2%) stddev-sans-first:637.30 07:55:26 INFO - PROCESS | 1657 | Values: 3139.9 3357.1 3385.4 3391.4 3395.2 5696.5 5765.6 5778.2 5814.0 5827.9 5691.9 5753.4 5755.2 5760.9 5764.8 4982.8 5220.2 5238.0 5269.2 5310.5 4705.9 5174.8 5177.1 5187.0 5347.9 5214.3 5253.2 5255.5 5262.1 5270.5 5241.6 5252.4 5313.1 5317.9 5320.7 5134.4 5181.5 5262.8 5265.8 5287.0 4616.7 5644.6 5652.2 5691.6 5741.1 6142.4 6197.5 6205.9 6270.5 6290.4 6138.0 6267.1 6316.6 6343.0 6359.4 5745.6 5789.3 5839.5 5845.4 5849.8 6302.6 6322.6 6345.8 6346.8 6348.4 6023.5 6211.7 6223.7 6224.4 6237.5 6157.5 6164.0 6192.3 6230.4 6230.9 6180.4 6240.9 6241.1 6246.5 6248.9 5233.2 6192.0 6213.9 6267.5 6282.3 4849.4 4891.7 4911.2 4920.4 4943.4 4415.6 4421.6 4454.1 4458.5 4460.3 5838.0 5848.3 5851.8 5862.4 5873.9 6177.8 6301.7 6346.0 6360.2 6360.9 4491.8 5720.8 5782.4 5839.7 5981.0 5447.3 5451.4 5455.8 5460.5 5476.7 6327.8 6340.7 6345.7 6353.5 6361.4 6094.9 6106.2 6125.8 6232.9 6268.9 6324.3 6332.8 6342.7 6349.5 6350.5 6183.6 6251.4 6252.2 6263.7 6272.5 6133.7 6195.3 6219.1 6293.6 6333.0 4911.9 5909.6 6146.7 6173.0 6181.8 6071.5 6139.4 6145.3 6147.0 6156.6 4958.7 5816.8 5860.6 5936.7 5973.8 6060.3 6062.6 6073.7 6146.2 6150.2 5962.0 5964.9 5971.8 5984.2 6007.8 07:55:26 INFO - PROCESS | 1657 | 07:55:26 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:74722.77 Median:38884.00 stddev:168821.25 (434.2%) stddev-sans-first:169202.80 07:55:26 INFO - PROCESS | 1657 | Values: 476.4 496.3 515.2 515.2 555.3 25691.4 38919.6 40546.2 40548.8 40656.0 42265.0 42757.9 42810.0 42812.6 42947.6 9544.9 9720.1 9722.4 9729.6 9735.4 8583.9 8781.6 8788.0 8911.9 8955.0 11660.6 11921.9 11927.2 12095.5 12174.9 11826.3 11910.8 11921.0 11924.4 11933.0 8609.3 8817.9 11360.2 11725.7 11806.4 31906.4 39912.8 39925.8 39998.0 40073.4 3292.7 3340.6 3610.8 3867.2 3930.2 30215.4 30647.0 30739.4 30914.8 31233.4 3116.8 3194.6 3201.1 3231.8 3288.6 541212.0 543820.0 548594.0 549764.0 593547.0 50963.0 51515.0 51617.7 51756.7 60725.4 60769.1 63187.7 63706.4 63721.7 63776.0 16671.3 16852.6 16869.7 16870.4 16890.0 12936.5 13015.9 13028.4 13032.9 13044.2 15955.6 16177.3 16230.5 18321.9 18359.2 6677.6 6914.8 7343.6 7354.8 7660.5 838.3 983.6 999.2 1017.9 1026.2 31153.2 31577.8 32119.0 32240.8 33190.3 845.6 891.8 1038.0 1084.7 1108.3 14017.3 14784.8 14829.4 15095.8 15108.8 736394.0 742061.0 742769.0 743480.0 745359.0 55102.7 55530.3 55593.9 55657.7 55715.2 1212.7 1260.3 1339.2 1343.8 1380.3 29563.4 30148.1 30404.4 30661.7 31025.5 48274.0 49063.8 49073.8 49101.8 49151.5 561956.2 574521.0 578314.0 578955.0 582109.0 26594.5 27340.3 27453.7 28278.9 28331.2 47711.0 47969.5 48250.0 48412.3 49025.3 38642.6 38841.8 39118.0 39436.6 40759.0 38321.8 38430.8 38885.0 39443.6 39954.6 37961.7 38184.8 38883.0 39058.4 39179.4 33311.3 33857.7 34440.8 34515.8 34611.1 25206.7 25693.4 25813.7 26205.9 26376.0 07:55:26 INFO - PROCESS | 1657 | 07:55:26 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:36398.20 Median:2756.52 stddev:109964.37 (3989.2%) stddev-sans-first:110239.55 07:55:26 INFO - PROCESS | 1657 | Values: 355.8 371.7 373.8 381.3 399.3 15069.3 15305.6 16620.4 20236.9 20906.6 11939.5 15478.9 19585.0 20189.8 20371.5 5201.3 5444.5 5446.7 5453.1 5462.1 5174.3 5320.6 5331.9 5368.2 5371.9 5364.8 5369.1 5370.7 5372.0 5373.0 5368.5 5402.3 5878.1 5944.2 5944.3 5259.6 5259.9 5264.1 5264.3 5264.5 12850.2 12961.4 12962.8 12984.8 14986.0 2380.5 2478.6 2719.4 2793.6 2944.8 9710.9 9821.3 10214.5 10227.6 10284.9 1767.3 1817.3 1819.6 1851.0 1859.0 84522.0 114313.9 118787.4 122956.0 130611.7 11021.7 11347.6 11567.2 11594.8 11793.9 14865.8 14879.7 14882.8 14898.1 14942.3 7210.0 8361.2 8595.7 8612.2 8721.7 8600.2 8615.7 8623.5 8774.5 8782.9 4416.0 4474.6 4501.7 4553.0 4581.5 1864.5 1899.0 1921.6 1923.2 1930.4 817.6 861.0 895.5 914.9 1002.6 16506.8 21206.5 21228.0 21228.2 21648.0 827.5 964.4 995.9 1020.4 1032.9 10373.4 11030.0 11070.6 11076.8 11126.3 646647.0 648803.0 658764.0 669574.0 674636.0 135686.0 135717.0 138059.0 140994.0 147466.0 966.3 974.8 975.5 996.4 996.7 17452.7 17967.3 18684.7 18699.0 18751.4 52643.0 52827.9 54440.0 55855.3 56024.4 77595.6 79019.0 79726.0 80350.6 81248.0 6909.3 6928.0 7990.1 8108.8 8163.6 11024.1 12399.3 12497.1 12734.2 12768.7 8988.8 10470.2 10567.7 10697.6 11013.7 10547.5 10587.2 10674.0 10746.4 10828.1 10632.8 10658.5 10830.8 10981.2 11135.3 7759.4 7953.7 8246.0 8289.1 8368.9 9571.5 10127.5 10273.2 10742.4 10851.0 07:55:26 INFO - PROCESS | 1657 | 07:55:26 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5816.83 Median:5071.23 stddev:3307.73 (65.2%) stddev-sans-first:3300.13 07:55:26 INFO - PROCESS | 1657 | Values: 1370.1 1538.5 1541.7 1740.6 1889.8 7994.8 8518.7 8871.9 9080.4 9099.8 8961.3 9066.8 9068.2 9069.0 9085.0 2327.3 2366.6 2370.1 2371.0 2377.8 2385.0 2413.9 2428.0 2428.9 2428.9 2388.9 2407.3 2412.4 2421.5 2428.3 2019.7 2360.9 2381.1 2393.7 2393.7 2332.2 2338.3 2369.5 2371.3 2373.1 8971.9 9075.0 9078.0 9078.3 9099.3 4654.4 5319.4 5325.3 5482.5 5490.0 3548.4 3611.5 3632.9 3637.3 3640.9 1080.5 1092.8 1118.4 1121.7 1124.1 12080.7 12156.8 12178.9 12198.4 12200.1 4351.3 4549.9 4822.8 4884.2 4996.4 9410.0 9481.8 9502.2 9502.9 9509.6 5289.9 5292.1 5299.6 5300.5 5305.6 4491.9 4638.3 4927.9 4931.8 5025.3 3808.8 3860.2 3918.6 3943.3 3957.6 1159.8 1162.7 1177.2 1182.9 1191.3 765.8 832.6 895.2 902.9 950.2 5937.3 5944.7 6006.1 6117.4 6154.2 861.0 875.9 880.3 887.8 916.7 3895.4 3901.7 4015.1 4015.7 4130.2 10719.6 11215.6 11225.3 11225.6 11234.2 11150.8 11163.1 11165.4 11222.7 11234.5 7996.4 8278.0 8280.8 8362.4 8392.0 5626.9 5988.6 6058.3 6130.4 6173.9 9572.5 9942.6 10534.3 10556.5 10571.6 10560.9 10562.3 10589.2 10596.8 10620.9 7102.6 7290.2 7307.0 7688.0 7860.6 7173.5 8444.7 8570.8 8687.5 8689.4 7553.4 7671.6 7679.7 7715.2 7811.7 7337.7 7356.7 7425.9 7500.5 7669.4 7090.3 7227.3 7231.9 7237.9 7261.9 5035.2 5065.0 5149.5 5209.4 5236.5 5077.5 5113.7 5130.7 5201.2 5327.8 07:55:26 INFO - PROCESS | 1657 | 07:55:26 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4262.51 Median:4610.89 stddev:1313.10 (28.5%) stddev-sans-first:1282.63 07:55:26 INFO - PROCESS | 1657 | Values: 298.2 300.3 305.9 312.2 313.2 4060.5 5079.8 5263.6 5299.9 5408.2 5044.5 5143.6 5148.5 5176.5 5188.3 4063.9 4074.6 4084.9 4087.4 4125.4 3615.0 3736.6 4068.7 4076.6 4113.3 3986.4 4002.3 4041.5 4049.6 4087.2 3970.2 3996.5 4016.9 4037.4 4083.3 3134.6 3318.4 3410.7 3469.9 3548.6 4636.8 4868.8 5055.6 5138.8 5217.6 4517.5 4519.3 4526.9 4536.0 4558.9 4371.7 4917.8 5267.5 5355.9 5558.8 3767.8 3770.0 3796.2 3796.5 3800.2 4898.4 5807.5 5828.9 5834.3 5865.1 3095.3 3319.9 3807.8 3828.4 3863.2 3311.1 3728.9 3895.8 3926.5 3942.1 3959.4 4443.0 4527.7 4534.8 4538.5 4822.5 5505.4 5530.6 5600.5 5626.5 1267.3 1276.7 1279.5 1288.1 1344.4 681.4 723.7 734.7 761.7 813.6 3695.5 4035.8 4185.7 4349.4 4393.0 4248.3 4571.7 4851.7 4893.5 4910.6 3880.0 4271.9 4341.5 4359.0 4362.1 2077.0 2126.6 2209.4 2554.3 2558.5 4696.1 4793.9 4859.4 4976.4 5016.8 4652.3 4754.8 4948.9 4972.8 5002.6 4614.2 4660.5 5023.4 5068.2 5117.9 4331.5 4404.9 4772.8 4832.6 4855.5 4318.9 4607.5 4617.2 4650.3 4655.4 4285.9 4573.4 4843.8 4946.5 5086.2 3384.9 3394.3 3397.6 3607.9 3753.3 4567.9 4775.7 5566.7 5742.6 5802.7 5545.7 5624.8 5630.3 5676.3 5725.9 5252.4 5538.8 5554.5 5583.4 5635.7 4670.4 5492.4 5504.9 5514.4 5538.9 5643.4 5651.9 5653.5 5657.3 5663.5 5072.2 5223.1 5532.9 5558.8 5560.9 07:55:26 INFO - PROCESS | 1657 | 07:55:26 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:25946.24 Median:12678.11 stddev:42833.36 (337.9%) stddev-sans-first:42911.28 07:55:26 INFO - PROCESS | 1657 | Values: 609.2 701.3 776.4 784.6 813.3 14998.0 16105.4 16139.1 16143.7 16185.0 12110.2 14371.8 14597.7 14603.8 14665.9 658.8 675.4 791.0 822.5 827.5 832.7 837.6 837.7 840.6 841.0 887.1 889.0 889.6 893.3 893.8 684.2 684.9 717.6 858.1 878.2 631.0 656.5 660.7 662.4 663.0 14730.7 14760.0 14788.3 14788.9 14812.9 13253.1 13541.1 13560.3 13672.4 13896.2 10113.0 12099.9 12227.6 12422.6 12919.0 4426.7 4435.0 4478.6 4729.8 4731.2 86253.0 109962.5 114860.0 114963.0 115443.0 10892.0 10895.6 11042.6 11049.0 11231.6 21855.6 21875.8 21895.9 21895.9 21926.8 7609.7 7656.9 7963.7 8095.3 8126.1 4084.0 4165.2 4171.2 4171.7 4174.4 3429.4 3558.0 3559.4 3562.1 3565.5 612.1 647.6 654.1 660.4 675.5 525.8 605.1 613.0 617.6 621.3 8374.0 9536.3 9646.0 9808.3 9969.2 629.2 655.9 672.0 697.6 699.1 4596.4 4646.4 4689.8 4762.3 4766.6 168387.2 168447.0 170712.0 171497.0 172051.3 137345.9 143189.0 146057.0 148639.5 152312.0 101588.0 101946.5 110446.0 126079.0 126123.7 9557.9 9967.3 10017.8 10352.8 10363.1 59414.0 64446.7 64487.4 65120.7 65789.3 71177.6 79060.6 91260.0 96597.0 97896.0 10539.4 13314.6 13506.6 13663.4 13777.3 14674.9 14817.6 14926.2 15144.9 15421.1 13120.4 13134.2 13139.6 13580.0 14298.6 13866.4 14183.7 14711.5 14876.2 14951.7 13828.7 14020.2 14049.4 14595.6 14610.3 10349.7 10521.4 11132.0 11153.2 11288.5 8502.3 11063.7 11100.3 11140.7 11166.8 07:55:26 INFO - PROCESS | 1657 | -------- Summary: end -------- 07:55:26 INFO - PROCESS | 1657 | 07:55:27 INFO - TEST-INFO | 1657: exit 0 07:55:27 INFO - TEST-OK | dromaeo_css | took 1116963ms 07:55:27 INFO - TEST-START | kraken 07:55:27 INFO - operating with platform_type : mac_ 07:55:27 INFO - Initialising browser for kraken test... 07:55:27 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmp14UHFa/profile http://localhost:49267/getInfo.html) 07:55:29 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 07:55:29 INFO - PROCESS | 1663 | colorDepth:24 07:55:29 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 07:55:29 INFO - PROCESS | 1663 | __metrics 07:55:29 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:55:29 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:55:30 INFO - TEST-INFO | 1663: exit 0 07:55:30 INFO - Browser initialized. 07:55:30 INFO - Running cycle 1/1 for kraken test... 07:55:30 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmp14UHFa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:42 INFO - PROCESS | 1664 | RSS: Main: 218836992 07:55:42 INFO - PROCESS | 1664 | 07:55:45 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 07:55:46 INFO - PROCESS | 1664 | RSS: Main: 268947456 07:55:46 INFO - PROCESS | 1664 | 07:55:48 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 07:55:49 INFO - PROCESS | 1664 | RSS: Main: 281534464 07:55:49 INFO - PROCESS | 1664 | 07:55:52 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 07:55:53 INFO - PROCESS | 1664 | RSS: Main: 378208256 07:55:53 INFO - PROCESS | 1664 | 07:55:55 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 07:55:55 INFO - PROCESS | 1664 | RSS: Main: 279543808 07:55:55 INFO - PROCESS | 1664 | 07:55:57 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:55:58 INFO - PROCESS | 1664 | RSS: Main: 281112576 07:55:58 INFO - PROCESS | 1664 | 07:56:01 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 07:56:01 INFO - PROCESS | 1664 | RSS: Main: 318660608 07:56:01 INFO - PROCESS | 1664 | 07:56:04 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:05 INFO - PROCESS | 1664 | RSS: Main: 319320064 07:56:05 INFO - PROCESS | 1664 | 07:56:08 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 07:56:08 INFO - PROCESS | 1664 | RSS: Main: 319365120 07:56:08 INFO - PROCESS | 1664 | 07:56:10 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:10 INFO - PROCESS | 1664 | RSS: Main: 294785024 07:56:10 INFO - PROCESS | 1664 | 07:56:12 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:13 INFO - PROCESS | 1664 | RSS: Main: 296644608 07:56:13 INFO - PROCESS | 1664 | 07:56:15 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:16 INFO - PROCESS | 1664 | RSS: Main: 295358464 07:56:16 INFO - PROCESS | 1664 | 07:56:19 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:19 INFO - PROCESS | 1664 | RSS: Main: 310743040 07:56:19 INFO - PROCESS | 1664 | 07:56:22 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:23 INFO - PROCESS | 1664 | RSS: Main: 307220480 07:56:23 INFO - PROCESS | 1664 | 07:56:25 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 07:56:25 INFO - PROCESS | 1664 | RSS: Main: 349958144 07:56:25 INFO - PROCESS | 1664 | 07:56:25 INFO - PROCESS | 1664 | __start_tp_report 07:56:25 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 07:56:25 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 07:56:25 INFO - PROCESS | 1664 | |i|pagename|runs| 07:56:25 INFO - PROCESS | 1664 | |0;ai-astar;117;113;115;114;114;115;115;113;114;114 07:56:25 INFO - PROCESS | 1664 | |1;audio-beat-detection;144;108;109;142;107;108;107;108;139;107 07:56:25 INFO - PROCESS | 1664 | |2;audio-dft;184;186;183;187;184;183;186;184;187;185 07:56:25 INFO - PROCESS | 1664 | |3;audio-fft;81;58;58;87;61;60;58;58;82;57 07:56:25 INFO - PROCESS | 1664 | |4;audio-oscillator;87;70;94;70;68;90;75;69;91;116 07:56:25 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;87;84;87;84;88;84;86;85;87;83 07:56:25 INFO - PROCESS | 1664 | |6;imaging-darkroom;144;92;93;93;92;92;93;94;93;92 07:56:25 INFO - PROCESS | 1664 | |7;imaging-desaturate;86;86;86;87;87;86;107;85;86;85 07:56:25 INFO - PROCESS | 1664 | |8;json-parse-financial;54;52;52;52;56;56;57;57;56;55 07:56:25 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;64;73;68;75;72;67;68;69;69;71 07:56:25 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;81;84;82;82;82;81;84;79;84;82 07:56:25 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;152;123;143;126;146;156;152;134;176;139 07:56:25 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;165;162;163;162;164;165;163;162;218;212 07:56:25 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;73;84;87;84;70;66;67;67;66;68 07:56:25 INFO - PROCESS | 1664 | __end_tp_report 07:56:25 INFO - PROCESS | 1664 | __start_cc_report 07:56:25 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1945 07:56:25 INFO - PROCESS | 1664 | __end_cc_report 07:56:25 INFO - PROCESS | 1664 | __startTimestamp1475247385292__endTimestamp 07:56:25 INFO - PROCESS | 1664 | 07:56:25 INFO - PROCESS | 1664 | ------- Summary: start ------- 07:56:25 INFO - PROCESS | 1664 | Number of tests: 14 07:56:25 INFO - PROCESS | 1664 | 07:56:25 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.50 stddev:1.17 (1.0%) stddev-sans-first:0.78 07:56:25 INFO - PROCESS | 1664 | Values: 117.0 113.0 115.0 114.0 114.0 115.0 115.0 113.0 114.0 114.0 07:56:25 INFO - PROCESS | 1664 | 07:56:25 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:117.90 Median:108.50 stddev:16.45 (15.2%) stddev-sans-first:14.49 07:56:25 INFO - PROCESS | 1664 | Values: 144.0 108.0 109.0 142.0 107.0 108.0 107.0 108.0 139.0 107.0 07:56:25 INFO - PROCESS | 1664 | 07:56:25 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:184.90 Median:185.50 stddev:1.52 (0.8%) stddev-sans-first:1.58 07:56:25 INFO - PROCESS | 1664 | Values: 184.0 186.0 183.0 187.0 184.0 183.0 186.0 184.0 187.0 185.0 07:56:25 INFO - PROCESS | 1664 | 07:56:25 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.50 stddev:12.11 (20.0%) stddev-sans-first:11.57 07:56:25 INFO - PROCESS | 1664 | Values: 81.0 58.0 58.0 87.0 61.0 60.0 58.0 58.0 82.0 57.0 07:56:25 INFO - PROCESS | 1664 | 07:56:25 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:83.00 Median:81.00 stddev:15.50 (19.1%) stddev-sans-first:16.37 07:56:25 INFO - PROCESS | 1664 | Values: 87.0 70.0 94.0 70.0 68.0 90.0 75.0 69.0 91.0 116.0 07:56:25 INFO - PROCESS | 1664 | 07:56:25 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:85.50 Median:86.50 stddev:1.72 (2.0%) stddev-sans-first:1.73 07:56:25 INFO - PROCESS | 1664 | Values: 87.0 84.0 87.0 84.0 88.0 84.0 86.0 85.0 87.0 83.0 07:56:25 INFO - PROCESS | 1664 | 07:56:25 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:97.80 Median:93.00 stddev:16.25 (17.5%) stddev-sans-first:0.71 07:56:25 INFO - PROCESS | 1664 | Values: 144.0 92.0 93.0 93.0 92.0 92.0 93.0 94.0 93.0 92.0 07:56:25 INFO - PROCESS | 1664 | 07:56:25 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:88.10 Median:86.00 stddev:6.67 (7.8%) stddev-sans-first:7.04 07:56:25 INFO - PROCESS | 1664 | Values: 86.0 86.0 86.0 87.0 87.0 86.0 107.0 85.0 86.0 85.0 07:56:25 INFO - PROCESS | 1664 | 07:56:25 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:56.00 stddev:2.06 (3.7%) stddev-sans-first:2.17 07:56:25 INFO - PROCESS | 1664 | Values: 54.0 52.0 52.0 52.0 56.0 56.0 57.0 57.0 56.0 55.0 07:56:25 INFO - PROCESS | 1664 | 07:56:25 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:3.20 (4.6%) stddev-sans-first:2.68 07:56:25 INFO - PROCESS | 1664 | Values: 64.0 73.0 68.0 75.0 72.0 67.0 68.0 69.0 69.0 71.0 07:56:25 INFO - PROCESS | 1664 | 07:56:25 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:1.60 (1.9%) stddev-sans-first:1.64 07:56:25 INFO - PROCESS | 1664 | Values: 81.0 84.0 82.0 82.0 82.0 81.0 84.0 79.0 84.0 82.0 07:56:25 INFO - PROCESS | 1664 | 07:56:25 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:144.70 Median:149.00 stddev:15.59 (10.5%) stddev-sans-first:16.31 07:56:25 INFO - PROCESS | 1664 | Values: 152.0 123.0 143.0 126.0 146.0 156.0 152.0 134.0 176.0 139.0 07:56:25 INFO - PROCESS | 1664 | 07:56:25 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:164.50 stddev:21.89 (13.3%) stddev-sans-first:23.00 07:56:25 INFO - PROCESS | 1664 | Values: 165.0 162.0 163.0 162.0 164.0 165.0 163.0 162.0 218.0 212.0 07:56:25 INFO - PROCESS | 1664 | 07:56:25 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:71.50 stddev:8.44 (11.8%) stddev-sans-first:8.96 07:56:25 INFO - PROCESS | 1664 | Values: 73.0 84.0 87.0 84.0 70.0 66.0 67.0 67.0 66.0 68.0 07:56:25 INFO - PROCESS | 1664 | -------- Summary: end -------- 07:56:25 INFO - PROCESS | 1664 | 07:56:26 INFO - TEST-INFO | 1664: exit 0 07:56:26 INFO - TEST-OK | kraken | took 58740ms 07:56:26 INFO - SUITE-END | took 1175s 07:56:26 INFO - Completed test suite (00:19:36) 07:56:26 INFO - javascript benchmark 07:56:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3139.8901038463655, 3357.127146941795, 3385.424477838769, 3391.372596069729, 3395.236071883825, 5696.515796157327, 5765.567582431314, 5778.219940308057, 5814.0, 5827.854303642411, 5691.943080569204, 5753.424657534244, 5755.165501002352, 5760.884782304352, 5764.827055188341, 4982.77577509013, 5220.216967454884, 5237.973810130944, 5269.235960785683, 5310.495502927235, 4705.858824235278, 5174.844754657347, 5177.119889618755, 5187.040397526451, 5347.866303342428, 5214.270002199676, 5253.185756207775, 5255.474452554733, 5262.079136151177, 5270.4729527047375, 5241.580673546107, 5252.448492908266, 5313.070212712799, 5317.920231196496, 5320.707361095138, 5134.383873935114, 5181.481851814826, 5262.7631756571045, 5265.815696450606, 5287.021900948298, 4616.6537509686905, 5644.576656750719, 5652.208690783294, 5691.630044047124, 5741.110127930177, 6142.355052719445, 6197.504199664016, 6205.906911396332, 6270.529710271748, 6290.370962903673, 6137.966867168923, 6267.05994100884, 6316.589421687576, 6342.953412686901, 6359.427651511386, 5745.597808153431, 5789.2763404574425, 5839.474447299764, 5845.386234445322, 5849.822906727577, 6302.560757621733, 6322.557420980487, 6345.777897773556, 6346.777862774873, 6348.428641422294, 6023.45788879003, 6211.689415529206, 6223.719932603044, 6224.439800417984, 6237.500999919996, 6157.476614487819, 6164.044573091178, 6192.349803270682, 6230.376962303824, 6230.937690623035, 6180.443760061616, 6240.875182496416, 6241.063840423882, 6246.469050130699, 6248.9062664060075, 5233.241180028951, 6191.97832357665, 6213.906791398133, 6267.529935254783, 6282.340354262737, 4849.393825771778, 4891.706497610155, 4911.238757992517, 4920.360353154067, 4943.431505376856, 4415.624671902924, 4421.579949904753, 4454.064646424287, 4458.487273963536, 4460.286354183315, 5838.0, 5848.2689663792025, 5851.795187168429, 5862.443067908542, 5873.941260587425, 6177.783777567854, 6301.684915754194, 6345.968270158712, 6360.236771587439, 6360.936390636127, 4491.8203271869415, 5720.799772007959, 5782.421757824184, 5839.737211825478, 5980.953333166678, 5447.319085114361, 5451.373092094381, 5455.781768729285, 5460.481254280837, 5476.726163691799, 6327.778527751599, 6340.682965851781, 6345.746170153327, 6353.491720662336, 6361.427471527492, 6094.878102438015, 6106.206193195034, 6125.754381768298, 6232.906506402498, 6268.905966410599, 6324.30432652417, 6332.841678958063, 6342.651154186564, 6349.460295874902, 6350.4919606432295, 6183.598066125867, 6251.4061164189325, 6252.218472690914, 6263.749450021948, 6272.529560282906, 6133.671320645445, 6195.349488303663, 6219.129321895029, 6293.622382657055, 6333.0, 4911.926321105115, 5909.5863289569315, 6146.661933593517, 6173.043178307369, 6181.783637572664, 6071.51427885777, 6139.355367686508, 6145.262568491809, 6147.047207682816, 6156.569040167145, 4958.677685950402, 5816.767329306949, 5860.648361098348, 5936.703164841827, 5973.820785376446, 6060.333363329942, 6062.605930614496, 6073.726682299395, 6146.231721034871, 6150.169727086786, 5962.016267316018, 5964.910526342195, 5971.820845374646, 5984.1921340618455, 6007.789727359522], "value": 5695.80450808314, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.4354240225333, 496.31756335039296, 515.1551455612794, 515.1808624287382, 555.3086407422759, 25691.357716057086, 38919.610803891985, 40546.189076218456, 40548.79725601368, 40656.0, 42265.0, 42757.931051723725, 42810.0, 42812.571874281246, 42947.570524294744, 9544.90455095447, 9720.07659272368, 9722.416655000687, 9729.56216970238, 9735.36720113194, 8583.871241931376, 8781.56092195391, 8788.033316335199, 8911.910880891173, 8955.0, 11660.591879284228, 11921.94039029808, 11927.224730392496, 12095.455704493319, 12174.878251217508, 11826.349550774705, 11910.761784764343, 11921.0, 11924.403779811062, 11932.985696215788, 8609.31125509964, 8817.867731984026, 11360.204785665006, 11725.70685732855, 11806.409679516075, 31906.361872762416, 39912.802615921566, 39925.80037099825, 39998.00004999869, 40073.39889901625, 3292.703656670887, 3340.632530421676, 3610.819459027038, 3867.207222519377, 3930.155016671429, 30215.395692086036, 30647.0, 30739.38521229563, 30914.845425772728, 31233.37533249345, 3116.750659947199, 3194.5847039884666, 3201.10369096651, 3231.8060916345094, 3288.62180849203, 541212.0, 543820.0, 548593.999999996, 549764.0, 593547.0, 50963.0, 51515.0, 51617.70955726137, 51756.706082348246, 60725.39274607286, 60769.08846367308, 63187.6840615794, 63706.362936370046, 63721.68139159275, 63776.0, 16671.33314667424, 16852.57868553296, 16869.662606747796, 16870.409535666193, 16889.98660080399, 12936.482540698455, 13015.934920325337, 13028.41372138256, 13032.934835325763, 13044.217346959023, 15955.601109972344, 16177.272022759003, 16230.51308460748, 18321.900685958884, 18359.17383717736, 6677.632730199788, 6914.7872680742685, 7343.559386436831, 7354.77935661931, 7660.5403675779635, 838.3335248477475, 983.6311383231289, 999.2355847776457, 1017.9236557258236, 1026.2405819693374, 31153.221169470944, 31577.842110789297, 32119.0, 32240.83879580634, 33190.33619327648, 845.6110189312985, 891.7592250092569, 1037.9775920718237, 1084.6854412220525, 1108.3349990005931, 14017.299135043208, 14784.778228326584, 14829.406823727146, 15095.773563396559, 15108.773368399483, 736394.0, 742061.0, 742769.0, 743480.0, 745359.0, 55102.724486378116, 55530.33408997737, 55593.88812223733, 55657.72171139118, 55715.16427253594, 1212.7028877924965, 1260.3068312428127, 1339.189790176929, 1343.8387393512646, 1380.2546624822685, 29563.40873182567, 30148.09555713332, 30404.39191216119, 30661.693383065885, 31025.534616981215, 48274.0, 49063.75468122637, 49073.75463122661, 49101.75449122874, 49151.50848491612, 561956.1902190463, 574521.0, 578314.0, 578955.0, 582109.0, 26594.468110638067, 27340.316492087062, 27453.72546274512, 28278.85860570684, 28331.150065498066, 47711.0, 47969.520304796504, 48250.03499929912, 48412.273815892084, 49025.26462103143, 38642.61357386503, 38841.805790970866, 39118.0, 39436.60563394329, 40759.0, 38321.808390958984, 38430.80784596059, 38885.0, 39443.605563943995, 39954.60045399509, 37961.671341502915, 38184.80907595444, 38883.0, 39058.41412378873, 39179.41230881482, 33311.333773324885, 33857.66142338545, 34440.82779586086, 34515.82742086273, 34611.13472163216, 25206.74793252044, 25693.3576660585, 25813.741862581133, 26205.868970655025, 26376.0], "value": 20233.517552288617, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.7936396889804, 371.7249235565682, 373.75145528223726, 381.3117323231568, 399.25339614920085, 15069.321880515376, 15305.617359566002, 16620.418285360014, 20236.8988155059, 20906.581868362624, 11939.522419103247, 15478.922605386986, 19585.0, 20189.798102018976, 20371.49071273219, 5201.349831271082, 5444.455554444564, 5446.673199608016, 5453.072977593819, 5462.071447853855, 5174.327337446127, 5320.600954928376, 5331.893362132755, 5368.1679339702405, 5371.892562148755, 5364.812231571896, 5369.140937450009, 5370.731463426832, 5372.0, 5373.032854086263, 5368.543673787733, 5402.270693456372, 5878.118282257653, 5944.197533333031, 5944.286685597713, 5259.5529380002745, 5259.86850328741, 5264.105102132647, 5264.263003179558, 5264.473552644705, 12850.228986260854, 12961.41673624689, 12962.80555791664, 12984.805227921588, 14986.025908315925, 2380.4524959259293, 2478.603423452239, 2719.415325704963, 2793.622860913771, 2944.838033908134, 9710.90289097107, 9821.312508124434, 10214.540345684461, 10227.590896364136, 10284.897151028543, 1767.2577517442705, 1817.3275887921554, 1819.6079998800928, 1850.9907450462797, 1859.0425930645729, 84522.0, 114313.85587648576, 118787.40606296914, 122956.0, 130611.69388306186, 11021.669349919515, 11347.602833900773, 11567.190296679151, 11594.826077608843, 11793.938545530944, 14865.777013344808, 14879.70240595182, 14882.776758348633, 14898.106113633217, 14942.327595258239, 7210.0, 8361.205685459872, 8595.742127736177, 8612.18184272493, 8721.738347849574, 8600.22597966186, 8615.6984505542, 8623.482591044558, 8774.473531588124, 8782.912170878337, 4416.0, 4474.619657329098, 4501.729896206238, 4552.954470455253, 4581.518940511265, 1864.515226041239, 1898.9810101898804, 1921.5580416504283, 1923.1538123225737, 1930.4401723500027, 817.6198067898337, 860.9956950215334, 895.4627223665749, 914.9222316103205, 1002.5763415949369, 16506.83493165077, 21206.46983825417, 21228.044737986827, 21228.150873965176, 21648.0, 827.5034979012544, 964.358701463533, 995.9253056020827, 1020.4234607446768, 1032.850236715672, 10373.429461379546, 11030.007299343097, 11070.612528561462, 11076.778464430667, 11126.332420054823, 646647.0, 648803.0, 658764.0, 669574.0, 674636.0, 135686.0, 135717.0, 138059.0, 140994.0, 147466.0, 966.3477152921749, 974.8001659659752, 975.4732444480044, 996.352370958868, 996.6561536269975, 17452.73820892713, 17967.281308747504, 18684.719729204346, 18699.008158695087, 18751.437456876316, 52643.0, 52827.943441131734, 54440.0, 55855.32434026986, 56024.439755601925, 77595.6120219418, 79019.0, 79726.0, 80350.59824700838, 81248.0, 6909.30906909305, 6928.0, 7990.121086680344, 8108.75673729789, 8163.551004694561, 11024.118070554176, 12399.25604463735, 12497.062720295833, 12734.172278801849, 12768.6807829805, 8988.820223595621, 10470.21473389514, 10567.735806604896, 10697.57209711634, 11013.724656883642, 10547.525361358605, 10587.20595955322, 10674.0, 10746.408947507962, 10828.079613232963, 10632.787344253225, 10658.507808906914, 10830.783384332111, 10981.231313807957, 11135.276207046516, 7759.413222479806, 7953.6818527260575, 8245.95877020611, 8289.088200298083, 8368.874466883124, 9571.521423928914, 10127.544260508148, 10273.195901813913, 10742.355458672504, 10851.023407893012], "value": 9228.335209183502, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.0546622830252, 1538.5076775431862, 1541.6916616676665, 1740.5561581796649, 1889.754331936848, 7994.800129996753, 8518.701845435411, 8871.86692199616, 9080.364374493787, 9099.77250568736, 8961.32790040748, 9066.818663626724, 9068.229200517964, 9069.0, 9085.0, 2327.3483424641086, 2366.6450032495177, 2370.0519792083132, 2371.0, 2377.762223777626, 2384.988075059622, 2413.8672373019476, 2428.0, 2428.878556072198, 2428.9271321860374, 2388.9283321500384, 2407.337982054931, 2412.372783076404, 2421.4551725861716, 2428.344347026302, 2019.707142464349, 2360.929172124839, 2381.0832829360734, 2393.7247216569967, 2393.7366889642126, 2332.24202134307, 2338.263447014185, 2369.5024044950583, 2371.34787933318, 2373.121944880388, 8971.865422018675, 9075.001749807516, 9077.954610226972, 9078.319126065571, 9099.317551183687, 4654.394928659286, 5319.388270348921, 5325.334333208349, 5482.533984611313, 5489.972550137224, 3548.3967725486473, 3611.4763359313015, 3632.8910132695796, 3637.345277849986, 3640.890773276806, 1080.4921686807188, 1092.8306112552489, 1118.3792994887833, 1121.7476067884743, 1124.0782558302196, 12080.697982550419, 12156.817647735379, 12178.878211217863, 12198.39008049594, 12200.145989780718, 4351.3472979053395, 4549.931751023737, 4822.831200907952, 4884.1941079722155, 4996.425411077773, 9410.0, 9481.810363792823, 9502.192313653417, 9502.857457138149, 9509.5720692569, 5289.867753306198, 5292.100342941709, 5299.6025298102795, 5300.522952934178, 5305.628605997543, 4491.865244042684, 4638.304254361873, 4927.926081108786, 4931.802727890844, 5025.346704928409, 3808.7905165215625, 3860.2472517858746, 3918.5689574146822, 3943.3296339622334, 3957.6240257175523, 1159.7854396936593, 1162.6570161802288, 1177.2347973816916, 1182.9231099978474, 1191.2614179208772, 765.8353454007415, 832.5545832979327, 895.1540793949655, 902.8510295801251, 950.1591091883732, 5937.287525496881, 5944.673042982591, 6006.069059295816, 6117.449429551273, 6154.230721159855, 860.9569521523899, 875.8554838451712, 880.2693764175718, 887.7691800131882, 916.683744108295, 3895.3962135868987, 3901.668358189586, 4015.0966032643005, 4015.6586690131667, 4130.235906357333, 10719.571217151226, 11215.55137794479, 11225.326480411202, 11225.60710375133, 11234.15743819217, 11150.832737508943, 11163.106951443864, 11165.38590377537, 11222.719432014102, 11234.49444774987, 7996.440249182501, 8278.0, 8280.83438331242, 8362.372822038371, 8391.95804020976, 5626.9027539631015, 5988.610740301867, 6058.27300723916, 6130.386961303834, 6173.876522469615, 9572.521373931415, 9942.602295908082, 10534.262601617813, 10556.472176391304, 10571.62999295021, 10560.894391055992, 10562.260641755003, 10589.152867770406, 10596.841047384141, 10620.946895265473, 7102.573845569283, 7290.198078211499, 7306.96346518264, 7688.0, 7860.6069696513805, 7173.497855150089, 8444.66221351139, 8570.828583428422, 8687.522186279815, 8689.435186712843, 7553.357964572853, 7671.61641917913, 7679.654415551202, 7715.1513333534385, 7811.726589569338, 7337.74317898871, 7356.705731770669, 7425.888611670721, 7500.549967001997, 7669.424793140425, 7090.255523170199, 7227.349538541556, 7231.927680723125, 7237.855242895218, 7261.891071634035, 5035.219540971156, 5064.9746751267485, 5149.455163450875, 5209.374875015023, 5236.476352364733, 5077.492250774893, 5113.744312784272, 5130.743462826769, 5201.1678131498775, 5327.786888524571], "value": 4638.173995185242, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.1681109703926, 300.2733385207797, 305.8914085499647, 312.1509494175841, 313.24507935874544, 4060.451839001734, 5079.822206222783, 5263.552598029162, 5299.867503312415, 5408.215808707735, 5044.520770526794, 5143.588512918966, 5148.48515148485, 5176.456472070435, 5188.273641690166, 4063.8577649782264, 4074.612911773384, 4084.9371067610964, 4087.448194493735, 4125.443065186191, 3615.0420138663276, 3736.607656196101, 4068.715189936691, 4076.61272179144, 4113.341865301552, 3986.3821107728204, 4002.319605667029, 4041.4746083009168, 4049.6355328020472, 4087.1825634872994, 3970.166265084336, 3996.4804575405155, 4016.9196616067807, 4037.37420699792, 4083.3262511685534, 3134.5768321276564, 3318.369509793132, 3410.7441941854213, 3469.9132521686906, 3548.556430446194, 4636.768161591907, 4868.756562171877, 5055.620828437882, 5138.768755406016, 5217.608679349026, 4517.457905051382, 4519.322101684741, 4526.932096018562, 4535.977320113411, 4558.931616025729, 4371.650267978586, 4917.754112294371, 5267.499587539178, 5355.858375959084, 5558.832645144525, 3767.830447629863, 3769.98210483168, 3796.1838204785827, 3796.544414670257, 3800.1829606634706, 4898.387701537308, 5807.506361959238, 5828.939806601526, 5834.2998840139035, 5865.149553314788, 3095.2880837407524, 3319.887837574391, 3807.7715337079862, 3828.4257361395457, 3863.16941857502, 3311.0894504011108, 3728.9440658390145, 3895.8052097395016, 3926.450296958371, 3942.1327307992196, 3959.426372857608, 4442.97811503356, 4527.728336299767, 4534.77326133692, 4538.503822897394, 4822.469528351879, 5505.421930697299, 5530.589699626569, 5600.4959553639555, 5626.465485778845, 1267.2649863079575, 1276.7318863038681, 1279.4562311017967, 1288.1498211180576, 1344.4017412251649, 681.417388133149, 723.735836419703, 734.6877577029741, 761.7333933123473, 813.5728742410282, 3695.464157697119, 4035.757854528738, 4185.748855068706, 4349.391085248068, 4393.045094932788, 4248.256555102845, 4571.748553829571, 4851.6954446637565, 4893.461719210955, 4910.575932979467, 3879.9612003880166, 4271.8718438446895, 4341.522432532419, 4359.0, 4362.105768317488, 2076.979230207709, 2126.6278401279715, 2209.414505156135, 2554.3231043773417, 2558.475512519929, 4696.051138777438, 4793.9041219176115, 4859.441164266154, 4976.353074100344, 5016.799328026911, 4652.324913174938, 4754.809807607726, 4948.8762780930765, 4972.801087956514, 5002.623753717028, 4614.238650622609, 4660.5106463821485, 5023.372078490115, 5068.239764035424, 5117.880106514292, 4331.5451877552405, 4404.9119017620105, 4772.785224664829, 4832.63755218353, 4855.499417799765, 4318.9352159718255, 4607.539246075366, 4617.215073437456, 4650.256153942271, 4655.441347038377, 4285.91428171441, 4573.395143875264, 4843.75781210931, 4946.452576922816, 5086.202588576194, 3384.949225761566, 3394.250656967864, 3397.5560386835, 3607.8917632471066, 3753.2922520253765, 4567.921595674027, 4775.71345719258, 5566.749496272597, 5742.640555275211, 5802.65184088956, 5545.694986775766, 5624.803131890364, 5630.324361076697, 5676.310398241177, 5725.942740572541, 5252.44849290819, 5538.806141785019, 5554.472325129106, 5583.441655834384, 5635.746391412315, 4670.369500117441, 5492.418563275254, 5504.9174262385295, 5514.3732598882625, 5538.86753599875, 5643.391633384465, 5651.915221271766, 5653.547716182778, 5657.349404818498, 5663.545237405262, 5072.188449848007, 5223.112070947872, 5532.917006244829, 5558.805441809517, 5560.888782224414], "value": 3841.1686950055587, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.1532769450464, 701.2636731431995, 776.4215659333797, 784.5567254501207, 813.3127507256366, 14997.95014348996, 16105.35578576857, 16139.11234882081, 16143.677126457464, 16185.0, 12110.212836165665, 14371.78442323366, 14597.708045839077, 14603.78094328586, 14665.853341466582, 658.7957733102729, 675.3617831149566, 790.9881351779728, 822.461287856452, 827.5448503323148, 832.7252006837759, 837.6105111123327, 837.6774941647479, 840.6427268410931, 840.9789755256106, 887.0641473245723, 888.9776756729748, 889.6308032166643, 893.3121496447732, 893.8301722672671, 684.2268236892305, 684.8664510420446, 717.6232477949067, 858.1161403754144, 878.152582757642, 630.9747610095591, 656.4518626946506, 660.686174067319, 662.4104546953215, 663.0154220981838, 14730.705385892223, 14759.966802323841, 14788.260586970608, 14788.926055369655, 14812.925935370362, 13253.13854599448, 13541.1198272112, 13560.321983900765, 13672.384742686503, 13896.235707036109, 10113.0, 12099.939500302531, 12227.643895638355, 12422.56521021769, 12919.031072669493, 4426.667999900021, 4434.977825110886, 4478.619317357996, 4729.810807567693, 4731.1720448921305, 86253.0, 109962.45018774855, 114860.0, 114963.0, 115443.0, 10892.019718225398, 10895.564177432814, 11042.613508527164, 11049.0, 11231.606893758679, 21855.562888742137, 21875.78124218769, 21895.890520547295, 21895.890520547615, 21926.794026328385, 7609.695612175451, 7656.885146722803, 7963.721269755531, 8095.311898488577, 8126.10612832588, 4083.959160408417, 4165.229432554987, 4171.249175148441, 4171.728837625545, 4174.436451079066, 3429.4341433663167, 3557.9822100889846, 3559.430491121408, 3562.07386079616, 3565.4830049642655, 612.1307743004944, 647.6243778608396, 654.1365397675023, 660.3693472733528, 675.5338816216795, 525.836990532936, 605.0621536618224, 612.9693515324306, 617.6479406738206, 621.2948303675361, 8374.0, 9536.28477864163, 9645.951770241103, 9808.313418060667, 9969.202463802878, 629.2417636747708, 655.8721049395322, 672.0270001985348, 697.553565717941, 699.0981633692581, 4596.4024676791805, 4646.442426908792, 4689.7655117244, 4762.333273341735, 4766.642501812378, 168387.1580642089, 168447.0, 170712.0, 171497.0, 172051.27948720602, 137345.93981090293, 143189.0, 146057.0, 148639.51360486256, 152312.0, 101588.0, 101946.47080293801, 110446.0, 126079.0, 126123.73876261304, 9557.90442095598, 9967.302288839712, 10017.799644006933, 10352.792944141225, 10363.06732394088, 59414.0, 64446.67776661087, 64487.355126448136, 65120.674396629605, 65789.34210657832, 71177.64411177911, 79060.60469697615, 91260.0, 96597.0, 97896.0, 10539.367637941748, 13314.600561983156, 13506.59480215595, 13663.385147668578, 13777.298329165727, 14674.926625366805, 14817.629559261104, 14926.179060151362, 15144.924275378553, 15421.074735515906, 13120.409581569043, 13134.211947283193, 13139.60581182566, 13579.981501387238, 14298.57104286873, 13866.376013079234, 14183.716325673635, 14711.485098021518, 14876.181810000553, 14951.700965980837, 13828.654283642989, 14020.228887411291, 14049.36777844979, 14595.635109122357, 14610.342534586182, 10349.74125646865, 10521.421321827373, 11132.0, 11153.219274650697, 11288.492017859051, 8502.319814414956, 11063.668089957315, 11100.278481898651, 11140.665780026613, 11166.776664466503], "value": 7865.123306858721, "unit": "score"}], "name": "dromaeo_css", "value": 7281.470573981268, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 115.0, 114.0, 114.0, 115.0, 115.0, 113.0, 114.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 108.0, 109.0, 142.0, 107.0, 108.0, 107.0, 108.0, 139.0, 107.0], "value": 117.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 183.0, 187.0, 184.0, 183.0, 186.0, 184.0, 187.0, 185.0], "value": 184.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 58.0, 87.0, 61.0, 60.0, 58.0, 58.0, 82.0, 57.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 94.0, 70.0, 68.0, 90.0, 75.0, 69.0, 91.0, 116.0], "value": 83.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 88.0, 84.0, 86.0, 85.0, 87.0, 83.0], "value": 85.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 92.0, 93.0, 93.0, 92.0, 92.0, 93.0, 94.0, 93.0, 92.0], "value": 97.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 87.0, 87.0, 86.0, 107.0, 85.0, 86.0, 85.0], "value": 88.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 52.0, 56.0, 56.0, 57.0, 57.0, 56.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 68.0, 75.0, 72.0, 67.0, 68.0, 69.0, 69.0, 71.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 82.0, 82.0, 82.0, 81.0, 84.0, 79.0, 84.0, 82.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 143.0, 126.0, 146.0, 156.0, 152.0, 134.0, 176.0, 139.0], "value": 144.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 163.0, 162.0, 164.0, 165.0, 163.0, 162.0, 218.0, 212.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 84.0, 87.0, 84.0, 70.0, 66.0, 67.0, 67.0, 66.0, 68.0], "value": 73.2, "unit": "score"}], "name": "kraken", "value": 1435.5, "alertThreshold": 2.0}]} 07:56:26 INFO - Return code: 0 07:56:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:56:26 INFO - # TBPL SUCCESS # 07:56:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:56:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:56:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:56:26 INFO - 2016-09-30 07:56:26.599 screenresolution[1668:10913] starting screenresolution argv=screenresolution get 07:56:26 INFO - 2016-09-30 07:56:26.602 screenresolution[1668:10913] Display 0: 1600x1200x32@60 07:56:26 INFO - 2016-09-30 07:56:26.608 screenresolution[1669:10916] starting screenresolution argv=screenresolution list 07:56:26 INFO - Available Modes on Display 0 07:56:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:56:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:56:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:56:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:56:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:56:26 INFO - Intel Iris: 07:56:26 INFO - Chipset Model: Intel Iris 07:56:26 INFO - Type: GPU 07:56:26 INFO - Bus: Built-In 07:56:26 INFO - VRAM (Dynamic, Max): 1536 MB 07:56:26 INFO - Vendor: Intel (0x8086) 07:56:26 INFO - Device ID: 0x0a2e 07:56:26 INFO - Revision ID: 0x0009 07:56:26 INFO - Displays: 07:56:26 INFO - Display: 07:56:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:56:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:56:26 INFO - Display Serial Number: 1600x1200 60 07:56:26 INFO - Main Display: Yes 07:56:26 INFO - Mirror: Off 07:56:26 INFO - Online: Yes 07:56:26 INFO - Rotation: Supported 07:56:26 INFO - Return code: 0 07:56:26 INFO - Running post-action listener: _resource_record_post_action 07:56:26 INFO - [mozharness: 2016-09-30 14:56:26.843654Z] Finished run-tests step (success) 07:56:26 INFO - Running post-run listener: _resource_record_post_run 07:56:26 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 32943104; Write bytes: 664256000; Read time: 314; Write time: 2028 07:56:26 INFO - TinderboxPrint: CPU usage
53.7% 07:56:26 INFO - TinderboxPrint: I/O read bytes / time
32,943,104 / 314 07:56:26 INFO - TinderboxPrint: I/O write bytes / time
664,256,000 / 2,028 07:56:26 INFO - TinderboxPrint: CPU idle
2,237.2 (46.3%) 07:56:26 INFO - TinderboxPrint: CPU system
975.9 (20.2%) 07:56:26 INFO - TinderboxPrint: CPU user
1,620.7 (33.5%) 07:56:26 INFO - TinderboxPrint: Swap in / out
392,826,880 / 0 07:56:26 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 362328576; Write bytes: 357697536; Read time: 27638; Write time: 786 07:56:26 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 28892160; Write bytes: 296134144; Read time: 282; Write time: 1204 07:56:27 INFO - Running post-run listener: _upload_blobber_files 07:56:27 INFO - Blob upload gear active. 07:56:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:56:27 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 07:56:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:56:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:56:27 INFO - (blobuploader) - INFO - Open directory for files ... 07:56:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:56:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:56:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:28 INFO - (blobuploader) - INFO - Done attempting. 07:56:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:56:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:56:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:29 INFO - (blobuploader) - INFO - Done attempting. 07:56:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:56:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:56:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:31 INFO - (blobuploader) - INFO - Done attempting. 07:56:31 INFO - (blobuploader) - INFO - Iteration through files over. 07:56:31 INFO - Return code: 0 07:56:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:56:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:56:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ce362e4e1d256ce7f4e2729f43f28724cd4797d5175f6a415ee6d18222ec0b163d0340752591cf6e7cd90daf86f643852134fe7140f5dfe1eea8337421e642f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c964deb212c7423d34dd3d315f9938d0147777814469193a7e8f7be24199e3258377eb58508b138fb7185b474c5f13075a29f0a2ea72473a2bf3f499d6405d2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04415732ccc1ea254691bc8e2e19a0dbed45cf25b39b0fa85c8a0335ca5164e8ec183a5ce09dd05b0f7913d713c00fa5e543ea0f62711763c7e524423719bfa1"} 07:56:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:56:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:56:31 INFO - Contents: 07:56:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ce362e4e1d256ce7f4e2729f43f28724cd4797d5175f6a415ee6d18222ec0b163d0340752591cf6e7cd90daf86f643852134fe7140f5dfe1eea8337421e642f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c964deb212c7423d34dd3d315f9938d0147777814469193a7e8f7be24199e3258377eb58508b138fb7185b474c5f13075a29f0a2ea72473a2bf3f499d6405d2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04415732ccc1ea254691bc8e2e19a0dbed45cf25b39b0fa85c8a0335ca5164e8ec183a5ce09dd05b0f7913d713c00fa5e543ea0f62711763c7e524423719bfa1"} 07:56:31 INFO - Running post-run listener: copy_logs_to_upload_dir 07:56:31 INFO - Copying logs to upload dir... 07:56:31 INFO - mkdir: /builds/slave/test/build/upload/logs 07:56:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.556023 ========= master_lag: 3.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-30 07:56:34.998235) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-09-30 07:56:35.001616) ========= 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.eO1tUUr6Pl/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.pCtf15JojL/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ce362e4e1d256ce7f4e2729f43f28724cd4797d5175f6a415ee6d18222ec0b163d0340752591cf6e7cd90daf86f643852134fe7140f5dfe1eea8337421e642f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c964deb212c7423d34dd3d315f9938d0147777814469193a7e8f7be24199e3258377eb58508b138fb7185b474c5f13075a29f0a2ea72473a2bf3f499d6405d2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04415732ccc1ea254691bc8e2e19a0dbed45cf25b39b0fa85c8a0335ca5164e8ec183a5ce09dd05b0f7913d713c00fa5e543ea0f62711763c7e524423719bfa1"} build_url:https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011103 build_url: 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ce362e4e1d256ce7f4e2729f43f28724cd4797d5175f6a415ee6d18222ec0b163d0340752591cf6e7cd90daf86f643852134fe7140f5dfe1eea8337421e642f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c964deb212c7423d34dd3d315f9938d0147777814469193a7e8f7be24199e3258377eb58508b138fb7185b474c5f13075a29f0a2ea72473a2bf3f499d6405d2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04415732ccc1ea254691bc8e2e19a0dbed45cf25b39b0fa85c8a0335ca5164e8ec183a5ce09dd05b0f7913d713c00fa5e543ea0f62711763c7e524423719bfa1"}' ========= master_lag: 4.72 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-09-30 07:56:39.731912) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:56:39.732278) ========= 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.eO1tUUr6Pl/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.pCtf15JojL/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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.005621 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:56:39.794503) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 07:56:39.794783) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 07:56:39.801601) ========= ========= Total master_lag: 7.99 =========