builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0237 starttime: 1494435036.16 results: success (0) buildid: 20170509092824 builduid: c1cc6ebbdb7a4cdeb7b37fa552aa6c40 revision: 4ac208f317b37f7ed2e669d5ca23064ebc979103 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:36.159751) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:36.160483) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:36.161020) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:36.191018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:36.191711) ========= 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.GJrCU8BJYu/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.HVIIaSbwY8/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-10 09:50:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2017-05-10 09:50:36 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.096102 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:36.316468) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:36.317182) ========= 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.GJrCU8BJYu/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.HVIIaSbwY8/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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.026484 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:36.368855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-10 09:50:36.369256) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4ac208f317b37f7ed2e669d5ca23064ebc979103 --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-beta --rev 4ac208f317b37f7ed2e669d5ca23064ebc979103 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GJrCU8BJYu/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.HVIIaSbwY8/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-10 09:50:36,471 truncating revision to first 12 chars 2017-05-10 09:50:36,471 Setting DEBUG logging. 2017-05-10 09:50:36,471 attempt 1/10 2017-05-10 09:50:36,471 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4ac208f317b3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-10 09:50:37,728 unpacking tar archive at: mozilla-beta-4ac208f317b3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.527592 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-10 09:50:37.922120) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:37.922625) ========= script_repo_revision: 4ac208f317b37f7ed2e669d5ca23064ebc979103 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:37.923388) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:37.923928) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 09:50:37.945338) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2017-05-10 09:50:37.945996) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GJrCU8BJYu/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.HVIIaSbwY8/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 09:50:38 INFO - MultiFileLogger online at 20170510 09:50:38 in /builds/slave/test 09:50:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:50:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:50:38 INFO - {'append_to_log': False, 09:50:38 INFO - 'base_work_dir': '/builds/slave/test', 09:50:38 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:50:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:50:38 INFO - 'branch': 'Mozilla-Beta', 09:50:38 INFO - 'buildbot_json_path': 'buildprops.json', 09:50:38 INFO - 'config_files': ('talos/mac_config.py',), 09:50:38 INFO - 'default_actions': ('clobber', 09:50:38 INFO - 'read-buildbot-config', 09:50:38 INFO - 'download-and-extract', 09:50:38 INFO - 'populate-webroot', 09:50:38 INFO - 'create-virtualenv', 09:50:38 INFO - 'install', 09:50:38 INFO - 'run-tests'), 09:50:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:50:38 INFO - 'download_minidump_stackwalk': True, 09:50:38 INFO - 'download_symbols': 'ondemand', 09:50:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:50:38 INFO - 'tooltool.py': '/tools/tooltool.py', 09:50:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:50:38 INFO - '/tools/misc-python/virtualenv.py')}, 09:50:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:50:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:50:38 INFO - 'gecko_profile': False, 09:50:38 INFO - 'gecko_profile_interval': 0, 09:50:38 INFO - 'installer_path': 'installer.exe', 09:50:38 INFO - 'log_level': 'info', 09:50:38 INFO - 'log_name': 'talos', 09:50:38 INFO - 'log_to_console': True, 09:50:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:50:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:50:38 INFO - 'opt_config_files': (), 09:50:38 INFO - 'pip_index': False, 09:50:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:50:38 INFO - 'cmd': ('bash', 09:50:38 INFO - '-c', 09:50:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:50:38 INFO - 'enabled': True, 09:50:38 INFO - 'halt_on_failure': False, 09:50:38 INFO - 'name': 'check_screen_resolution'},), 09:50:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:50:38 INFO - 'cmd': ('bash', 09:50:38 INFO - '-c', 09:50:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:50:38 INFO - 'enabled': True, 09:50:38 INFO - 'halt_on_failure': False, 09:50:38 INFO - 'name': 'check_screen_resolution'},), 09:50:38 INFO - 'run_cmd_checks_enabled': True, 09:50:38 INFO - 'suite': 'dromaeojs', 09:50:38 INFO - 'system_bits': '32', 09:50:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:50:38 INFO - 'title': 't-yosemite-r7-0237', 09:50:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:50:38 INFO - 'use_talos_json': True, 09:50:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:50:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:50:38 INFO - 'work_dir': 'build'} 09:50:38 INFO - [mozharness: 2017-05-10 16:50:38.164004Z] Running clobber step. 09:50:38 INFO - Running pre-action listener: _resource_record_pre_action 09:50:38 INFO - Running main action method: clobber 09:50:38 INFO - rmtree: /builds/slave/test/build 09:50:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:50:40 INFO - Running post-action listener: _resource_record_post_action 09:50:40 INFO - [mozharness: 2017-05-10 16:50:40.556049Z] Finished clobber step (success) 09:50:40 INFO - [mozharness: 2017-05-10 16:50:40.556214Z] Running read-buildbot-config step. 09:50:40 INFO - Running pre-action listener: _resource_record_pre_action 09:50:40 INFO - Running main action method: read_buildbot_config 09:50:40 INFO - Using buildbot properties: 09:50:40 INFO - { 09:50:40 INFO - "project": "", 09:50:40 INFO - "product": "firefox", 09:50:40 INFO - "script_repo_revision": "production", 09:50:40 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:50:40 INFO - "repository": "", 09:50:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:50:40 INFO - "buildid": "20170509092824", 09:50:40 INFO - "pgo_build": "False", 09:50:40 INFO - "basedir": "/builds/slave/test", 09:50:40 INFO - "buildnumber": 7, 09:50:40 INFO - "slavename": "t-yosemite-r7-0237", 09:50:40 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 09:50:40 INFO - "platform": "yosemite_r7", 09:50:40 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:50:40 INFO - "branch": "mozilla-beta", 09:50:40 INFO - "repo_path": "releases/mozilla-beta", 09:50:40 INFO - "revision": "4ac208f317b37f7ed2e669d5ca23064ebc979103", 09:50:40 INFO - "stage_platform": "macosx64", 09:50:40 INFO - "builduid": "c1cc6ebbdb7a4cdeb7b37fa552aa6c40", 09:50:40 INFO - "slavebuilddir": "test" 09:50:40 INFO - } 09:50:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 09:50:40 INFO - Running post-action listener: _resource_record_post_action 09:50:40 INFO - [mozharness: 2017-05-10 16:50:40.561937Z] Finished read-buildbot-config step (success) 09:50:40 INFO - [mozharness: 2017-05-10 16:50:40.562167Z] Running download-and-extract step. 09:50:40 INFO - Running pre-action listener: _resource_record_pre_action 09:50:40 INFO - Running main action method: download_and_extract 09:50:40 INFO - mkdir: /builds/slave/test/build/tests 09:50:40 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')]} 09:50:40 INFO - trying https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 09:50:40 INFO - Downloading https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 09:50:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 09:50:41 INFO - Downloaded 1287 bytes. 09:50:41 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 09:50:41 INFO - Using the following test package requirements: 09:50:41 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:50:41 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 09:50:41 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 09:50:41 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:50:41 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 09:50:41 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:50:41 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 09:50:41 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:50:41 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:50:41 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 09:50:41 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 09:50:41 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:50:41 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 09:50:41 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:50:41 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 09:50:41 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:50:41 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 09:50:41 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 09:50:41 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 09:50:41 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 09:50:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 09:50:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 09:50:41 INFO - Fetch https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 09:50:43 INFO - Expected file size: 51223859 09:50:43 INFO - Obtained file size: 51223859 09:50:59 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:50:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 09:50:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 09:50:59 INFO - Fetch https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 09:51:00 INFO - Expected file size: 51223859 09:51:00 INFO - Obtained file size: 51223859 09:51:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 09:51:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 09:51:16 INFO - Fetch https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 09:51:17 INFO - Expected file size: 14404449 09:51:17 INFO - Obtained file size: 14404449 09:51: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')]} 09:51:17 INFO - trying https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 09:51:17 INFO - Downloading https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 09:51:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 09:51:19 INFO - Downloaded 59570664 bytes. 09:51:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 09:51:19 INFO - mkdir: /builds/slave/test/properties 09:51:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:51:19 INFO - Writing to file /builds/slave/test/properties/build_url 09:51:19 INFO - Contents: 09:51:19 INFO - build_url:https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 09:51:20 INFO - Running post-action listener: _resource_record_post_action 09:51:20 INFO - Running post-action listener: set_extra_try_arguments 09:51:20 INFO - [mozharness: 2017-05-10 16:51:20.193145Z] Finished download-and-extract step (success) 09:51:20 INFO - [mozharness: 2017-05-10 16:51:20.193240Z] Running populate-webroot step. 09:51:20 INFO - Running pre-action listener: _resource_record_pre_action 09:51:20 INFO - Running main action method: populate_webroot 09:51:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:51:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:51:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:51:20 INFO - '--tppagecycles', 09:51:20 INFO - '7'], 09:51:20 INFO - 'tests': ['tsvgm']}}, 09:51:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:51:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:51:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:51:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:51:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:51:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:51:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:51:20 INFO - 'talos_options': ['--disable-e10s'], 09:51:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:51:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:51:20 INFO - 'talos_options': ['--disable-e10s'], 09:51:20 INFO - 'tests': ['damp', 'tps']}, 09:51:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:51:20 INFO - 'tests': ['damp', 'tps']}, 09:51:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:51:20 INFO - 'tests': ['dromaeo_dom']}, 09:51:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:51:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:51:20 INFO - 'tests': ['basic_compositor_video']}, 09:51:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:51:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:51:20 INFO - 'tests': ['a11yr', 09:51:20 INFO - 'ts_paint', 09:51:20 INFO - 'tpaint', 09:51:20 INFO - 'sessionrestore', 09:51:20 INFO - 'sessionrestore_no_auto_restore', 09:51:20 INFO - 'tabpaint']}, 09:51:20 INFO - 'other-e10s': {'tests': ['a11yr', 09:51:20 INFO - 'ts_paint', 09:51:20 INFO - 'tpaint', 09:51:20 INFO - 'sessionrestore', 09:51:20 INFO - 'sessionrestore_no_auto_restore', 09:51:20 INFO - 'tabpaint']}, 09:51:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:51:20 INFO - 'ts_paint', 09:51:20 INFO - 'tpaint', 09:51:20 INFO - 'sessionrestore', 09:51:20 INFO - 'sessionrestore_no_auto_restore', 09:51:20 INFO - 'tabpaint']}, 09:51:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:51:20 INFO - 'ts_paint', 09:51:20 INFO - 'tpaint', 09:51:20 INFO - 'sessionrestore', 09:51:20 INFO - 'sessionrestore_no_auto_restore', 09:51:20 INFO - 'tabpaint']}, 09:51:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:51:20 INFO - 'tests': ['a11yr', 09:51:20 INFO - 'ts_paint', 09:51:20 INFO - 'tpaint', 09:51:20 INFO - 'sessionrestore', 09:51:20 INFO - 'sessionrestore_no_auto_restore', 09:51:20 INFO - 'tabpaint']}, 09:51:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:51:20 INFO - 'tests': ['a11yr', 09:51:20 INFO - 'ts_paint', 09:51:20 INFO - 'tpaint', 09:51:20 INFO - 'sessionrestore', 09:51:20 INFO - 'sessionrestore_no_auto_restore', 09:51:20 INFO - 'tabpaint']}, 09:51:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:51:20 INFO - 'tests': ['tsvgx', 09:51:20 INFO - 'tsvgr_opacity', 09:51:20 INFO - 'tart', 09:51:20 INFO - 'tscrollx', 09:51:20 INFO - 'cart', 09:51:20 INFO - 'tsvg_static']}, 09:51:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:51:20 INFO - 'tsvgr_opacity', 09:51:20 INFO - 'tart', 09:51:20 INFO - 'tscrollx', 09:51:20 INFO - 'cart', 09:51:20 INFO - 'tsvg_static']}, 09:51:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:51:20 INFO - 'talos_options': ['--disable-e10s'], 09:51:20 INFO - 'tests': ['tp5o']}, 09:51:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:51:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:51:20 INFO - 'talos_options': ['--disable-e10s', 09:51:20 INFO - '--xperf_path', 09:51:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:20 INFO - 'tests': ['tp5n']}, 09:51:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:51:20 INFO - 'talos_options': ['--xperf_path', 09:51:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:20 INFO - 'tests': ['tp5n']}}, 09:51:20 INFO - 'talos.zip': {'path': '', 09:51:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:51:20 INFO - Running post-action listener: _resource_record_post_action 09:51:20 INFO - [mozharness: 2017-05-10 16:51:20.211816Z] Finished populate-webroot step (success) 09:51:20 INFO - [mozharness: 2017-05-10 16:51:20.211930Z] Running create-virtualenv step. 09:51:20 INFO - Running pre-action listener: _resource_record_pre_action 09:51:20 INFO - Running main action method: create_virtualenv 09:51:20 INFO - Creating virtualenv /builds/slave/test/build/venv 09:51:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:51:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:51:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:51:20 INFO - Using real prefix '/tools/python27' 09:51:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:51:21 INFO - Installing distribute.............................................................................................................................................................................................done. 09:51:23 INFO - Installing pip.................done. 09:51:23 INFO - Return code: 0 09:51:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:51:24 INFO - Reading from file tmpfile_stdout 09:51:24 INFO - Output received: 09:51:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:51:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fb5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9302c9e150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f939d30>, '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 0x10f860db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f92ebe8>, '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.GJrCU8BJYu/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.HVIIaSbwY8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 09:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GJrCU8BJYu/Render', 09:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:24 INFO - 'HOME': '/Users/cltbld', 09:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:24 INFO - 'LOGNAME': 'cltbld', 09:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:24 INFO - 'MOZ_NO_REMOTE': '1', 09:51:24 INFO - 'NO_EM_RESTART': '1', 09:51:24 INFO - 'PAGER': '/bin/cat', 09:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:24 INFO - 'PWD': '/builds/slave/test', 09:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:24 INFO - 'SHELL': '/bin/bash', 09:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVIIaSbwY8/Listeners', 09:51:24 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 09:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:24 INFO - 'USER': 'cltbld', 09:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:24 INFO - 'XPC_FLAGS': '0x0', 09:51:24 INFO - 'XPC_SERVICE_NAME': '0', 09:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:51:24 INFO - Cleaning up... 09:51:24 INFO - Return code: 0 09:51:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fb5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9302c9e150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f939d30>, '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 0x10f860db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f92ebe8>, '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.GJrCU8BJYu/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.HVIIaSbwY8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 09:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GJrCU8BJYu/Render', 09:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:24 INFO - 'HOME': '/Users/cltbld', 09:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:24 INFO - 'LOGNAME': 'cltbld', 09:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:24 INFO - 'MOZ_NO_REMOTE': '1', 09:51:24 INFO - 'NO_EM_RESTART': '1', 09:51:24 INFO - 'PAGER': '/bin/cat', 09:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:24 INFO - 'PWD': '/builds/slave/test', 09:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:24 INFO - 'SHELL': '/bin/bash', 09:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVIIaSbwY8/Listeners', 09:51:24 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 09:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:24 INFO - 'USER': 'cltbld', 09:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:24 INFO - 'XPC_FLAGS': '0x0', 09:51:24 INFO - 'XPC_SERVICE_NAME': '0', 09:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:24 INFO - Downloading/unpacking psutil>=3.1.1 09:51:24 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 09:51:24 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 09:51:24 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 09:51:24 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 09:51:24 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 09:51:24 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 09:51:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:51:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:27 INFO - Installing collected packages: psutil 09:51:27 INFO - Running setup.py install for psutil 09:51:27 INFO - building 'psutil._psutil_osx' extension 09:51:27 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 09:51:27 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 09:51:27 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 09:51:27 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 09:51:27 INFO - building 'psutil._psutil_posix' extension 09:51:27 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 09:51:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:51:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:51:27 INFO - ^ 09:51:27 INFO - 1 warning generated. 09:51:27 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 09:51:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:28 INFO - Successfully installed psutil 09:51:28 INFO - Cleaning up... 09:51:28 INFO - Return code: 0 09:51:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:51:28 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')]} 09:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:28 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')]} 09:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:28 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 0x10fb5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9302c9e150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f939d30>, '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 0x10f860db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f92ebe8>, '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.GJrCU8BJYu/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.HVIIaSbwY8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 09:51:28 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 09:51:28 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 09:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GJrCU8BJYu/Render', 09:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:28 INFO - 'HOME': '/Users/cltbld', 09:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:28 INFO - 'LOGNAME': 'cltbld', 09:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:28 INFO - 'MOZ_NO_REMOTE': '1', 09:51:28 INFO - 'NO_EM_RESTART': '1', 09:51:28 INFO - 'PAGER': '/bin/cat', 09:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:28 INFO - 'PWD': '/builds/slave/test', 09:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:28 INFO - 'SHELL': '/bin/bash', 09:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVIIaSbwY8/Listeners', 09:51:28 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 09:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:28 INFO - 'USER': 'cltbld', 09:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:28 INFO - 'XPC_FLAGS': '0x0', 09:51:28 INFO - 'XPC_SERVICE_NAME': '0', 09:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:51:28 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 09:51:28 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 09:51:28 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 09:51:28 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 09:51:28 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 09:51:28 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 09:51:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:51:29 INFO - Installing collected packages: mozsystemmonitor 09:51:29 INFO - Running setup.py install for mozsystemmonitor 09:51:30 INFO - Successfully installed mozsystemmonitor 09:51:30 INFO - Cleaning up... 09:51:30 INFO - Return code: 0 09:51:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:30 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 0x10fb5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9302c9e150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f939d30>, '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 0x10f860db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f92ebe8>, '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.GJrCU8BJYu/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.HVIIaSbwY8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 09:51:30 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 09:51:30 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 09:51:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GJrCU8BJYu/Render', 09:51:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:30 INFO - 'HOME': '/Users/cltbld', 09:51:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:30 INFO - 'LOGNAME': 'cltbld', 09:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:30 INFO - 'MOZ_NO_REMOTE': '1', 09:51:30 INFO - 'NO_EM_RESTART': '1', 09:51:30 INFO - 'PAGER': '/bin/cat', 09:51:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:30 INFO - 'PWD': '/builds/slave/test', 09:51:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:30 INFO - 'SHELL': '/bin/bash', 09:51:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVIIaSbwY8/Listeners', 09:51:30 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 09:51:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:30 INFO - 'USER': 'cltbld', 09:51:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:30 INFO - 'XPC_FLAGS': '0x0', 09:51:30 INFO - 'XPC_SERVICE_NAME': '0', 09:51:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:30 INFO - Downloading/unpacking jsonschema==2.5.1 09:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:51:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:51:31 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 09:51:31 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 09:51:31 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 09:51:31 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 09:51:31 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 09:51:31 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 09:51:31 INFO - Downloading functools32-3.2.3-2.tar.gz 09:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:51:32 INFO - warning: no files found matching '*.txt' 09:51:32 INFO - no previously-included directories found matching 'build' 09:51:32 INFO - no previously-included directories found matching 'dist' 09:51:32 INFO - no previously-included directories found matching '.git*' 09:51:32 INFO - Installing collected packages: jsonschema, functools32 09:51:32 INFO - Running setup.py install for functools32 09:51:32 INFO - warning: no files found matching '*.txt' 09:51:32 INFO - no previously-included directories found matching 'build' 09:51:32 INFO - no previously-included directories found matching 'dist' 09:51:32 INFO - no previously-included directories found matching '.git*' 09:51:32 INFO - Successfully installed jsonschema functools32 09:51:32 INFO - Cleaning up... 09:51:32 INFO - Return code: 0 09:51:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fb5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9302c9e150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f939d30>, '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 0x10f860db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f92ebe8>, '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.GJrCU8BJYu/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.HVIIaSbwY8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 09:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GJrCU8BJYu/Render', 09:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:33 INFO - 'HOME': '/Users/cltbld', 09:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:33 INFO - 'LOGNAME': 'cltbld', 09:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:33 INFO - 'MOZ_NO_REMOTE': '1', 09:51:33 INFO - 'NO_EM_RESTART': '1', 09:51:33 INFO - 'PAGER': '/bin/cat', 09:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:33 INFO - 'PWD': '/builds/slave/test', 09:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:33 INFO - 'SHELL': '/bin/bash', 09:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVIIaSbwY8/Listeners', 09:51:33 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 09:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:33 INFO - 'USER': 'cltbld', 09:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:33 INFO - 'XPC_FLAGS': '0x0', 09:51:33 INFO - 'XPC_SERVICE_NAME': '0', 09:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:51:33 INFO - Cleaning up... 09:51:33 INFO - Return code: 0 09:51:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fb5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9302c9e150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f939d30>, '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 0x10f860db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f92ebe8>, '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.GJrCU8BJYu/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.HVIIaSbwY8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 09:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GJrCU8BJYu/Render', 09:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:33 INFO - 'HOME': '/Users/cltbld', 09:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:33 INFO - 'LOGNAME': 'cltbld', 09:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:33 INFO - 'MOZ_NO_REMOTE': '1', 09:51:33 INFO - 'NO_EM_RESTART': '1', 09:51:33 INFO - 'PAGER': '/bin/cat', 09:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:33 INFO - 'PWD': '/builds/slave/test', 09:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:33 INFO - 'SHELL': '/bin/bash', 09:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVIIaSbwY8/Listeners', 09:51:33 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 09:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:33 INFO - 'USER': 'cltbld', 09:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:33 INFO - 'XPC_FLAGS': '0x0', 09:51:33 INFO - 'XPC_SERVICE_NAME': '0', 09:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:33 INFO - Downloading/unpacking blobuploader==1.2.4 09:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:35 INFO - Downloading blobuploader-1.2.4.tar.gz 09:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:51:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:51:35 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 09:51:35 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 09:51:35 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 09:51:35 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 09:51:35 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 09:51:35 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 09:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:51:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:51:36 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 09:51:36 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 09:51:36 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 09:51:36 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 09:51:36 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 09:51:36 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 09:51:36 INFO - Downloading docopt-0.6.1.tar.gz 09:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:51:36 INFO - Installing collected packages: blobuploader, requests, docopt 09:51:36 INFO - Running setup.py install for blobuploader 09:51:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:51:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:51:36 INFO - Running setup.py install for requests 09:51:37 INFO - Running setup.py install for docopt 09:51:37 INFO - Successfully installed blobuploader requests docopt 09:51:37 INFO - Cleaning up... 09:51:37 INFO - Return code: 0 09:51:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:37 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 0x10fb5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9302c9e150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f939d30>, '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 0x10f860db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f92ebe8>, '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.GJrCU8BJYu/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.HVIIaSbwY8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 09:51:37 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 09:51:37 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 09:51:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GJrCU8BJYu/Render', 09:51:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:37 INFO - 'HOME': '/Users/cltbld', 09:51:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:37 INFO - 'LOGNAME': 'cltbld', 09:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:37 INFO - 'MOZ_NO_REMOTE': '1', 09:51:37 INFO - 'NO_EM_RESTART': '1', 09:51:37 INFO - 'PAGER': '/bin/cat', 09:51:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:37 INFO - 'PWD': '/builds/slave/test', 09:51:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:37 INFO - 'SHELL': '/bin/bash', 09:51:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVIIaSbwY8/Listeners', 09:51:37 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 09:51:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:37 INFO - 'USER': 'cltbld', 09:51:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:37 INFO - 'XPC_FLAGS': '0x0', 09:51:37 INFO - 'XPC_SERVICE_NAME': '0', 09:51:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:37 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-gocmWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:38 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-lC92f9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:38 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-pFP4tZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:38 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-VuGUbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:38 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-Kjipba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:38 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-6d2XgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:38 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-wZPRfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:38 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-IOUOLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:38 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-9NWElb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:38 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-2_q7pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:38 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-4o5LNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:39 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-Ngoyth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:39 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-zzaqmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:39 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-JeS0JC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:39 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-zK6OAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:39 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-fhouW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:39 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-w3EFCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:51:39 INFO - Running setup.py install for manifestparser 09:51:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:51:39 INFO - Running setup.py install for mozcrash 09:51:40 INFO - Running setup.py install for mozdebug 09:51:40 INFO - Running setup.py install for mozdevice 09:51:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:51:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:51:40 INFO - Running setup.py install for mozfile 09:51:40 INFO - Running setup.py install for mozhttpd 09:51:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:51:40 INFO - Running setup.py install for mozinfo 09:51:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:51:40 INFO - Running setup.py install for mozInstall 09:51:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:51:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:51:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:51:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:51:40 INFO - Running setup.py install for mozleak 09:51:41 INFO - Running setup.py install for mozlog 09:51:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:51:41 INFO - Running setup.py install for moznetwork 09:51:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:51:41 INFO - Running setup.py install for mozprocess 09:51:41 INFO - Running setup.py install for mozprofile 09:51:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:51:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:51:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:51:41 INFO - Running setup.py install for mozrunner 09:51:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:51:41 INFO - Running setup.py install for mozscreenshot 09:51:41 INFO - Running setup.py install for moztest 09:51:42 INFO - Running setup.py install for mozversion 09:51:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:51:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:51:42 INFO - Cleaning up... 09:51:42 INFO - Return code: 0 09:51:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51: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')]} 09:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:42 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 0x10fb5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9302c9e150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f939d30>, '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 0x10f860db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f92ebe8>, '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.GJrCU8BJYu/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.HVIIaSbwY8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 09:51:42 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 09:51:42 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 09:51:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GJrCU8BJYu/Render', 09:51:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:42 INFO - 'HOME': '/Users/cltbld', 09:51:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:42 INFO - 'LOGNAME': 'cltbld', 09:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:42 INFO - 'MOZ_NO_REMOTE': '1', 09:51:42 INFO - 'NO_EM_RESTART': '1', 09:51:42 INFO - 'PAGER': '/bin/cat', 09:51:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:42 INFO - 'PWD': '/builds/slave/test', 09:51:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:42 INFO - 'SHELL': '/bin/bash', 09:51:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVIIaSbwY8/Listeners', 09:51:42 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 09:51:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:42 INFO - 'USER': 'cltbld', 09:51:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:42 INFO - 'XPC_FLAGS': '0x0', 09:51:42 INFO - 'XPC_SERVICE_NAME': '0', 09:51:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:42 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-gxMCEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:42 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)) 09:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:42 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-e8HGmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:42 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-P0d3La-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:42 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)) 09:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:42 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-QZGnp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:43 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-9jIKy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:43 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)) 09:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:43 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-PrnLY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:43 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)) 09:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:43 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-XJgX8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:43 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)) 09:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:43 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-kGQvpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:43 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)) 09:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:43 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-u9JsuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:43 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)) 09:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:43 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-iXVYB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:43 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)) 09:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:43 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-DOFAAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:43 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)) 09:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:43 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-PLPnZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:43 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-4BF6zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:43 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)) 09:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:43 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-2hPXa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:44 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-JBYB79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:44 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)) 09:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:44 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-sR9Okv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:44 INFO - Running setup.py (path:/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/pip-0mMYOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:44 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)) 09:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:44 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)) 09:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:51:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:45 INFO - Downloading blessings-1.6.tar.gz 09:51:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:51:45 INFO - Installing collected packages: blessings 09:51:45 INFO - Running setup.py install for blessings 09:51:46 INFO - Successfully installed blessings 09:51:46 INFO - Cleaning up... 09:51:46 INFO - Return code: 0 09:51:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:46 INFO - Reading from file tmpfile_stdout 09:51:46 INFO - Current package versions: 09:51:46 INFO - blessings == 1.6 09:51:46 INFO - blobuploader == 1.2.4 09:51:46 INFO - docopt == 0.6.1 09:51:46 INFO - functools32 == 3.2.3-2 09:51:46 INFO - jsonschema == 2.5.1 09:51:46 INFO - manifestparser == 1.1 09:51:46 INFO - mozInstall == 1.12 09:51:46 INFO - mozcrash == 1.0 09:51:46 INFO - mozdebug == 0.1 09:51:46 INFO - mozdevice == 0.49 09:51:46 INFO - mozfile == 1.2 09:51:46 INFO - mozhttpd == 0.7 09:51:46 INFO - mozinfo == 0.9 09:51:46 INFO - mozleak == 0.1 09:51:46 INFO - mozlog == 3.4 09:51:46 INFO - moznetwork == 0.27 09:51:46 INFO - mozprocess == 0.25 09:51:46 INFO - mozprofile == 0.28 09:51:46 INFO - mozrunner == 6.13 09:51:46 INFO - mozscreenshot == 0.1 09:51:46 INFO - mozsystemmonitor == 0.3 09:51:46 INFO - moztest == 0.8 09:51:46 INFO - mozversion == 1.4 09:51:46 INFO - psutil == 3.1.1 09:51:46 INFO - requests == 1.2.3 09:51:46 INFO - wsgiref == 0.1.2 09:51:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:46 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 0x10fb5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9302c9e150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f939d30>, '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 0x10f860db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f92ebe8>, '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.GJrCU8BJYu/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.HVIIaSbwY8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 09:51:46 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 09:51:46 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 09:51:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GJrCU8BJYu/Render', 09:51:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:46 INFO - 'HOME': '/Users/cltbld', 09:51:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:46 INFO - 'LOGNAME': 'cltbld', 09:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:46 INFO - 'MOZ_NO_REMOTE': '1', 09:51:46 INFO - 'NO_EM_RESTART': '1', 09:51:46 INFO - 'PAGER': '/bin/cat', 09:51:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:46 INFO - 'PWD': '/builds/slave/test', 09:51:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:46 INFO - 'SHELL': '/bin/bash', 09:51:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVIIaSbwY8/Listeners', 09:51:46 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 09:51:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:46 INFO - 'USER': 'cltbld', 09:51:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:46 INFO - 'XPC_FLAGS': '0x0', 09:51:46 INFO - 'XPC_SERVICE_NAME': '0', 09:51:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:46 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)) 09:51:46 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)) 09:51:46 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)) 09:51:46 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)) 09:51:46 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)) 09:51:46 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)) 09:51:46 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)) 09:51:46 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)) 09:51:46 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)) 09:51:46 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)) 09:51:46 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)) 09:51:46 INFO - Cleaning up... 09:51:46 INFO - Return code: 0 09:51:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fb5bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb5e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9302c9e150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f939d30>, '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 0x10f860db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f92ebe8>, '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.GJrCU8BJYu/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.HVIIaSbwY8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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 09:51:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:51:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GJrCU8BJYu/Render', 09:51:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:46 INFO - 'HOME': '/Users/cltbld', 09:51:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:46 INFO - 'LOGNAME': 'cltbld', 09:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:46 INFO - 'MOZ_NO_REMOTE': '1', 09:51:46 INFO - 'NO_EM_RESTART': '1', 09:51:46 INFO - 'PAGER': '/bin/cat', 09:51:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:46 INFO - 'PWD': '/builds/slave/test', 09:51:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:46 INFO - 'SHELL': '/bin/bash', 09:51:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVIIaSbwY8/Listeners', 09:51:46 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 09:51:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:46 INFO - 'USER': 'cltbld', 09:51:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:46 INFO - 'XPC_FLAGS': '0x0', 09:51:46 INFO - 'XPC_SERVICE_NAME': '0', 09:51:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:51:46 INFO - Cleaning up... 09:51:46 INFO - Return code: 0 09:51:46 INFO - Running post-action listener: _resource_record_post_action 09:51:46 INFO - Running post-action listener: _start_resource_monitoring 09:51:46 INFO - Starting resource monitoring. 09:51:46 INFO - [mozharness: 2017-05-10 16:51:46.958068Z] Finished create-virtualenv step (success) 09:51:46 INFO - [mozharness: 2017-05-10 16:51:46.958998Z] Running install step. 09:51:46 INFO - Running pre-action listener: _resource_record_pre_action 09:51:46 INFO - Running main action method: install 09:51:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:47 INFO - Reading from file tmpfile_stdout 09:51:47 INFO - Detecting whether we're running mozinstall >=1.0... 09:51:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:51:47 INFO - Reading from file tmpfile_stdout 09:51:47 INFO - Output received: 09:51:47 INFO - Usage: mozinstall [options] installer 09:51:47 INFO - Options: 09:51:47 INFO - -h, --help show this help message and exit 09:51:47 INFO - -d DEST, --destination=DEST 09:51:47 INFO - Directory to install application into. [default: 09:51:47 INFO - "/builds/slave/test"] 09:51:47 INFO - --app=APP Application being installed. [default: firefox] 09:51:47 INFO - mkdir: /builds/slave/test/build/application 09:51:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:52:02 INFO - Reading from file tmpfile_stdout 09:52:02 INFO - Output received: 09:52:02 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:52:02 INFO - Running post-action listener: _resource_record_post_action 09:52:02 INFO - [mozharness: 2017-05-10 16:52:02.207886Z] Finished install step (success) 09:52:02 INFO - [mozharness: 2017-05-10 16:52:02.208009Z] Running run-tests step. 09:52:02 INFO - Running pre-action listener: _resource_record_pre_action 09:52:02 INFO - Running main action method: run_tests 09:52:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:52:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:52:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:52:02 INFO - 2017-05-10 09:52:02.222 screenresolution[1620:7377] starting screenresolution argv=screenresolution get 09:52:02 INFO - 2017-05-10 09:52:02.225 screenresolution[1620:7377] Display 0: 1600x1200x32@60 09:52:02 INFO - 2017-05-10 09:52:02.231 screenresolution[1621:7379] starting screenresolution argv=screenresolution list 09:52:02 INFO - Available Modes on Display 0 09:52:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:52:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:52:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:52:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:52:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:52:02 INFO - Intel Iris: 09:52:02 INFO - Chipset Model: Intel Iris 09:52:02 INFO - Type: GPU 09:52:02 INFO - Bus: Built-In 09:52:02 INFO - VRAM (Dynamic, Max): 1536 MB 09:52:02 INFO - Vendor: Intel (0x8086) 09:52:02 INFO - Device ID: 0x0a2e 09:52:02 INFO - Revision ID: 0x0009 09:52:02 INFO - Displays: 09:52:02 INFO - Display: 09:52:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:52:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:52:02 INFO - Display Serial Number: 1600x1200 60 09:52:02 INFO - Main Display: Yes 09:52:02 INFO - Mirror: Off 09:52:02 INFO - Online: Yes 09:52:02 INFO - Rotation: Supported 09:52:02 INFO - Return code: 0 09:52:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:52:02 INFO - Python 2.7.3 09:52:02 INFO - Return code: 0 09:52:02 INFO - grabbing minidump binary from tooltool 09:52: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')]} 09:52:02 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f939d30>, '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 0x10f860db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f92ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:52:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:52:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:52:02 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:52:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:52:02 INFO - Return code: 0 09:52:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:52:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:52:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:52:02 INFO - ENV: RUST_BACKTRACE is now 1 09:52:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:52:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:52:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0237', '--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 09:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0237 --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 09:52:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GJrCU8BJYu/Render', 09:52:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:02 INFO - 'HOME': '/Users/cltbld', 09:52:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:02 INFO - 'LOGNAME': 'cltbld', 09:52:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:52:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:02 INFO - 'MOZ_NO_REMOTE': '1', 09:52:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:52:02 INFO - 'NO_EM_RESTART': '1', 09:52:02 INFO - 'PAGER': '/bin/cat', 09:52:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:02 INFO - 'PWD': '/builds/slave/test', 09:52:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:52:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:02 INFO - 'RUST_BACKTRACE': '1', 09:52:02 INFO - 'SHELL': '/bin/bash', 09:52:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HVIIaSbwY8/Listeners', 09:52:02 INFO - 'TMPDIR': '/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/', 09:52:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:02 INFO - 'USER': 'cltbld', 09:52:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:02 INFO - 'XPC_FLAGS': '0x0', 09:52:02 INFO - 'XPC_SERVICE_NAME': '0', 09:52:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0237', '--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 09:52:02 INFO - mozversion application_buildid: 20170509092824 09:52:02 INFO - mozversion application_changeset: 4ac208f317b37f7ed2e669d5ca23064ebc979103 09:52:02 INFO - mozversion application_display_name: Firefox 09:52:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:52:02 INFO - mozversion application_name: Firefox 09:52:02 INFO - mozversion application_remotingname: firefox 09:52:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:52:02 INFO - mozversion application_vendor: Mozilla 09:52:02 INFO - mozversion application_version: 54.0 09:52:02 INFO - mozversion platform_buildid: 20170509092824 09:52:02 INFO - mozversion platform_changeset: 4ac208f317b37f7ed2e669d5ca23064ebc979103 09:52:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:52:02 INFO - mozversion platform_version: 54.0 09:52:02 INFO - using testdate: 1494435122 09:52:02 INFO - actual date: 1494435122 09:52:02 INFO - starting webserver on 'localhost:49242' 09:52:02 INFO - SUITE-START | Running 2 tests 09:52:02 INFO - TEST-START | dromaeo_css 09:52:02 INFO - operating with platform_type : mac_ 09:52:02 INFO - Initialising browser for dromaeo_css test... 09:52:02 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/tmpTqdgAk/profile http://localhost:49242/getInfo.html) 09:52:05 INFO - PROCESS | 1631 | __metrics Screen width/height:1600/1200 09:52:05 INFO - PROCESS | 1631 | colorDepth:24 09:52:05 INFO - PROCESS | 1631 | Browser inner width/height: 1024/689 09:52:05 INFO - PROCESS | 1631 | __metrics 09:52:05 INFO - PROCESS | 1631 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:52:05 INFO - PROCESS | 1631 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:52:06 INFO - TEST-INFO | 1631: exit 0 09:52:06 INFO - Browser initialized. 09:52:06 INFO - Running cycle 1/1 for dromaeo_css test... 09:52:06 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/tmpTqdgAk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:18 INFO - PROCESS | 1634 | RSS: Main: 165142528 09:52:18 INFO - PROCESS | 1634 | 09:55:21 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 09:55:24 INFO - PROCESS | 1634 | RSS: Main: 378044416 09:55:24 INFO - PROCESS | 1634 | 09:58:27 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 09:58:27 INFO - PROCESS | 1634 | RSS: Main: 304902144 09:58:27 INFO - PROCESS | 1634 | 10:01:30 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 10:01:31 INFO - PROCESS | 1634 | RSS: Main: 274018304 10:01:31 INFO - PROCESS | 1634 | 10:04:33 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 10:04:34 INFO - PROCESS | 1634 | RSS: Main: 272699392 10:04:34 INFO - PROCESS | 1634 | 10:07:37 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 10:07:38 INFO - PROCESS | 1634 | RSS: Main: 265388032 10:07:38 INFO - PROCESS | 1634 | 10:10:41 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 10:10:41 INFO - PROCESS | 1634 | RSS: Main: 470040576 10:10:41 INFO - PROCESS | 1634 | 10:10:41 INFO - PROCESS | 1634 | __start_tp_report 10:10:41 INFO - PROCESS | 1634 | _x_x_mozilla_page_load 10:10:41 INFO - PROCESS | 1634 | _x_x_mozilla_page_load_details 10:10:41 INFO - PROCESS | 1634 | |i|pagename|runs| 10:10:41 INFO - PROCESS | 1634 | |0;dojo.html;3519.085037890149;3531.8410671519778;3538.1685303953573;3549.2901419716063;3597.946030809538;6104.328523862378;6142.293636231835;6144.539159563028;6148.446639802417;6167.198264225655;4418.867433976978;6106.236720409949;6212.44088032077;6216.440520353167;6256.687165641711;5470.91793623096;5493.505584497394;5503.229547863302;5534.142207957773;5638.577106716992;5398.811041613544;5401.027814993299;5436.401995780461;5644.774209031654;5674.035413979634;5507.862303442406;5530.281063461744;5592.832215033555;5594.0769772987405;5645.491905728483;5556.222128901977;5560.360558535739;5577.6653400796085;5596.4403559644115;5600.103983362683;5423.457654234585;5522.475364840374;5538.889222215533;5549.112142057252;5557.083081291582;5970.34326224115;5979.581429299951;6000.129981152709;6162.691865406712;6192.195014648067;6407.487401007908;6449.451796597295;6469.967650161766;6477.287498375175;6481.2222533295835;6576.0793488911595;6616.735330586771;6637.070810086543;6653.3346665333565;6663.06717059612;4431.778411079433;6257.906131408033;6342.619442833353;6363.649999250039;6389.808305750835;6574.276829548746;6575.967120164464;6662.733490660319;6691.364320389555;6709.329067093252;6481.449076828428;6484.481241500669;6487;6488.448481879093;6500.057491663777;5599.832005039855;6564.474842012628;6600.73597056122;6629.834254143589;6656.600603963778;6267.2792628848265;6330.651814150174;6396.488280937514;6413.743450261937;6529.706163222666;6328.367163283635;6368.936310636927;6387.904181437282;6514.9674251629385;6566.474682025427;5210.062188806051;5275.683458992396;5279.1817268323475;5284.524392804666;5285.445028271976;4707.741074240949;4761.166795810719;4766.356541866873;4779.784909679072;4823.782929768169;5135.87160320995;6108.129596501619;6191.473724733358;6370.331115232834;6376.39424254695;6452.774152904626;6515.51133664977;6523.510736694672;6561.0814485972005;6615.272320044791;5969.611975221596;6332.620042797447;6340.873182536324;6348.047792831112;6349.873002539924;5193.454687257859;5849.239598852122;5866.7653293868625;5886;5913.674747888821;5841.620294680833;6506.902396464056;6583.210014798255;6735.0570920072205;6796.66016699173;6599.40605345502;6633.635150066792;6634.270230274762;6634.668266586747;6643.269240383651;5871;6657.968014957495;6818.284080171709;6864.965675171592;6874.9656251718425;6292.993121100602;6354.23749150105;6377.23473183221;6395.5203359747275;6554.705038273194;5404.297441332602;6405.071264666691;6435.871282574229;6444.709988050643;6449.677516124269;6465.676716164267;6480.25477070143;6484.027395890655;6499.707513162014;6511.088447617432;6464.773732919325;6466.321036291121;6475.643839588868;6476.319986401549;6481.740730370732;6131.663631601338;6342.175517182736;6351.904721429275;6359.17330747;6365.458935990493;6236.407541283571;6320.4311611955145;6321.146645202839;6422.839429014312;6473.935260647333;6135.906433916094;6188.783392581238;6204;6213.409726076015;6260.248770147611 10:10:41 INFO - PROCESS | 1634 | |1;ext.html;759.3962799574339;822.5969275055221;896.117324435431;904.3940559824921;990.4255531791562;39231.607683923154;39557.208855822864;39573.406398904;41965.950851228736;41981.160376792446;32124.51813222798;40294.798526007406;40519.392209116886;40599.188016239656;40687.38968915468;7954.960225198866;8087.514749115043;8159.510429374227;8288.129746376604;11729.296242225451;11750.11874109441;11886.108541859352;11906.702332441715;11915.165938384273;11924.344161071138;11899.286042837457;11902.821457678141;11924.224925379822;11934.462949167264;11935.70160745984;11822.99504542115;11879.940600296986;11887.88112118885;11904.107191960638;11904.880951190464;11540.596079137275;11573.36346500942;11606.593769218036;11619.419029048599;11641.6507504775;33027.6697233027;39427.02864856746;40865.795671021755;41160.588394116276;41248;4003.4395184674167;4016.819243134066;4063.085805693725;4067.735597186203;4073.124278280184;28746.425071498452;29353.972610958514;29856.40287194244;30761.923332683247;30927;3213.373392188524;3273.2307907641684;3292.7365810735323;3425.6231814500384;3431.571053618298;292936;356056;361050;361829;362229;40502;44748;45290.773546132055;51651;53050;55092.17361739577;55096.44903550913;55318.17022744662;55437.72281138649;55460.44539554633;15718.764218536731;15801.525954221392;15803.762943555856;15825.68348633044;15851.048937063813;13359.198448093146;13389.129706569041;13411.195328280335;13417.0608057437;13427.798583021262;12522.87477125217;12543.686407839878;12543.93728031354;12602.81095783564;12678.492860285669;4803.807847686124;5726.513246374105;5737.770489180386;5744.942550574441;5748.770049197985;1137.2323681514945;1173.2432580985217;1186.6440067979745;1195.1992165249303;1209.7640960012714;26965.595516067275;27217.86391068032;27576.17271481859;27619;27790.72209277922;1308.1823860087445;1314.8948084153435;1327.6723276723276;1358.3208395802098;1359.4494229836932;14301.856981430052;14394.136351818925;14459.349329280207;14582;14626.707465850623;396411.0358896432;398206;398215;399080;399166;57103.42896571064;57170.71317147351;57187.42812571821;57193.428065718814;57375.27874163782;1476.8375478697335;1494.4619936822517;1532.1266877879725;1533.7315969705035;1536.3240174323262;25157;26597.7340226603;26631.20106396811;26653.86673066622;26708.19875403741;44047.11905761931;44709.32936006028;46292;47459.76270118627;47532;439609;442691;443568;443921;444164;25135.622965655897;25449.745502545476;25553.361165971;29692;30430;37044.07389815276;39706;40032.79983600063;40191;40203.99490012773;27374.863125684245;28056.859715701292;28456.146315610564;29304.12087637289;29610.25974350572;27496.862515687295;27940.860295698392;28241.71758282391;28367.432651346444;29058.7094129056;32682.83658581787;33410.49884251787;33904.98285051453;34005.48991765175;34082.14794630055;28365;28815.991440299487;29128.854355728086;29195;29484.410311793214;19386.709199362303;22556.66165007559;23043.88478057599;23548.764512354657;23569.93935272951 10:10:41 INFO - PROCESS | 1634 | |2;jquery.html;378.37568012778917;396.13839898221363;414.66826538768976;434.25741981212127;458.6582995668228;12017.978471829894;12233.266004039753;21238.25666101683;21869.906504674742;22157.113715451404;23162.95766690499;23335.416614584603;23742.76257237427;23832.285031449042;24180.516389672197;6356.618602883818;6793.048973143764;6883.759068432606;6886.655667216644;6899;6608;6638.236602790693;6736.528443008991;6781.559198652097;6851.828704282408;5837.9124313135335;6785.1518560179975;6788.11754471918;6801.931980680204;6827.829304267383;5854.531637468992;6609.3390660933765;6807.863842723167;6884.931150688479;6885.208201056893;6571.080048793173;6586.7694630688175;6587.769428069994;6636.340914771307;6698.799036028927;25994.74005259942;27091.86454067737;27760;28117;28377.290567735767;3288.934221315584;3374.4769560718128;3425.657434256579;3465.705415039725;3547.6629720176543;15833.762493562606;17053.062081585507;17124.978927222128;17250.654986900317;17419.73870391945;2037.4295197344768;2063.1128614695676;2081.115525901501;2103.442587714257;2205.6691496275525;93603;162630;164943;169962;176122;15898.284577194054;18693.719594206097;20160.39518814438;20420.38738837837;20437.284695035603;31121;31672.208194795316;31673.04980850578;31726.524102138486;31788.682113179035;10437.634682786065;10640.680779576625;10845.566177352817;10870.130389568816;10988.505517251742;9037.864432033524;9053.139951704577;9062.320325975577;9208.539573021457;9241.306901982378;8472.279856212168;8492.70275540353;9243.861342079874;9330.620691723567;9425.717228483156;3483.7387195960405;4114.732542384735;4165.604267594574;4169.332906734908;4170.749755014648;912.2792993535033;937.2267878999852;943.5423819447562;947.5404428852002;972.6644307713827;20905.477363066046;22548.88725556362;22599.757013364422;22619.09523619037;22646.66030009551;928.8978212396631;929.7907970706672;953.5613617735919;965.6234068713208;966.2849491376331;6912.55068420551;7045.471589630695;7244.094488188976;7358.77923662291;7453.291937265951;712686;721837;724359;732164;740489;158573;159382;159704;161609;165825.02524924272;1185.2888267039707;1425.2517428349993;1444.3428240150706;1448.608875603581;1452.4843680493484;12484.687882803002;12684.619461416172;12861.421236044587;13020.47918083266;13090.934545327213;58249.12626310693;58809.70595146997;60198.78608497363;60945;61175.08237376354;76456;89272;90123;91753;92699;9289.86065209036;10087.29388942767;11812.586559470377;11825.349605771766;12000.459979301128;12726.936365318485;13433.529826456028;13575.932120339336;13733.793993089912;13946.372413241226;11708;11734.647960561197;11765.647030589096;11966.162368634112;12163.087768417581;8130;9648.324617277003;11148.498317575566;11241.718957025812;11272.267302625303;9705.854412183682;11546.364949927834;11682.299062056303;11905.28568285871;11987.220830646329;9990.500474976367;11594.942025290156;11719.179657423898;11766;12131.393430328624;11569.7107572308;11580.768384632429;11653.067754579783;11792.351420671945;11983.700407489883 10:10:41 INFO - PROCESS | 1634 | |3;mootools.html;1379.8620137986202;1411.6329754263888;1636;1656.5775727189568;1663.459375702896;8862.468251904891;9021.909780902197;9885.258605604582;10086;10088.74778130547;9377.765555861108;9802.313838031323;10338.534765935532;11067.944660276708;11075.833862492049;2416.9637455438183;2454.2391858523824;2456.6683497727845;2458.6926634170727;2461.4215659320043;2386.152915714922;2433.8052955763583;2438.6585877977095;2442;2447.412620970972;2086.6035453263908;2158.3956492182215;2162.837787165961;2164.2533326002504;2421.019487107724;1746.502246859639;2319.965200521985;2410.614301711718;2414.770596793302;2415.855048697066;2441.1455990403215;2462.101333013455;2488.278399264211;2489.265666628349;2512.2337687005456;11209.607663731811;11337.489812958436;11458.14063945199;11463.254888432226;11473.655790326304;5869.2369991901205;6057.939420605781;6060.636361818261;6071.058985857199;6074.179985701918;3378.763486555942;3445.173158441981;3509.578850537952;3601.7118630509494;3688.041109311598;1246.4827096754836;1262.8800263975;1294.4692676002887;1296.293520031585;1316.7366526694605;15519.612009699735;15879.12664803447;15879.60300992473;15889.205539723083;15895.284712187979;4800.639952003614;4916.237983112624;4988.6757360771435;4997.550220480174;5055.064813009605;12122.151449398634;12187.025037996938;12205.877941220651;12205.877941220651;12209.816852747215;5814.534837213013;5819.621724587888;5822.097574875901;5827.184194212814;5854.121881717691;4289.9571004289555;4914.0908931847725;5336.332958380202;5429.56563474921;5444.1017232156255;3865.980670096688;3971.285168669667;3991.3613821788376;4035.233305671913;4052.3111071117983;1045.9633912813167;1054.6835949215206;1054.9419781912068;1067.6209945469247;1070.9518071686794;969.6703120938914;977.2182254196614;982.3909176310733;986.2553771902311;1023.9692809215586;6578.243501997332;6658.1344425224415;6712.630805305657;6828.829279267959;6835.555688880207;885.2298500304776;909.0182602789104;991.5686676295834;1011.8886922438526;1024.5799222318963;3684.3552378333684;4149.730267532661;4274.417397208326;4280.6789490788315;4283.121959998193;11531.365774882463;12063.758724825455;13758.899288056931;14112.22382768937;14119.43522259098;13689.110207836458;13939.790903136462;14008.439662413593;14036.94722895787;14073.788893166611;10414.947925260325;10464.947675261576;10482.213833962483;10495.160387169008;10635.41505217205;6509.1863517060365;6524.771632992823;6605.867882642224;6701.363370479797;6705.195376554844;10804.351738895692;11910;12449.315287658903;12471.812922806346;12523.561675341683;12018.218815776947;12115.515379385079;12245.816312755494;12302.446389912297;12652.493900243888;9294.024127466519;9346.906530934604;9461.858072128785;9519.57161927701;9581.185599224144;10320.329178603366;10403.583856645952;10507.422091785025;10511.94744026275;10517.526711298164;9093.863592045993;9101.817963640822;9164.633414663338;9206.723798286062;9309.255259579082;8759.781005474913;8871.245944094824;8952.104789520996;8960.955195223982;9142.497162656118;7675.731349402744;7846.979892613924;8002.559859207567;8117.512949223065;8128.065272493503;5822.94177058241;5846.093855452412;5915.881682366415;6046.879062418815;6084.60450070744;5971.611845230046;6082.5438092142385;6110.633361998294;6145.539084568764;6259.78090766821 10:10:41 INFO - PROCESS | 1634 | |4;prototype.html;385.2622228432552;386.2121272603888;389.943458198561;394.45368165091355;399.70621593129044;4818.7111122216975;4953.975230123849;5025.924611130836;5032.773525191366;5037.84886453406;4354.934675979855;4716.787744551495;4759.928601070978;4792.448868380137;4947.257911313305;3303.8843640472587;3316.403047451458;3872.7869967151864;3895.922081558367;3976.045749020229;3370.270081234208;3607.8094228904397;3729.403295472725;3960.6831453483796;3963.2073585282915;3338.2822693120975;3667.889963301105;3938.2911076006308;3963.246983073221;3967.642912137907;3336.96663033369;3793.715471339661;3829.770213787168;3933.970842451325;4025;3456.2741824216946;3476.548048753671;3505.6669616386403;3506.211102501942;3508.017755028596;4837.879053023667;4851.27230915362;4853.781579828881;4877.804987755524;4936.654434189608;3670.137517683342;4275.657947364203;4553.908921821545;4565.52062033485;4646.9070618587775;5045.048646541741;5270.525652691276;5318.414974352818;5391.676499410048;5490.689808500308;3379;3708.4993525873933;3797.715171362159;3953.142023249068;3995.320795464778;4762.618990480753;4955.430125535573;5051.040302342543;5488.890222195574;5560.944390556083;4000.9199816004098;4182.137581347109;4540.318952157137;4718.433787945469;4733.266343716729;4727.069217085429;4790.760461976957;4792.592629626521;4800.639552313394;4811.9518804812205;4791;4950.554450099508;4968.950310496921;5013.674111182761;5046.697198168122;5083.8983220335385;5248.553872920845;5326.387465441524;5336.865253898472;5342.171963345688;1389.895033448411;1476.0884654372612;1605.6628108097198;1606.4297174503117;1634.2890842483557;1148.6554033789996;1254.3226657604791;1259.7087984815455;1329.7739384304691;1363.2229629111312;4101.318459431619;4763.45220299663;4906.58294045003;5125.538701516882;5197.974010129925;4698.718076915327;4852.357536879429;5294.37335425235;5344.839654810362;5491.945080549143;4618.956091959721;4707.458642256116;4998.900241946766;5083.907454499164;5126.948730512721;2586.267200975351;2861.3848022675224;2861.5135426977463;2868.670102938189;2886.898958536441;5056.873578160576;5199.350081239845;5215.843524694265;5567.916481252784;5614.775408983595;4457.150282632736;4854.233087140296;5006.874828129326;5613.933352662981;5622.887542249214;5510.834674959758;5569.860753481195;5650.547956163579;5653.717314134276;5677.37548869624;4706.8117275308605;4975.557088444455;5035.672681275705;5180.145276029413;5353.678779273256;4649.511801260955;5381.950519648787;5452.700101494456;5582.609217354746;5634.436556344497;4800.023970157176;5421.756020978986;5748.655080695172;5774.2782152230975;5802.158686990447;4141.79291035453;4164.416981622636;4463.910721785611;4466.888327791831;4503.5005571907905;4958.975205123951;5114.590832733298;5413.350397952271;5565.777368905198;5690.9430905690415;4370.868873933787;4520.095980803787;4651.488336283074;4938.30863679078;5122.515579943799;4982.352294201875;5133.537981581676;5304.99472897975;5385.4076051635075;5397.139516056496;4959.975200123977;5230;5270.49930256625;5336.371267538111;5365.9900910978395;4494.977525112354;5422.891542169214;5485.217304376014;5551.91868512963;5569.658205077083;4927.989762098689;5263.657862239095;5321.255024296679;5365.624406291522;5400.432954539717 10:10:41 INFO - PROCESS | 1634 | |5;yui.html;766.2758693035084;784.0512979295053;790.0401012769483;904.6245807989685;914.9771255718608;14227.359768810402;16613.83386166138;17459.03975281359;17503.299868005266;17560.560985975342;16004.75992860108;16136;16156.919215403936;16170;16193.35226590938;967.9274054445909;972.7324985628937;1004.1765752083295;1026.4764969865348;1036.5957276662107;1015.9441230732307;1021.7905329407454;1022.2537547590264;1022.5194158745416;1024.4672770159514;1061.644349143038;1063.1494804156644;1063.952122154501;1063.9946800265989;1066.642674703975;1058.9894101058967;1059.4861492176287;1059.6397224943519;1060.2578195263347;1063.9838953799142;783.6199443270009;784.2667106255612;784.372501998399;784.7645706288091;785.7328508307203;16557.66884662312;16944.661106777796;17362.739558906625;17398.56503587408;17661;12176.756464870741;14906.403743850233;14937.850621493755;14971.326290316962;15224.314905829264;11706.590269340617;12243.265404075695;12313.630591082281;12763.234205947672;12903.870961290455;3805.086779173006;3924.725269231155;3936.7047471439755;4067.8169482373364;4089.795510224477;120124.39937800255;121105;123079;124429;124941.37529312386;11352.14858885587;11595.942020290013;11633.243839150427;11729.4135293235;11803.055755539537;24294.663793491527;24560.508789824104;24596.139135130543;24638.87680561586;24659.89030493632;8107.108218096005;8170.836583268301;8190.058143313595;8283.627236774239;8298.04572474161;4551.590356867831;4584.518625544337;4627.838025669153;4665.253559430543;4666.323383109498;3578.98210508951;3722.0880884183007;3779.1874746928993;3791.563970143469;3798.9932667843045;591.804554799303;628.089270557684;650.6909218121355;656.8226578823691;667.172705844749;582.5194214772829;585;590.6101972697999;610.6305685060474;620.5656040771478;9023.729288121367;9202.861957070649;10111.64609238673;10898.182636302308;11047.889521104848;574.2764117212259;597.9730912108965;623.3454872383978;629.5750368501243;654.2014324926715;5046.646734728533;5260.44765299638;5261.473852614785;5264.710440925709;5266.710330931835;104666.47666761618;105586;106882.46558767157;107439;108671;52951;56245.71877140588;64261.714765704426;88618.11381886227;91118.17763644822;65317;75526.48947021029;79470;83250;85770.57114714387;9827.656032038843;11214.887851121384;11300.378479183724;11575.363355015555;11590.88409115898;52263.73868130635;53650;53884;55020.724896375265;55099.17351239654;59112.52218694567;68373.31626683868;69510.65244673744;71006.2248443793;74214.62892685502;14924.85075149278;14979;15009.249537522861;15046.322915469049;15231.771523426936;14914.85085149178;15311.46409875649;16091.75862362089;16175.757363639319;16381.706561081697;14179.929100354433;15068.623284417978;15102.697946041237;15197.31612077437;15590.9220453897;14138.50515231962;14981.40074397012;15288.847111528743;15547.455839045579;15679;13481.393337299649;13973.021888468116;14355.282235887955;14376.928115359357;14543.127412355292;9292.644944896894;9753.609855605697;9800.558974846006;9959.551820168255;10145.34055286404;10948.452577370941;11029.113134094658;11903.523859045541;12299.88130031023;12510 10:10:41 INFO - PROCESS | 1634 | __end_tp_report 10:10:41 INFO - PROCESS | 1634 | __start_cc_report 10:10:41 INFO - PROCESS | 1634 | _x_x_mozilla_cycle_collect,2611 10:10:41 INFO - PROCESS | 1634 | __end_cc_report 10:10:41 INFO - PROCESS | 1634 | __startTimestamp1494436241962__endTimestamp 10:10:41 INFO - PROCESS | 1634 | 10:10:41 INFO - PROCESS | 1634 | ------- Summary: start ------- 10:10:41 INFO - PROCESS | 1634 | Number of tests: 6 10:10:41 INFO - PROCESS | 1634 | 10:10:41 INFO - PROCESS | 1634 | [#0] dojo.html Cycles:165 Average:6045.77 Median:6330.65 stddev:683.68 (10.8%) stddev-sans-first:656.42 10:10:41 INFO - PROCESS | 1634 | Values: 3519.1 3531.8 3538.2 3549.3 3597.9 6104.3 6142.3 6144.5 6148.4 6167.2 4418.9 6106.2 6212.4 6216.4 6256.7 5470.9 5493.5 5503.2 5534.1 5638.6 5398.8 5401.0 5436.4 5644.8 5674.0 5507.9 5530.3 5592.8 5594.1 5645.5 5556.2 5560.4 5577.7 5596.4 5600.1 5423.5 5522.5 5538.9 5549.1 5557.1 5970.3 5979.6 6000.1 6162.7 6192.2 6407.5 6449.5 6470.0 6477.3 6481.2 6576.1 6616.7 6637.1 6653.3 6663.1 4431.8 6257.9 6342.6 6363.6 6389.8 6574.3 6576.0 6662.7 6691.4 6709.3 6481.4 6484.5 6487.0 6488.4 6500.1 5599.8 6564.5 6600.7 6629.8 6656.6 6267.3 6330.7 6396.5 6413.7 6529.7 6328.4 6368.9 6387.9 6515.0 6566.5 5210.1 5275.7 5279.2 5284.5 5285.4 4707.7 4761.2 4766.4 4779.8 4823.8 5135.9 6108.1 6191.5 6370.3 6376.4 6452.8 6515.5 6523.5 6561.1 6615.3 5969.6 6332.6 6340.9 6348.0 6349.9 5193.5 5849.2 5866.8 5886.0 5913.7 5841.6 6506.9 6583.2 6735.1 6796.7 6599.4 6633.6 6634.3 6634.7 6643.3 5871.0 6658.0 6818.3 6865.0 6875.0 6293.0 6354.2 6377.2 6395.5 6554.7 5404.3 6405.1 6435.9 6444.7 6449.7 6465.7 6480.3 6484.0 6499.7 6511.1 6464.8 6466.3 6475.6 6476.3 6481.7 6131.7 6342.2 6351.9 6359.2 6365.5 6236.4 6320.4 6321.1 6422.8 6473.9 6135.9 6188.8 6204.0 6213.4 6260.2 10:10:41 INFO - PROCESS | 1634 | 10:10:41 INFO - PROCESS | 1634 | [#1] ext.html Cycles:180 Average:53728.79 Median:29547.34 stddev:105353.36 (356.6%) stddev-sans-first:105573.84 10:10:41 INFO - PROCESS | 1634 | Values: 759.4 822.6 896.1 904.4 990.4 39231.6 39557.2 39573.4 41966.0 41981.2 32124.5 40294.8 40519.4 40599.2 40687.4 7955.0 8087.5 8159.5 8288.1 11729.3 11750.1 11886.1 11906.7 11915.2 11924.3 11899.3 11902.8 11924.2 11934.5 11935.7 11823.0 11879.9 11887.9 11904.1 11904.9 11540.6 11573.4 11606.6 11619.4 11641.7 33027.7 39427.0 40865.8 41160.6 41248.0 4003.4 4016.8 4063.1 4067.7 4073.1 28746.4 29354.0 29856.4 30761.9 30927.0 3213.4 3273.2 3292.7 3425.6 3431.6 292936.0 356056.0 361050.0 361829.0 362229.0 40502.0 44748.0 45290.8 51651.0 53050.0 55092.2 55096.4 55318.2 55437.7 55460.4 15718.8 15801.5 15803.8 15825.7 15851.0 13359.2 13389.1 13411.2 13417.1 13427.8 12522.9 12543.7 12543.9 12602.8 12678.5 4803.8 5726.5 5737.8 5744.9 5748.8 1137.2 1173.2 1186.6 1195.2 1209.8 26965.6 27217.9 27576.2 27619.0 27790.7 1308.2 1314.9 1327.7 1358.3 1359.4 14301.9 14394.1 14459.3 14582.0 14626.7 396411.0 398206.0 398215.0 399080.0 399166.0 57103.4 57170.7 57187.4 57193.4 57375.3 1476.8 1494.5 1532.1 1533.7 1536.3 25157.0 26597.7 26631.2 26653.9 26708.2 44047.1 44709.3 46292.0 47459.8 47532.0 439609.0 442691.0 443568.0 443921.0 444164.0 25135.6 25449.7 25553.4 29692.0 30430.0 37044.1 39706.0 40032.8 40191.0 40204.0 27374.9 28056.9 28456.1 29304.1 29610.3 27496.9 27940.9 28241.7 28367.4 29058.7 32682.8 33410.5 33905.0 34005.5 34082.1 28365.0 28816.0 29128.9 29195.0 29484.4 19386.7 22556.7 23043.9 23548.8 23569.9 10:10:41 INFO - PROCESS | 1634 | 10:10:41 INFO - PROCESS | 1634 | [#2] jquery.html Cycles:180 Average:42341.06 Median:31672.63 stddev:121714.93 (384.3%) stddev-sans-first:122015.59 10:10:41 INFO - PROCESS | 1634 | Values: 378.4 396.1 414.7 434.3 458.7 12018.0 12233.3 21238.3 21869.9 22157.1 23163.0 23335.4 23742.8 23832.3 24180.5 6356.6 6793.0 6883.8 6886.7 6899.0 6608.0 6638.2 6736.5 6781.6 6851.8 5837.9 6785.2 6788.1 6801.9 6827.8 5854.5 6609.3 6807.9 6884.9 6885.2 6571.1 6586.8 6587.8 6636.3 6698.8 25994.7 27091.9 27760.0 28117.0 28377.3 3288.9 3374.5 3425.7 3465.7 3547.7 15833.8 17053.1 17125.0 17250.7 17419.7 2037.4 2063.1 2081.1 2103.4 2205.7 93603.0 162630.0 164943.0 169962.0 176122.0 15898.3 18693.7 20160.4 20420.4 20437.3 31121.0 31672.2 31673.0 31726.5 31788.7 10437.6 10640.7 10845.6 10870.1 10988.5 9037.9 9053.1 9062.3 9208.5 9241.3 8472.3 8492.7 9243.9 9330.6 9425.7 3483.7 4114.7 4165.6 4169.3 4170.7 912.3 937.2 943.5 947.5 972.7 20905.5 22548.9 22599.8 22619.1 22646.7 928.9 929.8 953.6 965.6 966.3 6912.6 7045.5 7244.1 7358.8 7453.3 712686.0 721837.0 724359.0 732164.0 740489.0 158573.0 159382.0 159704.0 161609.0 165825.0 1185.3 1425.3 1444.3 1448.6 1452.5 12484.7 12684.6 12861.4 13020.5 13090.9 58249.1 58809.7 60198.8 60945.0 61175.1 76456.0 89272.0 90123.0 91753.0 92699.0 9289.9 10087.3 11812.6 11825.3 12000.5 12726.9 13433.5 13575.9 13733.8 13946.4 11708.0 11734.6 11765.6 11966.2 12163.1 8130.0 9648.3 11148.5 11241.7 11272.3 9705.9 11546.4 11682.3 11905.3 11987.2 9990.5 11594.9 11719.2 11766.0 12131.4 11569.7 11580.8 11653.1 11792.4 11983.7 10:10:41 INFO - PROCESS | 1634 | 10:10:41 INFO - PROCESS | 1634 | [#3] mootools.html Cycles:180 Average:6769.84 Median:2488.77 stddev:4229.74 (170.0%) stddev-sans-first:4222.21 10:10:41 INFO - PROCESS | 1634 | Values: 1379.9 1411.6 1636.0 1656.6 1663.5 8862.5 9021.9 9885.3 10086.0 10088.7 9377.8 9802.3 10338.5 11067.9 11075.8 2417.0 2454.2 2456.7 2458.7 2461.4 2386.2 2433.8 2438.7 2442.0 2447.4 2086.6 2158.4 2162.8 2164.3 2421.0 1746.5 2320.0 2410.6 2414.8 2415.9 2441.1 2462.1 2488.3 2489.3 2512.2 11209.6 11337.5 11458.1 11463.3 11473.7 5869.2 6057.9 6060.6 6071.1 6074.2 3378.8 3445.2 3509.6 3601.7 3688.0 1246.5 1262.9 1294.5 1296.3 1316.7 15519.6 15879.1 15879.6 15889.2 15895.3 4800.6 4916.2 4988.7 4997.6 5055.1 12122.2 12187.0 12205.9 12205.9 12209.8 5814.5 5819.6 5822.1 5827.2 5854.1 4290.0 4914.1 5336.3 5429.6 5444.1 3866.0 3971.3 3991.4 4035.2 4052.3 1046.0 1054.7 1054.9 1067.6 1071.0 969.7 977.2 982.4 986.3 1024.0 6578.2 6658.1 6712.6 6828.8 6835.6 885.2 909.0 991.6 1011.9 1024.6 3684.4 4149.7 4274.4 4280.7 4283.1 11531.4 12063.8 13758.9 14112.2 14119.4 13689.1 13939.8 14008.4 14036.9 14073.8 10414.9 10464.9 10482.2 10495.2 10635.4 6509.2 6524.8 6605.9 6701.4 6705.2 10804.4 11910.0 12449.3 12471.8 12523.6 12018.2 12115.5 12245.8 12302.4 12652.5 9294.0 9346.9 9461.9 9519.6 9581.2 10320.3 10403.6 10507.4 10511.9 10517.5 9093.9 9101.8 9164.6 9206.7 9309.3 8759.8 8871.2 8952.1 8961.0 9142.5 7675.7 7847.0 8002.6 8117.5 8128.1 5822.9 5846.1 5915.9 6046.9 6084.6 5971.6 6082.5 6110.6 6145.5 6259.8 10:10:41 INFO - PROCESS | 1634 | 10:10:41 INFO - PROCESS | 1634 | [#4] prototype.html Cycles:180 Average:4425.34 Median:4844.58 stddev:1240.48 (25.6%) stddev-sans-first:1206.32 10:10:41 INFO - PROCESS | 1634 | Values: 385.3 386.2 389.9 394.5 399.7 4818.7 4954.0 5025.9 5032.8 5037.8 4354.9 4716.8 4759.9 4792.4 4947.3 3303.9 3316.4 3872.8 3895.9 3976.0 3370.3 3607.8 3729.4 3960.7 3963.2 3338.3 3667.9 3938.3 3963.2 3967.6 3337.0 3793.7 3829.8 3934.0 4025.0 3456.3 3476.5 3505.7 3506.2 3508.0 4837.9 4851.3 4853.8 4877.8 4936.7 3670.1 4275.7 4553.9 4565.5 4646.9 5045.0 5270.5 5318.4 5391.7 5490.7 3379.0 3708.5 3797.7 3953.1 3995.3 4762.6 4955.4 5051.0 5488.9 5560.9 4000.9 4182.1 4540.3 4718.4 4733.3 4727.1 4790.8 4792.6 4800.6 4812.0 4791.0 4950.6 4969.0 5013.7 5046.7 5083.9 5248.6 5326.4 5336.9 5342.2 1389.9 1476.1 1605.7 1606.4 1634.3 1148.7 1254.3 1259.7 1329.8 1363.2 4101.3 4763.5 4906.6 5125.5 5198.0 4698.7 4852.4 5294.4 5344.8 5491.9 4619.0 4707.5 4998.9 5083.9 5126.9 2586.3 2861.4 2861.5 2868.7 2886.9 5056.9 5199.4 5215.8 5567.9 5614.8 4457.2 4854.2 5006.9 5613.9 5622.9 5510.8 5569.9 5650.5 5653.7 5677.4 4706.8 4975.6 5035.7 5180.1 5353.7 4649.5 5382.0 5452.7 5582.6 5634.4 4800.0 5421.8 5748.7 5774.3 5802.2 4141.8 4164.4 4463.9 4466.9 4503.5 4959.0 5114.6 5413.4 5565.8 5690.9 4370.9 4520.1 4651.5 4938.3 5122.5 4982.4 5133.5 5305.0 5385.4 5397.1 4960.0 5230.0 5270.5 5336.4 5366.0 4495.0 5422.9 5485.2 5551.9 5569.7 4928.0 5263.7 5321.3 5365.6 5400.4 10:10:41 INFO - PROCESS | 1634 | 10:10:41 INFO - PROCESS | 1634 | [#5] yui.html Cycles:180 Average:21235.44 Median:17380.65 stddev:30305.54 (174.4%) stddev-sans-first:30351.58 10:10:41 INFO - PROCESS | 1634 | Values: 766.3 784.1 790.0 904.6 915.0 14227.4 16613.8 17459.0 17503.3 17560.6 16004.8 16136.0 16156.9 16170.0 16193.4 967.9 972.7 1004.2 1026.5 1036.6 1015.9 1021.8 1022.3 1022.5 1024.5 1061.6 1063.1 1064.0 1064.0 1066.6 1059.0 1059.5 1059.6 1060.3 1064.0 783.6 784.3 784.4 784.8 785.7 16557.7 16944.7 17362.7 17398.6 17661.0 12176.8 14906.4 14937.9 14971.3 15224.3 11706.6 12243.3 12313.6 12763.2 12903.9 3805.1 3924.7 3936.7 4067.8 4089.8 120124.4 121105.0 123079.0 124429.0 124941.4 11352.1 11595.9 11633.2 11729.4 11803.1 24294.7 24560.5 24596.1 24638.9 24659.9 8107.1 8170.8 8190.1 8283.6 8298.0 4551.6 4584.5 4627.8 4665.3 4666.3 3579.0 3722.1 3779.2 3791.6 3799.0 591.8 628.1 650.7 656.8 667.2 582.5 585.0 590.6 610.6 620.6 9023.7 9202.9 10111.6 10898.2 11047.9 574.3 598.0 623.3 629.6 654.2 5046.6 5260.4 5261.5 5264.7 5266.7 104666.5 105586.0 106882.5 107439.0 108671.0 52951.0 56245.7 64261.7 88618.1 91118.2 65317.0 75526.5 79470.0 83250.0 85770.6 9827.7 11214.9 11300.4 11575.4 11590.9 52263.7 53650.0 53884.0 55020.7 55099.2 59112.5 68373.3 69510.7 71006.2 74214.6 14924.9 14979.0 15009.2 15046.3 15231.8 14914.9 15311.5 16091.8 16175.8 16381.7 14179.9 15068.6 15102.7 15197.3 15590.9 14138.5 14981.4 15288.8 15547.5 15679.0 13481.4 13973.0 14355.3 14376.9 14543.1 9292.6 9753.6 9800.6 9959.6 10145.3 10948.5 11029.1 11903.5 12299.9 12510.0 10:10:41 INFO - PROCESS | 1634 | -------- Summary: end -------- 10:10:41 INFO - PROCESS | 1634 | 10:10:42 INFO - TEST-INFO | 1634: exit 0 10:10:42 INFO - TEST-OK | dromaeo_css | took 1119712ms 10:10:42 INFO - TEST-START | kraken 10:10:42 INFO - operating with platform_type : mac_ 10:10:42 INFO - Initialising browser for kraken test... 10:10:42 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/tmpHcyVcl/profile http://localhost:49242/getInfo.html) 10:10:44 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 10:10:44 INFO - PROCESS | 1644 | colorDepth:24 10:10:44 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 10:10:44 INFO - PROCESS | 1644 | __metrics 10:10:44 INFO - PROCESS | 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:10:44 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:10:45 INFO - TEST-INFO | 1644: exit 0 10:10:45 INFO - Browser initialized. 10:10:45 INFO - Running cycle 1/1 for kraken test... 10:10:45 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/T/tmpHcyVcl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:57 INFO - PROCESS | 1646 | RSS: Main: 164749312 10:10:57 INFO - PROCESS | 1646 | 10:11:00 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 10:11:01 INFO - PROCESS | 1646 | RSS: Main: 216174592 10:11:01 INFO - PROCESS | 1646 | 10:11:03 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 10:11:04 INFO - PROCESS | 1646 | RSS: Main: 231518208 10:11:04 INFO - PROCESS | 1646 | 10:11:07 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 10:11:08 INFO - PROCESS | 1646 | RSS: Main: 328577024 10:11:08 INFO - PROCESS | 1646 | 10:11:10 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 10:11:10 INFO - PROCESS | 1646 | RSS: Main: 230256640 10:11:10 INFO - PROCESS | 1646 | 10:11:12 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:11:13 INFO - PROCESS | 1646 | RSS: Main: 231747584 10:11:13 INFO - PROCESS | 1646 | 10:11:16 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 10:11:16 INFO - PROCESS | 1646 | RSS: Main: 271937536 10:11:16 INFO - PROCESS | 1646 | 10:11:19 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 10:11:20 INFO - PROCESS | 1646 | RSS: Main: 271540224 10:11:20 INFO - PROCESS | 1646 | 10:11:23 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 10:11:24 INFO - PROCESS | 1646 | RSS: Main: 270905344 10:11:24 INFO - PROCESS | 1646 | 10:11:25 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:11:26 INFO - PROCESS | 1646 | RSS: Main: 247599104 10:11:26 INFO - PROCESS | 1646 | 10:11:28 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:11:29 INFO - PROCESS | 1646 | RSS: Main: 252911616 10:11:29 INFO - PROCESS | 1646 | 10:11:31 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:11:31 INFO - PROCESS | 1646 | RSS: Main: 255721472 10:11:31 INFO - PROCESS | 1646 | 10:11:34 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:11:35 INFO - PROCESS | 1646 | RSS: Main: 259973120 10:11:35 INFO - PROCESS | 1646 | 10:11:38 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:11:38 INFO - PROCESS | 1646 | RSS: Main: 261128192 10:11:38 INFO - PROCESS | 1646 | 10:11:40 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 10:11:40 INFO - PROCESS | 1646 | RSS: Main: 305786880 10:11:40 INFO - PROCESS | 1646 | 10:11:40 INFO - PROCESS | 1646 | __start_tp_report 10:11:40 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 10:11:40 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 10:11:40 INFO - PROCESS | 1646 | |i|pagename|runs| 10:11:40 INFO - PROCESS | 1646 | |0;ai-astar;104;115;116;115;116;131;172;151;117;114 10:11:40 INFO - PROCESS | 1646 | |1;audio-beat-detection;139;106;106;141;112;107;108;111;150;92 10:11:40 INFO - PROCESS | 1646 | |2;audio-dft;188;184;181;181;185;183;184;183;195;182 10:11:40 INFO - PROCESS | 1646 | |3;audio-fft;83;58;60;91;60;60;59;59;74;61 10:11:40 INFO - PROCESS | 1646 | |4;audio-oscillator;84;68;87;68;69;68;82;69;68;83 10:11:40 INFO - PROCESS | 1646 | |5;imaging-gaussian-blur;89;94;88;89;88;93;91;89;89;89 10:11:40 INFO - PROCESS | 1646 | |6;imaging-darkroom;94;95;94;94;95;95;96;95;107;151 10:11:40 INFO - PROCESS | 1646 | |7;imaging-desaturate;83;86;98;138;140;96;129;136;87;89 10:11:40 INFO - PROCESS | 1646 | |8;json-parse-financial;62;61;61;60;64;62;64;63;63;64 10:11:40 INFO - PROCESS | 1646 | |9;json-stringify-tinderbox;55;58;70;63;62;56;57;57;58;57 10:11:40 INFO - PROCESS | 1646 | |10;stanford-crypto-aes;83;83;84;83;80;83;80;87;85;102 10:11:40 INFO - PROCESS | 1646 | |11;stanford-crypto-ccm;136;133;129;134;132;133;133;140;160;140 10:11:40 INFO - PROCESS | 1646 | |12;stanford-crypto-pbkdf2;164;162;165;161;162;166;164;163;160;186 10:11:40 INFO - PROCESS | 1646 | |13;stanford-crypto-sha256-iterative;64;65;65;65;63;63;61;62;63;63 10:11:40 INFO - PROCESS | 1646 | __end_tp_report 10:11:40 INFO - PROCESS | 1646 | __start_cc_report 10:11:40 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,2063 10:11:40 INFO - PROCESS | 1646 | __end_cc_report 10:11:40 INFO - PROCESS | 1646 | __startTimestamp1494436300693__endTimestamp 10:11:40 INFO - PROCESS | 1646 | 10:11:40 INFO - PROCESS | 1646 | ------- Summary: start ------- 10:11:40 INFO - PROCESS | 1646 | Number of tests: 14 10:11:40 INFO - PROCESS | 1646 | 10:11:40 INFO - PROCESS | 1646 | [#0] ai-astar Cycles:10 Average:125.10 Median:116.50 stddev:20.84 (17.9%) stddev-sans-first:20.66 10:11:40 INFO - PROCESS | 1646 | Values: 104.0 115.0 116.0 115.0 116.0 131.0 172.0 151.0 117.0 114.0 10:11:40 INFO - PROCESS | 1646 | 10:11:40 INFO - PROCESS | 1646 | [#1] audio-beat-detection Cycles:10 Average:117.20 Median:125.50 stddev:19.03 (15.2%) stddev-sans-first:18.47 10:11:40 INFO - PROCESS | 1646 | Values: 139.0 106.0 106.0 141.0 112.0 107.0 108.0 111.0 150.0 92.0 10:11:40 INFO - PROCESS | 1646 | 10:11:40 INFO - PROCESS | 1646 | [#2] audio-dft Cycles:10 Average:184.60 Median:184.00 stddev:4.20 (2.3%) stddev-sans-first:4.27 10:11:40 INFO - PROCESS | 1646 | Values: 188.0 184.0 181.0 181.0 185.0 183.0 184.0 183.0 195.0 182.0 10:11:40 INFO - PROCESS | 1646 | 10:11:40 INFO - PROCESS | 1646 | [#3] audio-fft Cycles:10 Average:66.50 Median:60.50 stddev:11.88 (19.6%) stddev-sans-first:11.00 10:11:40 INFO - PROCESS | 1646 | Values: 83.0 58.0 60.0 91.0 60.0 60.0 59.0 59.0 74.0 61.0 10:11:40 INFO - PROCESS | 1646 | 10:11:40 INFO - PROCESS | 1646 | [#4] audio-oscillator Cycles:10 Average:74.60 Median:75.50 stddev:8.19 (10.9%) stddev-sans-first:7.95 10:11:40 INFO - PROCESS | 1646 | Values: 84.0 68.0 87.0 68.0 69.0 68.0 82.0 69.0 68.0 83.0 10:11:40 INFO - PROCESS | 1646 | 10:11:40 INFO - PROCESS | 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:89.90 Median:89.00 stddev:2.08 (2.3%) stddev-sans-first:2.18 10:11:40 INFO - PROCESS | 1646 | Values: 89.0 94.0 88.0 89.0 88.0 93.0 91.0 89.0 89.0 89.0 10:11:40 INFO - PROCESS | 1646 | 10:11:40 INFO - PROCESS | 1646 | [#6] imaging-darkroom Cycles:10 Average:101.60 Median:95.00 stddev:17.79 (18.7%) stddev-sans-first:18.66 10:11:40 INFO - PROCESS | 1646 | Values: 94.0 95.0 94.0 94.0 95.0 95.0 96.0 95.0 107.0 151.0 10:11:40 INFO - PROCESS | 1646 | 10:11:40 INFO - PROCESS | 1646 | [#7] imaging-desaturate Cycles:10 Average:108.20 Median:86.50 stddev:24.28 (28.1%) stddev-sans-first:23.97 10:11:40 INFO - PROCESS | 1646 | Values: 83.0 86.0 98.0 138.0 140.0 96.0 129.0 136.0 87.0 89.0 10:11:40 INFO - PROCESS | 1646 | 10:11:40 INFO - PROCESS | 1646 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:63.00 stddev:1.43 (2.3%) stddev-sans-first:1.51 10:11:40 INFO - PROCESS | 1646 | Values: 62.0 61.0 61.0 60.0 64.0 62.0 64.0 63.0 63.0 64.0 10:11:40 INFO - PROCESS | 1646 | 10:11:40 INFO - PROCESS | 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:58.00 stddev:4.52 (7.8%) stddev-sans-first:4.52 10:11:40 INFO - PROCESS | 1646 | Values: 55.0 58.0 70.0 63.0 62.0 56.0 57.0 57.0 58.0 57.0 10:11:40 INFO - PROCESS | 1646 | 10:11:40 INFO - PROCESS | 1646 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:83.00 stddev:6.32 (7.6%) stddev-sans-first:6.67 10:11:40 INFO - PROCESS | 1646 | Values: 83.0 83.0 84.0 83.0 80.0 83.0 80.0 87.0 85.0 102.0 10:11:40 INFO - PROCESS | 1646 | 10:11:40 INFO - PROCESS | 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:137.00 Median:135.00 stddev:8.78 (6.5%) stddev-sans-first:9.31 10:11:40 INFO - PROCESS | 1646 | Values: 136.0 133.0 129.0 134.0 132.0 133.0 133.0 140.0 160.0 140.0 10:11:40 INFO - PROCESS | 1646 | 10:11:40 INFO - PROCESS | 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:164.00 stddev:7.50 (4.6%) stddev-sans-first:7.94 10:11:40 INFO - PROCESS | 1646 | Values: 164.0 162.0 165.0 161.0 162.0 166.0 164.0 163.0 160.0 186.0 10:11:40 INFO - PROCESS | 1646 | 10:11:40 INFO - PROCESS | 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:1.35 (2.1%) stddev-sans-first:1.41 10:11:40 INFO - PROCESS | 1646 | Values: 64.0 65.0 65.0 65.0 63.0 63.0 61.0 62.0 63.0 63.0 10:11:40 INFO - PROCESS | 1646 | -------- Summary: end -------- 10:11:40 INFO - PROCESS | 1646 | 10:11:41 INFO - TEST-INFO | 1646: exit 0 10:11:41 INFO - TEST-OK | kraken | took 59015ms 10:11:41 INFO - SUITE-END | took 1178s 10:11:41 INFO - Completed test suite (00:19:39) 10:11:41 INFO - javascript benchmark 10:11:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7767.181126731264, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3519.085037890149, 3531.8410671519778, 3538.1685303953573, 3549.2901419716063, 3597.946030809538, 6104.328523862378, 6142.293636231835, 6144.539159563028, 6148.446639802417, 6167.198264225655, 4418.867433976978, 6106.236720409949, 6212.44088032077, 6216.440520353167, 6256.687165641711, 5470.91793623096, 5493.505584497394, 5503.229547863302, 5534.142207957773, 5638.577106716992, 5398.811041613544, 5401.027814993299, 5436.401995780461, 5644.774209031654, 5674.035413979634, 5507.862303442406, 5530.281063461744, 5592.832215033555, 5594.0769772987405, 5645.491905728483, 5556.222128901977, 5560.360558535739, 5577.6653400796085, 5596.4403559644115, 5600.103983362683, 5423.457654234585, 5522.475364840374, 5538.889222215533, 5549.112142057252, 5557.083081291582, 5970.34326224115, 5979.581429299951, 6000.129981152709, 6162.691865406712, 6192.195014648067, 6407.487401007908, 6449.451796597295, 6469.967650161766, 6477.287498375175, 6481.2222533295835, 6576.0793488911595, 6616.735330586771, 6637.070810086543, 6653.3346665333565, 6663.06717059612, 4431.778411079433, 6257.906131408033, 6342.619442833353, 6363.649999250039, 6389.808305750835, 6574.276829548746, 6575.967120164464, 6662.733490660319, 6691.364320389555, 6709.329067093252, 6481.449076828428, 6484.481241500669, 6487.0, 6488.448481879093, 6500.057491663777, 5599.832005039855, 6564.474842012628, 6600.73597056122, 6629.834254143589, 6656.600603963778, 6267.2792628848265, 6330.651814150174, 6396.488280937514, 6413.743450261937, 6529.706163222666, 6328.367163283635, 6368.936310636927, 6387.904181437282, 6514.9674251629385, 6566.474682025427, 5210.062188806051, 5275.683458992396, 5279.1817268323475, 5284.524392804666, 5285.445028271976, 4707.741074240949, 4761.166795810719, 4766.356541866873, 4779.784909679072, 4823.782929768169, 5135.87160320995, 6108.129596501619, 6191.473724733358, 6370.331115232834, 6376.39424254695, 6452.774152904626, 6515.51133664977, 6523.510736694672, 6561.0814485972005, 6615.272320044791, 5969.611975221596, 6332.620042797447, 6340.873182536324, 6348.047792831112, 6349.873002539924, 5193.454687257859, 5849.239598852122, 5866.7653293868625, 5886.0, 5913.674747888821, 5841.620294680833, 6506.902396464056, 6583.210014798255, 6735.0570920072205, 6796.66016699173, 6599.40605345502, 6633.635150066792, 6634.270230274762, 6634.668266586747, 6643.269240383651, 5871.0, 6657.968014957495, 6818.284080171709, 6864.965675171592, 6874.9656251718425, 6292.993121100602, 6354.23749150105, 6377.23473183221, 6395.5203359747275, 6554.705038273194, 5404.297441332602, 6405.071264666691, 6435.871282574229, 6444.709988050643, 6449.677516124269, 6465.676716164267, 6480.25477070143, 6484.027395890655, 6499.707513162014, 6511.088447617432, 6464.773732919325, 6466.321036291121, 6475.643839588868, 6476.319986401549, 6481.740730370732, 6131.663631601338, 6342.175517182736, 6351.904721429275, 6359.17330747, 6365.458935990493, 6236.407541283571, 6320.4311611955145, 6321.146645202839, 6422.839429014312, 6473.935260647333, 6135.906433916094, 6188.783392581238, 6204.0, 6213.409726076015, 6260.248770147611], "value": 6005.77337150834, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.3962799574339, 822.5969275055221, 896.117324435431, 904.3940559824921, 990.4255531791562, 39231.607683923154, 39557.208855822864, 39573.406398904, 41965.950851228736, 41981.160376792446, 32124.51813222798, 40294.798526007406, 40519.392209116886, 40599.188016239656, 40687.38968915468, 7954.960225198866, 8087.514749115043, 8159.510429374227, 8288.129746376604, 11729.296242225451, 11750.11874109441, 11886.108541859352, 11906.702332441715, 11915.165938384273, 11924.344161071138, 11899.286042837457, 11902.821457678141, 11924.224925379822, 11934.462949167264, 11935.70160745984, 11822.99504542115, 11879.940600296986, 11887.88112118885, 11904.107191960638, 11904.880951190464, 11540.596079137275, 11573.36346500942, 11606.593769218036, 11619.419029048599, 11641.6507504775, 33027.6697233027, 39427.02864856746, 40865.795671021755, 41160.588394116276, 41248.0, 4003.4395184674167, 4016.819243134066, 4063.085805693725, 4067.735597186203, 4073.124278280184, 28746.425071498452, 29353.972610958514, 29856.40287194244, 30761.923332683247, 30927.0, 3213.373392188524, 3273.2307907641684, 3292.7365810735323, 3425.6231814500384, 3431.571053618298, 292936.0, 356056.0, 361050.0, 361829.0, 362229.0, 40502.0, 44748.0, 45290.773546132055, 51651.0, 53050.0, 55092.17361739577, 55096.44903550913, 55318.17022744662, 55437.72281138649, 55460.44539554633, 15718.764218536731, 15801.525954221392, 15803.762943555856, 15825.68348633044, 15851.048937063813, 13359.198448093146, 13389.129706569041, 13411.195328280335, 13417.0608057437, 13427.798583021262, 12522.87477125217, 12543.686407839878, 12543.93728031354, 12602.81095783564, 12678.492860285669, 4803.807847686124, 5726.513246374105, 5737.770489180386, 5744.942550574441, 5748.770049197985, 1137.2323681514945, 1173.2432580985217, 1186.6440067979745, 1195.1992165249303, 1209.7640960012714, 26965.595516067275, 27217.86391068032, 27576.17271481859, 27619.0, 27790.72209277922, 1308.1823860087445, 1314.8948084153435, 1327.6723276723276, 1358.3208395802098, 1359.4494229836932, 14301.856981430052, 14394.136351818925, 14459.349329280207, 14582.0, 14626.707465850623, 396411.0358896432, 398206.0, 398215.0, 399080.0, 399166.0, 57103.42896571064, 57170.71317147351, 57187.42812571821, 57193.428065718814, 57375.27874163782, 1476.8375478697335, 1494.4619936822517, 1532.1266877879725, 1533.7315969705035, 1536.3240174323262, 25157.0, 26597.7340226603, 26631.20106396811, 26653.86673066622, 26708.19875403741, 44047.11905761931, 44709.32936006028, 46292.0, 47459.76270118627, 47532.0, 439609.0, 442691.0, 443568.0, 443921.0, 444164.0, 25135.622965655897, 25449.745502545476, 25553.361165971, 29692.0, 30430.0, 37044.07389815276, 39706.0, 40032.79983600063, 40191.0, 40203.99490012773, 27374.863125684245, 28056.859715701292, 28456.146315610564, 29304.12087637289, 29610.25974350572, 27496.862515687295, 27940.860295698392, 28241.71758282391, 28367.432651346444, 29058.7094129056, 32682.83658581787, 33410.49884251787, 33904.98285051453, 34005.48991765175, 34082.14794630055, 28365.0, 28815.991440299487, 29128.854355728086, 29195.0, 29484.410311793214, 19386.709199362303, 22556.66165007559, 23043.88478057599, 23548.764512354657, 23569.93935272951], "value": 19006.100879648046, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.37568012778917, 396.13839898221363, 414.66826538768976, 434.25741981212127, 458.6582995668228, 12017.978471829894, 12233.266004039753, 21238.25666101683, 21869.906504674742, 22157.113715451404, 23162.95766690499, 23335.416614584603, 23742.76257237427, 23832.285031449042, 24180.516389672197, 6356.618602883818, 6793.048973143764, 6883.759068432606, 6886.655667216644, 6899.0, 6608.0, 6638.236602790693, 6736.528443008991, 6781.559198652097, 6851.828704282408, 5837.9124313135335, 6785.1518560179975, 6788.11754471918, 6801.931980680204, 6827.829304267383, 5854.531637468992, 6609.3390660933765, 6807.863842723167, 6884.931150688479, 6885.208201056893, 6571.080048793173, 6586.7694630688175, 6587.769428069994, 6636.340914771307, 6698.799036028927, 25994.74005259942, 27091.86454067737, 27760.0, 28117.0, 28377.290567735767, 3288.934221315584, 3374.4769560718128, 3425.657434256579, 3465.705415039725, 3547.6629720176543, 15833.762493562606, 17053.062081585507, 17124.978927222128, 17250.654986900317, 17419.73870391945, 2037.4295197344768, 2063.1128614695676, 2081.115525901501, 2103.442587714257, 2205.6691496275525, 93603.0, 162630.0, 164943.0, 169962.0, 176122.0, 15898.284577194054, 18693.719594206097, 20160.39518814438, 20420.38738837837, 20437.284695035603, 31121.0, 31672.208194795316, 31673.04980850578, 31726.524102138486, 31788.682113179035, 10437.634682786065, 10640.680779576625, 10845.566177352817, 10870.130389568816, 10988.505517251742, 9037.864432033524, 9053.139951704577, 9062.320325975577, 9208.539573021457, 9241.306901982378, 8472.279856212168, 8492.70275540353, 9243.861342079874, 9330.620691723567, 9425.717228483156, 3483.7387195960405, 4114.732542384735, 4165.604267594574, 4169.332906734908, 4170.749755014648, 912.2792993535033, 937.2267878999852, 943.5423819447562, 947.5404428852002, 972.6644307713827, 20905.477363066046, 22548.88725556362, 22599.757013364422, 22619.09523619037, 22646.66030009551, 928.8978212396631, 929.7907970706672, 953.5613617735919, 965.6234068713208, 966.2849491376331, 6912.55068420551, 7045.471589630695, 7244.094488188976, 7358.77923662291, 7453.291937265951, 712686.0, 721837.0, 724359.0, 732164.0, 740489.0, 158573.0, 159382.0, 159704.0, 161609.0, 165825.02524924272, 1185.2888267039707, 1425.2517428349993, 1444.3428240150706, 1448.608875603581, 1452.4843680493484, 12484.687882803002, 12684.619461416172, 12861.421236044587, 13020.47918083266, 13090.934545327213, 58249.12626310693, 58809.70595146997, 60198.78608497363, 60945.0, 61175.08237376354, 76456.0, 89272.0, 90123.0, 91753.0, 92699.0, 9289.86065209036, 10087.29388942767, 11812.586559470377, 11825.349605771766, 12000.459979301128, 12726.936365318485, 13433.529826456028, 13575.932120339336, 13733.793993089912, 13946.372413241226, 11708.0, 11734.647960561197, 11765.647030589096, 11966.162368634112, 12163.087768417581, 8130.0, 9648.324617277003, 11148.498317575566, 11241.718957025812, 11272.267302625303, 9705.854412183682, 11546.364949927834, 11682.299062056303, 11905.28568285871, 11987.220830646329, 9990.500474976367, 11594.942025290156, 11719.179657423898, 11766.0, 12131.393430328624, 11569.7107572308, 11580.768384632429, 11653.067754579783, 11792.351420671945, 11983.700407489883], "value": 11398.755707929735, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.8620137986202, 1411.6329754263888, 1636.0, 1656.5775727189568, 1663.459375702896, 8862.468251904891, 9021.909780902197, 9885.258605604582, 10086.0, 10088.74778130547, 9377.765555861108, 9802.313838031323, 10338.534765935532, 11067.944660276708, 11075.833862492049, 2416.9637455438183, 2454.2391858523824, 2456.6683497727845, 2458.6926634170727, 2461.4215659320043, 2386.152915714922, 2433.8052955763583, 2438.6585877977095, 2442.0, 2447.412620970972, 2086.6035453263908, 2158.3956492182215, 2162.837787165961, 2164.2533326002504, 2421.019487107724, 1746.502246859639, 2319.965200521985, 2410.614301711718, 2414.770596793302, 2415.855048697066, 2441.1455990403215, 2462.101333013455, 2488.278399264211, 2489.265666628349, 2512.2337687005456, 11209.607663731811, 11337.489812958436, 11458.14063945199, 11463.254888432226, 11473.655790326304, 5869.2369991901205, 6057.939420605781, 6060.636361818261, 6071.058985857199, 6074.179985701918, 3378.763486555942, 3445.173158441981, 3509.578850537952, 3601.7118630509494, 3688.041109311598, 1246.4827096754836, 1262.8800263975, 1294.4692676002887, 1296.293520031585, 1316.7366526694605, 15519.612009699735, 15879.12664803447, 15879.60300992473, 15889.205539723083, 15895.284712187979, 4800.639952003614, 4916.237983112624, 4988.6757360771435, 4997.550220480174, 5055.064813009605, 12122.151449398634, 12187.025037996938, 12205.877941220651, 12205.877941220651, 12209.816852747215, 5814.534837213013, 5819.621724587888, 5822.097574875901, 5827.184194212814, 5854.121881717691, 4289.9571004289555, 4914.0908931847725, 5336.332958380202, 5429.56563474921, 5444.1017232156255, 3865.980670096688, 3971.285168669667, 3991.3613821788376, 4035.233305671913, 4052.3111071117983, 1045.9633912813167, 1054.6835949215206, 1054.9419781912068, 1067.6209945469247, 1070.9518071686794, 969.6703120938914, 977.2182254196614, 982.3909176310733, 986.2553771902311, 1023.9692809215586, 6578.243501997332, 6658.1344425224415, 6712.630805305657, 6828.829279267959, 6835.555688880207, 885.2298500304776, 909.0182602789104, 991.5686676295834, 1011.8886922438526, 1024.5799222318963, 3684.3552378333684, 4149.730267532661, 4274.417397208326, 4280.6789490788315, 4283.121959998193, 11531.365774882463, 12063.758724825455, 13758.899288056931, 14112.22382768937, 14119.43522259098, 13689.110207836458, 13939.790903136462, 14008.439662413593, 14036.94722895787, 14073.788893166611, 10414.947925260325, 10464.947675261576, 10482.213833962483, 10495.160387169008, 10635.41505217205, 6509.1863517060365, 6524.771632992823, 6605.867882642224, 6701.363370479797, 6705.195376554844, 10804.351738895692, 11910.0, 12449.315287658903, 12471.812922806346, 12523.561675341683, 12018.218815776947, 12115.515379385079, 12245.816312755494, 12302.446389912297, 12652.493900243888, 9294.024127466519, 9346.906530934604, 9461.858072128785, 9519.57161927701, 9581.185599224144, 10320.329178603366, 10403.583856645952, 10507.422091785025, 10511.94744026275, 10517.526711298164, 9093.863592045993, 9101.817963640822, 9164.633414663338, 9206.723798286062, 9309.255259579082, 8759.781005474913, 8871.245944094824, 8952.104789520996, 8960.955195223982, 9142.497162656118, 7675.731349402744, 7846.979892613924, 8002.559859207567, 8117.512949223065, 8128.065272493503, 5822.94177058241, 5846.093855452412, 5915.881682366415, 6046.879062418815, 6084.60450070744, 5971.611845230046, 6082.5438092142385, 6110.633361998294, 6145.539084568764, 6259.78090766821], "value": 5170.070710854298, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.2622228432552, 386.2121272603888, 389.943458198561, 394.45368165091355, 399.70621593129044, 4818.7111122216975, 4953.975230123849, 5025.924611130836, 5032.773525191366, 5037.84886453406, 4354.934675979855, 4716.787744551495, 4759.928601070978, 4792.448868380137, 4947.257911313305, 3303.8843640472587, 3316.403047451458, 3872.7869967151864, 3895.922081558367, 3976.045749020229, 3370.270081234208, 3607.8094228904397, 3729.403295472725, 3960.6831453483796, 3963.2073585282915, 3338.2822693120975, 3667.889963301105, 3938.2911076006308, 3963.246983073221, 3967.642912137907, 3336.96663033369, 3793.715471339661, 3829.770213787168, 3933.970842451325, 4025.0, 3456.2741824216946, 3476.548048753671, 3505.6669616386403, 3506.211102501942, 3508.017755028596, 4837.879053023667, 4851.27230915362, 4853.781579828881, 4877.804987755524, 4936.654434189608, 3670.137517683342, 4275.657947364203, 4553.908921821545, 4565.52062033485, 4646.9070618587775, 5045.048646541741, 5270.525652691276, 5318.414974352818, 5391.676499410048, 5490.689808500308, 3379.0, 3708.4993525873933, 3797.715171362159, 3953.142023249068, 3995.320795464778, 4762.618990480753, 4955.430125535573, 5051.040302342543, 5488.890222195574, 5560.944390556083, 4000.9199816004098, 4182.137581347109, 4540.318952157137, 4718.433787945469, 4733.266343716729, 4727.069217085429, 4790.760461976957, 4792.592629626521, 4800.639552313394, 4811.9518804812205, 4791.0, 4950.554450099508, 4968.950310496921, 5013.674111182761, 5046.697198168122, 5083.8983220335385, 5248.553872920845, 5326.387465441524, 5336.865253898472, 5342.171963345688, 1389.895033448411, 1476.0884654372612, 1605.6628108097198, 1606.4297174503117, 1634.2890842483557, 1148.6554033789996, 1254.3226657604791, 1259.7087984815455, 1329.7739384304691, 1363.2229629111312, 4101.318459431619, 4763.45220299663, 4906.58294045003, 5125.538701516882, 5197.974010129925, 4698.718076915327, 4852.357536879429, 5294.37335425235, 5344.839654810362, 5491.945080549143, 4618.956091959721, 4707.458642256116, 4998.900241946766, 5083.907454499164, 5126.948730512721, 2586.267200975351, 2861.3848022675224, 2861.5135426977463, 2868.670102938189, 2886.898958536441, 5056.873578160576, 5199.350081239845, 5215.843524694265, 5567.916481252784, 5614.775408983595, 4457.150282632736, 4854.233087140296, 5006.874828129326, 5613.933352662981, 5622.887542249214, 5510.834674959758, 5569.860753481195, 5650.547956163579, 5653.717314134276, 5677.37548869624, 4706.8117275308605, 4975.557088444455, 5035.672681275705, 5180.145276029413, 5353.678779273256, 4649.511801260955, 5381.950519648787, 5452.700101494456, 5582.609217354746, 5634.436556344497, 4800.023970157176, 5421.756020978986, 5748.655080695172, 5774.2782152230975, 5802.158686990447, 4141.79291035453, 4164.416981622636, 4463.910721785611, 4466.888327791831, 4503.5005571907905, 4958.975205123951, 5114.590832733298, 5413.350397952271, 5565.777368905198, 5690.9430905690415, 4370.868873933787, 4520.095980803787, 4651.488336283074, 4938.30863679078, 5122.515579943799, 4982.352294201875, 5133.537981581676, 5304.99472897975, 5385.4076051635075, 5397.139516056496, 4959.975200123977, 5230.0, 5270.49930256625, 5336.371267538111, 5365.9900910978395, 4494.977525112354, 5422.891542169214, 5485.217304376014, 5551.91868512963, 5569.658205077083, 4927.989762098689, 5263.657862239095, 5321.255024296679, 5365.624406291522, 5400.432954539717], "value": 4080.6141646367932, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.2758693035084, 784.0512979295053, 790.0401012769483, 904.6245807989685, 914.9771255718608, 14227.359768810402, 16613.83386166138, 17459.03975281359, 17503.299868005266, 17560.560985975342, 16004.75992860108, 16136.0, 16156.919215403936, 16170.0, 16193.35226590938, 967.9274054445909, 972.7324985628937, 1004.1765752083295, 1026.4764969865348, 1036.5957276662107, 1015.9441230732307, 1021.7905329407454, 1022.2537547590264, 1022.5194158745416, 1024.4672770159514, 1061.644349143038, 1063.1494804156644, 1063.952122154501, 1063.9946800265989, 1066.642674703975, 1058.9894101058967, 1059.4861492176287, 1059.6397224943519, 1060.2578195263347, 1063.9838953799142, 783.6199443270009, 784.2667106255612, 784.372501998399, 784.7645706288091, 785.7328508307203, 16557.66884662312, 16944.661106777796, 17362.739558906625, 17398.56503587408, 17661.0, 12176.756464870741, 14906.403743850233, 14937.850621493755, 14971.326290316962, 15224.314905829264, 11706.590269340617, 12243.265404075695, 12313.630591082281, 12763.234205947672, 12903.870961290455, 3805.086779173006, 3924.725269231155, 3936.7047471439755, 4067.8169482373364, 4089.795510224477, 120124.39937800255, 121105.0, 123079.0, 124429.0, 124941.37529312386, 11352.14858885587, 11595.942020290013, 11633.243839150427, 11729.4135293235, 11803.055755539537, 24294.663793491527, 24560.508789824104, 24596.139135130543, 24638.87680561586, 24659.89030493632, 8107.108218096005, 8170.836583268301, 8190.058143313595, 8283.627236774239, 8298.04572474161, 4551.590356867831, 4584.518625544337, 4627.838025669153, 4665.253559430543, 4666.323383109498, 3578.98210508951, 3722.0880884183007, 3779.1874746928993, 3791.563970143469, 3798.9932667843045, 591.804554799303, 628.089270557684, 650.6909218121355, 656.8226578823691, 667.172705844749, 582.5194214772829, 585.0, 590.6101972697999, 610.6305685060474, 620.5656040771478, 9023.729288121367, 9202.861957070649, 10111.64609238673, 10898.182636302308, 11047.889521104848, 574.2764117212259, 597.9730912108965, 623.3454872383978, 629.5750368501243, 654.2014324926715, 5046.646734728533, 5260.44765299638, 5261.473852614785, 5264.710440925709, 5266.710330931835, 104666.47666761618, 105586.0, 106882.46558767157, 107439.0, 108671.0, 52951.0, 56245.71877140588, 64261.714765704426, 88618.11381886227, 91118.17763644822, 65317.0, 75526.48947021029, 79470.0, 83250.0, 85770.57114714387, 9827.656032038843, 11214.887851121384, 11300.378479183724, 11575.363355015555, 11590.88409115898, 52263.73868130635, 53650.0, 53884.0, 55020.724896375265, 55099.17351239654, 59112.52218694567, 68373.31626683868, 69510.65244673744, 71006.2248443793, 74214.62892685502, 14924.85075149278, 14979.0, 15009.249537522861, 15046.322915469049, 15231.771523426936, 14914.85085149178, 15311.46409875649, 16091.75862362089, 16175.757363639319, 16381.706561081697, 14179.929100354433, 15068.623284417978, 15102.697946041237, 15197.31612077437, 15590.9220453897, 14138.50515231962, 14981.40074397012, 15288.847111528743, 15547.455839045579, 15679.0, 13481.393337299649, 13973.021888468116, 14355.282235887955, 14376.928115359357, 14543.127412355292, 9292.644944896894, 9753.609855605697, 9800.558974846006, 9959.551820168255, 10145.34055286404, 10948.452577370941, 11029.113134094658, 11903.523859045541, 12299.88130031023, 12510.0], "value": 7998.281189068357, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1440.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 116.0, 115.0, 116.0, 131.0, 172.0, 151.0, 117.0, 114.0], "value": 125.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 106.0, 106.0, 141.0, 112.0, 107.0, 108.0, 111.0, 150.0, 92.0], "value": 117.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 184.0, 181.0, 181.0, 185.0, 183.0, 184.0, 183.0, 195.0, 182.0], "value": 184.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 60.0, 91.0, 60.0, 60.0, 59.0, 59.0, 74.0, 61.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 68.0, 87.0, 68.0, 69.0, 68.0, 82.0, 69.0, 68.0, 83.0], "value": 74.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 94.0, 88.0, 89.0, 88.0, 93.0, 91.0, 89.0, 89.0, 89.0], "value": 89.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 96.0, 95.0, 107.0, 151.0], "value": 101.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 98.0, 138.0, 140.0, 96.0, 129.0, 136.0, 87.0, 89.0], "value": 108.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 60.0, 64.0, 62.0, 64.0, 63.0, 63.0, 64.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 70.0, 63.0, 62.0, 56.0, 57.0, 57.0, 58.0, 57.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 83.0, 80.0, 83.0, 80.0, 87.0, 85.0, 102.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 129.0, 134.0, 132.0, 133.0, 133.0, 140.0, 160.0, 140.0], "value": 137.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 165.0, 161.0, 162.0, 166.0, 164.0, 163.0, 160.0, 186.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 63.0, 63.0, 61.0, 62.0, 63.0, 63.0], "value": 63.4, "unit": "score"}]}]} 10:11:41 INFO - Return code: 0 10:11:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:11:42 INFO - # TBPL SUCCESS # 10:11:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:11:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:11:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:11:42 INFO - 2017-05-10 10:11:42.046 screenresolution[1650:9803] starting screenresolution argv=screenresolution get 10:11:42 INFO - 2017-05-10 10:11:42.049 screenresolution[1650:9803] Display 0: 1600x1200x32@60 10:11:42 INFO - 2017-05-10 10:11:42.055 screenresolution[1651:9806] starting screenresolution argv=screenresolution list 10:11:42 INFO - Available Modes on Display 0 10:11:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:11:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:11:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:11:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:11:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:11:42 INFO - Intel Iris: 10:11:42 INFO - Chipset Model: Intel Iris 10:11:42 INFO - Type: GPU 10:11:42 INFO - Bus: Built-In 10:11:42 INFO - VRAM (Dynamic, Max): 1536 MB 10:11:42 INFO - Vendor: Intel (0x8086) 10:11:42 INFO - Device ID: 0x0a2e 10:11:42 INFO - Revision ID: 0x0009 10:11:42 INFO - Displays: 10:11:42 INFO - Display: 10:11:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:11:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:11:42 INFO - Display Serial Number: 1600x1200 60 10:11:42 INFO - Main Display: Yes 10:11:42 INFO - Mirror: Off 10:11:42 INFO - Online: Yes 10:11:42 INFO - Rotation: Supported 10:11:42 INFO - Return code: 0 10:11:42 INFO - Running post-action listener: _resource_record_post_action 10:11:42 INFO - [mozharness: 2017-05-10 17:11:42.300570Z] Finished run-tests step (success) 10:11:42 INFO - Running post-run listener: _resource_record_post_run 10:11:42 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 38929408; Write bytes: 422663680; Read time: 254; Write time: 1386 10:11:42 INFO - TinderboxPrint: CPU usage
53.7% 10:11:42 INFO - TinderboxPrint: I/O read bytes / time
38,929,408 / 254 10:11:42 INFO - TinderboxPrint: I/O write bytes / time
422,663,680 / 1,386 10:11:42 INFO - TinderboxPrint: CPU idle
2,213.2 (46.3%) 10:11:42 INFO - TinderboxPrint: CPU system
955.9 (20.0%) 10:11:42 INFO - TinderboxPrint: CPU user
1,608.6 (33.7%) 10:11:42 INFO - TinderboxPrint: Swap in / out
160,768,000 / 0 10:11:42 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 121672192; Write bytes: 113950720; Read time: 11077; Write time: 250 10:11:42 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 36799488; Write bytes: 298567168; Read time: 232; Write time: 1100 10:11:42 INFO - Running post-run listener: _upload_blobber_files 10:11:42 INFO - Blob upload gear active. 10:11:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:11:42 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 10:11:42 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:11:42 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:11:43 INFO - (blobuploader) - INFO - Open directory for files ... 10:11:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:11:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:11:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:44 INFO - (blobuploader) - INFO - Done attempting. 10:11:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:11:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:11:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:46 INFO - (blobuploader) - INFO - Done attempting. 10:11:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:11:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:11:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:47 INFO - (blobuploader) - INFO - Done attempting. 10:11:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:11:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:11:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:49 INFO - (blobuploader) - INFO - Done attempting. 10:11:49 INFO - (blobuploader) - INFO - Iteration through files over. 10:11:49 INFO - Return code: 0 10:11:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:11:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:11:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9dbd14ce7960c1fb5886c0fb4f9860995f6e65e4f48e6ef0904fc5b17aeefdab1439bb8bcdbadc7995680240825b076e861af4c0f35c609fb88ccabec85e1aeb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1bac9c25058e817e0dc6c0cc6eb7f2daa666c1037167bb7e805720703d97eddfcda3d4e744caa966371de1c026c17f4fe12fce1af1d689388f1a2509d91fa74e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbe43e012f56bfabee5f09e842d5940c8858f02c9bdab829da7ac7ffb5413c9bcfd3dcc07c089603e7e1e31c923c9e03e2b8107f66b60e7de419bd1d7e99727e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/68c33b88743a6812fd36174831d713d1625fe39bcdfa36fa18d251ed31dd0729a999597fdac74bbbbd5eac3631c0307e8f1208223f2faf05d77af01581efdbb7"} 10:11:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:11:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:11:49 INFO - Contents: 10:11:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9dbd14ce7960c1fb5886c0fb4f9860995f6e65e4f48e6ef0904fc5b17aeefdab1439bb8bcdbadc7995680240825b076e861af4c0f35c609fb88ccabec85e1aeb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1bac9c25058e817e0dc6c0cc6eb7f2daa666c1037167bb7e805720703d97eddfcda3d4e744caa966371de1c026c17f4fe12fce1af1d689388f1a2509d91fa74e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbe43e012f56bfabee5f09e842d5940c8858f02c9bdab829da7ac7ffb5413c9bcfd3dcc07c089603e7e1e31c923c9e03e2b8107f66b60e7de419bd1d7e99727e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/68c33b88743a6812fd36174831d713d1625fe39bcdfa36fa18d251ed31dd0729a999597fdac74bbbbd5eac3631c0307e8f1208223f2faf05d77af01581efdbb7"} 10:11:49 INFO - Running post-run listener: copy_logs_to_upload_dir 10:11:49 INFO - Copying logs to upload dir... 10:11:49 INFO - mkdir: /builds/slave/test/build/upload/logs 10:11:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.441731 ========= master_lag: -0.09 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2017-05-10 10:11:49.293482) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 10:11:49.298354) ========= 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.GJrCU8BJYu/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.HVIIaSbwY8/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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-Beta/sha512/9dbd14ce7960c1fb5886c0fb4f9860995f6e65e4f48e6ef0904fc5b17aeefdab1439bb8bcdbadc7995680240825b076e861af4c0f35c609fb88ccabec85e1aeb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1bac9c25058e817e0dc6c0cc6eb7f2daa666c1037167bb7e805720703d97eddfcda3d4e744caa966371de1c026c17f4fe12fce1af1d689388f1a2509d91fa74e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbe43e012f56bfabee5f09e842d5940c8858f02c9bdab829da7ac7ffb5413c9bcfd3dcc07c089603e7e1e31c923c9e03e2b8107f66b60e7de419bd1d7e99727e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/68c33b88743a6812fd36174831d713d1625fe39bcdfa36fa18d251ed31dd0729a999597fdac74bbbbd5eac3631c0307e8f1208223f2faf05d77af01581efdbb7"} build_url:https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011015 build_url: 'https://queue.taskcluster.net/v1/task/diq9pxQVRB6jX2zUUFIpTw/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9dbd14ce7960c1fb5886c0fb4f9860995f6e65e4f48e6ef0904fc5b17aeefdab1439bb8bcdbadc7995680240825b076e861af4c0f35c609fb88ccabec85e1aeb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1bac9c25058e817e0dc6c0cc6eb7f2daa666c1037167bb7e805720703d97eddfcda3d4e744caa966371de1c026c17f4fe12fce1af1d689388f1a2509d91fa74e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbe43e012f56bfabee5f09e842d5940c8858f02c9bdab829da7ac7ffb5413c9bcfd3dcc07c089603e7e1e31c923c9e03e2b8107f66b60e7de419bd1d7e99727e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/68c33b88743a6812fd36174831d713d1625fe39bcdfa36fa18d251ed31dd0729a999597fdac74bbbbd5eac3631c0307e8f1208223f2faf05d77af01581efdbb7"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 10:11:49.336280) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 10:11:49.337016) ========= 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.GJrCU8BJYu/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.HVIIaSbwY8/Listeners TMPDIR=/var/folders/st/6ntnsvx13cz7v7n60qs4hh6000000w/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.004813 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 10:11:49.389310) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 10:11:49.390014) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 10:11:49.390654) ========= ========= Total master_lag: 0.06 =========