builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0235 starttime: 1481653980.61 results: success (0) buildid: 20161213080202 builduid: 723eacb037be4aa8b6f4430324c6278f revision: e5997b747aed3e731cfac25c14ecd889cdba40ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 10:33:00.614487) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 10:33:00.621123) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 10:33:00.621433) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 10:33:00.648295) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:33:00.648682) ========= 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.zs0TJPIMCk/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.3lxPDCsava/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-13 10:33:00-- 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% 18.0M=0.001s 2016-12-13 10:33:01 (18.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.492333 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:33:01.242882) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:33:01.243258) ========= 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.zs0TJPIMCk/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.3lxPDCsava/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.026135 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:33:01.301080) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-13 10:33:01.301431) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e5997b747aed3e731cfac25c14ecd889cdba40ef --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 e5997b747aed3e731cfac25c14ecd889cdba40ef --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zs0TJPIMCk/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.3lxPDCsava/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-13 10:33:01,404 truncating revision to first 12 chars 2016-12-13 10:33:01,404 Setting DEBUG logging. 2016-12-13 10:33:01,404 attempt 1/10 2016-12-13 10:33:01,404 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e5997b747aed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-13 10:33:02,108 unpacking tar archive at: mozilla-beta-e5997b747aed/testing/mozharness/ program finished with exit code 0 elapsedTime=0.984596 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-13 10:33:02.311985) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 10:33:02.312341) ========= script_repo_revision: e5997b747aed3e731cfac25c14ecd889cdba40ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 10:33:02.312796) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 10:33:02.313103) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 10:33:02.333313) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-12-13 10:33:02.333707) ========= /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.zs0TJPIMCk/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.3lxPDCsava/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 10:33:02 INFO - MultiFileLogger online at 20161213 10:33:02 in /builds/slave/test 10:33:02 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 10:33:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:33:02 INFO - {'append_to_log': False, 10:33:02 INFO - 'base_work_dir': '/builds/slave/test', 10:33:02 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:33:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:33:02 INFO - 'branch': 'Mozilla-Beta', 10:33:02 INFO - 'buildbot_json_path': 'buildprops.json', 10:33:02 INFO - 'config_files': ('talos/mac_config.py',), 10:33:02 INFO - 'default_actions': ('clobber', 10:33:02 INFO - 'read-buildbot-config', 10:33:02 INFO - 'download-and-extract', 10:33:02 INFO - 'populate-webroot', 10:33:02 INFO - 'create-virtualenv', 10:33:02 INFO - 'install', 10:33:02 INFO - 'run-tests'), 10:33:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:33:02 INFO - 'download_minidump_stackwalk': True, 10:33:02 INFO - 'download_symbols': 'ondemand', 10:33:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:33:02 INFO - 'tooltool.py': '/tools/tooltool.py', 10:33:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:33:02 INFO - '/tools/misc-python/virtualenv.py')}, 10:33:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:33:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:33:02 INFO - 'installer_path': 'installer.exe', 10:33:02 INFO - 'log_level': 'info', 10:33:02 INFO - 'log_name': 'talos', 10:33:02 INFO - 'log_to_console': True, 10:33:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:33:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:33:02 INFO - 'opt_config_files': (), 10:33:02 INFO - 'pip_index': False, 10:33:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:33:02 INFO - 'cmd': ('bash', 10:33:02 INFO - '-c', 10:33:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:33:02 INFO - 'enabled': True, 10:33:02 INFO - 'halt_on_failure': False, 10:33:02 INFO - 'name': 'check_screen_resolution'},), 10:33:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:33:02 INFO - 'cmd': ('bash', 10:33:02 INFO - '-c', 10:33:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:33:02 INFO - 'enabled': True, 10:33:02 INFO - 'halt_on_failure': False, 10:33:02 INFO - 'name': 'check_screen_resolution'},), 10:33:02 INFO - 'run_cmd_checks_enabled': True, 10:33:02 INFO - 'sps_profile': False, 10:33:02 INFO - 'sps_profile_interval': 0, 10:33:02 INFO - 'suite': 'dromaeojs', 10:33:02 INFO - 'system_bits': '32', 10:33:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:33:02 INFO - 'title': 't-yosemite-r7-0235', 10:33:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:33:02 INFO - 'use_talos_json': True, 10:33:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:33:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:33:02 INFO - 'work_dir': 'build'} 10:33:02 INFO - [mozharness: 2016-12-13 18:33:02.530440Z] Running clobber step. 10:33:02 INFO - Running pre-action listener: _resource_record_pre_action 10:33:02 INFO - Running main action method: clobber 10:33:02 INFO - rmtree: /builds/slave/test/build 10:33:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:33:04 INFO - Running post-action listener: _resource_record_post_action 10:33:04 INFO - [mozharness: 2016-12-13 18:33:04.939691Z] Finished clobber step (success) 10:33:04 INFO - [mozharness: 2016-12-13 18:33:04.939928Z] Running read-buildbot-config step. 10:33:04 INFO - Running pre-action listener: _resource_record_pre_action 10:33:04 INFO - Running main action method: read_buildbot_config 10:33:04 INFO - Using buildbot properties: 10:33:04 INFO - { 10:33:04 INFO - "project": "", 10:33:04 INFO - "product": "firefox", 10:33:04 INFO - "script_repo_revision": "production", 10:33:04 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 10:33:04 INFO - "repository": "", 10:33:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 10:33:04 INFO - "buildid": "20161213080202", 10:33:04 INFO - "pgo_build": "False", 10:33:04 INFO - "basedir": "/builds/slave/test", 10:33:04 INFO - "buildnumber": 82, 10:33:04 INFO - "slavename": "t-yosemite-r7-0235", 10:33:04 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 10:33:04 INFO - "platform": "yosemite_r7", 10:33:04 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:33:04 INFO - "branch": "mozilla-beta", 10:33:04 INFO - "repo_path": "releases/mozilla-beta", 10:33:04 INFO - "revision": "e5997b747aed3e731cfac25c14ecd889cdba40ef", 10:33:04 INFO - "stage_platform": "macosx64", 10:33:04 INFO - "builduid": "723eacb037be4aa8b6f4430324c6278f", 10:33:04 INFO - "slavebuilddir": "test" 10:33:04 INFO - } 10:33:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 10:33:04 INFO - Running post-action listener: _resource_record_post_action 10:33:04 INFO - [mozharness: 2016-12-13 18:33:04.945380Z] Finished read-buildbot-config step (success) 10:33:04 INFO - [mozharness: 2016-12-13 18:33:04.945590Z] Running download-and-extract step. 10:33:04 INFO - Running pre-action listener: _resource_record_pre_action 10:33:04 INFO - Running main action method: download_and_extract 10:33:04 INFO - mkdir: /builds/slave/test/build/tests 10:33:04 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')]} 10:33:04 INFO - trying https://queue.taskcluster.net/v1/task/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 10:33:04 INFO - Downloading https://queue.taskcluster.net/v1/task/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 10:33:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 10:33:05 INFO - Downloaded 1165 bytes. 10:33:05 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 10:33:05 INFO - Using the following test package requirements: 10:33:05 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 10:33:05 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:33:05 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 10:33:05 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:33:05 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 10:33:05 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:33:05 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:33:05 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 10:33:05 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 10:33:05 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:33:05 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 10:33:05 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:33:05 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 10:33:05 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:33:05 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 10:33:05 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:33:05 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 10:33:05 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 10:33:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 10:33:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 10:33:05 INFO - Fetch https://queue.taskcluster.net/v1/task/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 10:33:06 INFO - Expected file size: 16232516 10:33:13 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:33:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 10:33:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 10:33:13 INFO - Fetch https://queue.taskcluster.net/v1/task/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 10:33:14 INFO - Expected file size: 16232516 10:33:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 10:33:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 10:33:20 INFO - Fetch https://queue.taskcluster.net/v1/task/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 10:33:21 INFO - Expected file size: 14414089 10:33:21 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')]} 10:33:21 INFO - trying https://queue.taskcluster.net/v1/task/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 10:33:21 INFO - Downloading https://queue.taskcluster.net/v1/task/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 10:33:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 10:33:24 INFO - Downloaded 86075364 bytes. 10:33:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 10:33:24 INFO - mkdir: /builds/slave/test/properties 10:33:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:33:24 INFO - Writing to file /builds/slave/test/properties/build_url 10:33:24 INFO - Contents: 10:33:24 INFO - build_url:https://queue.taskcluster.net/v1/task/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 10:33:25 INFO - Running post-action listener: _resource_record_post_action 10:33:25 INFO - Running post-action listener: set_extra_try_arguments 10:33:25 INFO - [mozharness: 2016-12-13 18:33:25.896618Z] Finished download-and-extract step (success) 10:33:25 INFO - [mozharness: 2016-12-13 18:33:25.896736Z] Running populate-webroot step. 10:33:25 INFO - Running pre-action listener: _resource_record_pre_action 10:33:25 INFO - Running main action method: populate_webroot 10:33:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:33:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:33:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:33:25 INFO - '--tppagecycles', 10:33:25 INFO - '7'], 10:33:25 INFO - 'tests': ['tsvgm']}}, 10:33:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:33:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:33:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:33:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:33:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:33:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:33:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:25 INFO - 'talos_options': ['--disable-e10s'], 10:33:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:33:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:33:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:25 INFO - 'talos_options': ['--disable-e10s'], 10:33:25 INFO - 'tests': ['damp', 'tps']}, 10:33:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:25 INFO - 'tests': ['damp', 'tps']}, 10:33:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:33:25 INFO - 'tests': ['dromaeo_dom']}, 10:33:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:33:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:33:25 INFO - 'tests': ['basic_compositor_video']}, 10:33:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:33:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:33:25 INFO - 'tests': ['a11yr', 10:33:25 INFO - 'ts_paint', 10:33:25 INFO - 'tpaint', 10:33:25 INFO - 'sessionrestore', 10:33:25 INFO - 'sessionrestore_no_auto_restore', 10:33:25 INFO - 'tabpaint']}, 10:33:25 INFO - 'other-e10s': {'tests': ['a11yr', 10:33:25 INFO - 'ts_paint', 10:33:25 INFO - 'tpaint', 10:33:25 INFO - 'sessionrestore', 10:33:25 INFO - 'sessionrestore_no_auto_restore', 10:33:25 INFO - 'tabpaint']}, 10:33:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:33:25 INFO - 'ts_paint', 10:33:25 INFO - 'tpaint', 10:33:25 INFO - 'sessionrestore', 10:33:25 INFO - 'sessionrestore_no_auto_restore', 10:33:25 INFO - 'tabpaint']}, 10:33:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:33:25 INFO - 'ts_paint', 10:33:25 INFO - 'tpaint', 10:33:25 INFO - 'sessionrestore', 10:33:25 INFO - 'sessionrestore_no_auto_restore', 10:33:25 INFO - 'tabpaint']}, 10:33:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:33:25 INFO - 'tests': ['a11yr', 10:33:25 INFO - 'ts_paint', 10:33:25 INFO - 'tpaint', 10:33:25 INFO - 'sessionrestore', 10:33:25 INFO - 'sessionrestore_no_auto_restore', 10:33:25 INFO - 'tabpaint']}, 10:33:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:33:25 INFO - 'tests': ['a11yr', 10:33:25 INFO - 'ts_paint', 10:33:25 INFO - 'tpaint', 10:33:25 INFO - 'sessionrestore', 10:33:25 INFO - 'sessionrestore_no_auto_restore', 10:33:25 INFO - 'tabpaint']}, 10:33:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:33:25 INFO - 'tests': ['tsvgx', 10:33:25 INFO - 'tsvgr_opacity', 10:33:25 INFO - 'tart', 10:33:25 INFO - 'tscrollx', 10:33:25 INFO - 'cart']}, 10:33:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:33:25 INFO - 'tsvgr_opacity', 10:33:25 INFO - 'tart', 10:33:25 INFO - 'tscrollx', 10:33:25 INFO - 'cart']}, 10:33:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:25 INFO - 'talos_options': ['--disable-e10s'], 10:33:25 INFO - 'tests': ['tp5o']}, 10:33:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:25 INFO - 'tests': ['tp5o']}, 10:33:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:25 INFO - 'talos_options': ['--disable-e10s', 10:33:25 INFO - '--xperf_path', 10:33:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:33:25 INFO - 'tests': ['tp5n']}, 10:33:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:25 INFO - 'talos_options': ['--xperf_path', 10:33:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:33:25 INFO - 'tests': ['tp5n']}}, 10:33:25 INFO - 'talos.zip': {'path': '', 10:33:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:33:25 INFO - Running post-action listener: _resource_record_post_action 10:33:25 INFO - [mozharness: 2016-12-13 18:33:25.915527Z] Finished populate-webroot step (success) 10:33:25 INFO - [mozharness: 2016-12-13 18:33:25.915653Z] Running create-virtualenv step. 10:33:25 INFO - Running pre-action listener: _resource_record_pre_action 10:33:25 INFO - Running main action method: create_virtualenv 10:33:25 INFO - Creating virtualenv /builds/slave/test/build/venv 10:33:25 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 10:33:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:33:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:33:26 INFO - Using real prefix '/tools/python27' 10:33:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:33:26 INFO - Installing distribute.............................................................................................................................................................................................done. 10:33:29 INFO - Installing pip.................done. 10:33:29 INFO - Return code: 0 10:33:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101220490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101196570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81c96370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101034d30>, '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 0x100e9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10102cb20>, '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.zs0TJPIMCk/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.3lxPDCsava/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 10:33:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:33:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zs0TJPIMCk/Render', 10:33:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:29 INFO - 'HOME': '/Users/cltbld', 10:33:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:29 INFO - 'LOGNAME': 'cltbld', 10:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:29 INFO - 'MOZ_NO_REMOTE': '1', 10:33:29 INFO - 'NO_EM_RESTART': '1', 10:33:29 INFO - 'PAGER': '/bin/cat', 10:33:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:29 INFO - 'PWD': '/builds/slave/test', 10:33:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:29 INFO - 'SHELL': '/bin/bash', 10:33:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3lxPDCsava/Listeners', 10:33:29 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 10:33:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:29 INFO - 'USER': 'cltbld', 10:33:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:29 INFO - 'XPC_FLAGS': '0x0', 10:33:29 INFO - 'XPC_SERVICE_NAME': '0', 10:33:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:29 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 10:33:29 INFO - Cleaning up... 10:33:29 INFO - Return code: 0 10:33:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101220490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101196570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81c96370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101034d30>, '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 0x100e9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10102cb20>, '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.zs0TJPIMCk/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.3lxPDCsava/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 10:33:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:33:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zs0TJPIMCk/Render', 10:33:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:29 INFO - 'HOME': '/Users/cltbld', 10:33:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:29 INFO - 'LOGNAME': 'cltbld', 10:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:29 INFO - 'MOZ_NO_REMOTE': '1', 10:33:29 INFO - 'NO_EM_RESTART': '1', 10:33:29 INFO - 'PAGER': '/bin/cat', 10:33:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:29 INFO - 'PWD': '/builds/slave/test', 10:33:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:29 INFO - 'SHELL': '/bin/bash', 10:33:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3lxPDCsava/Listeners', 10:33:29 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 10:33:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:29 INFO - 'USER': 'cltbld', 10:33:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:29 INFO - 'XPC_FLAGS': '0x0', 10:33:29 INFO - 'XPC_SERVICE_NAME': '0', 10:33:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:30 INFO - Downloading/unpacking psutil>=3.1.1 10:33: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 10:33: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 10:33: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 10:33: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 10:33: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 10:33: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 10:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:33:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:33:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:33:33 INFO - Installing collected packages: psutil 10:33:33 INFO - Running setup.py install for psutil 10:33:33 INFO - building 'psutil._psutil_osx' extension 10:33:33 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 10:33:34 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 10:33:34 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 10:33:34 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 10:33:34 INFO - building 'psutil._psutil_posix' extension 10:33:34 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 10:33:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:33:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:33:34 INFO - ^ 10:33:34 INFO - 1 warning generated. 10:33:34 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 10:33:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:33:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:33:34 INFO - Successfully installed psutil 10:33:34 INFO - Cleaning up... 10:33:34 INFO - Return code: 0 10:33:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101220490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101196570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81c96370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101034d30>, '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 0x100e9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10102cb20>, '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.zs0TJPIMCk/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.3lxPDCsava/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 10:33:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:33:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:33:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zs0TJPIMCk/Render', 10:33:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:34 INFO - 'HOME': '/Users/cltbld', 10:33:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:34 INFO - 'LOGNAME': 'cltbld', 10:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:34 INFO - 'MOZ_NO_REMOTE': '1', 10:33:34 INFO - 'NO_EM_RESTART': '1', 10:33:34 INFO - 'PAGER': '/bin/cat', 10:33:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:34 INFO - 'PWD': '/builds/slave/test', 10:33:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:34 INFO - 'SHELL': '/bin/bash', 10:33:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3lxPDCsava/Listeners', 10:33:34 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 10:33:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:34 INFO - 'USER': 'cltbld', 10:33:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:34 INFO - 'XPC_FLAGS': '0x0', 10:33:34 INFO - 'XPC_SERVICE_NAME': '0', 10:33:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:33: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 10:33: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 10:33: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 10:33: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 10:33: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 10:33: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 10:33:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:33:37 INFO - Installing collected packages: mozsystemmonitor 10:33:37 INFO - Running setup.py install for mozsystemmonitor 10:33:37 INFO - Successfully installed mozsystemmonitor 10:33:37 INFO - Cleaning up... 10:33:38 INFO - Return code: 0 10:33:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101220490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101196570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81c96370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101034d30>, '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 0x100e9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10102cb20>, '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.zs0TJPIMCk/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.3lxPDCsava/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 10:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:33:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zs0TJPIMCk/Render', 10:33:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:38 INFO - 'HOME': '/Users/cltbld', 10:33:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:38 INFO - 'LOGNAME': 'cltbld', 10:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:38 INFO - 'MOZ_NO_REMOTE': '1', 10:33:38 INFO - 'NO_EM_RESTART': '1', 10:33:38 INFO - 'PAGER': '/bin/cat', 10:33:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:38 INFO - 'PWD': '/builds/slave/test', 10:33:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:38 INFO - 'SHELL': '/bin/bash', 10:33:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3lxPDCsava/Listeners', 10:33:38 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 10:33:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:38 INFO - 'USER': 'cltbld', 10:33:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:38 INFO - 'XPC_FLAGS': '0x0', 10:33:38 INFO - 'XPC_SERVICE_NAME': '0', 10:33:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:38 INFO - Downloading/unpacking jsonschema==2.5.1 10:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:33:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:41 INFO - Downloading functools32-3.2.3-2.tar.gz 10:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:33:41 INFO - warning: no files found matching '*.txt' 10:33:41 INFO - no previously-included directories found matching 'build' 10:33:41 INFO - no previously-included directories found matching 'dist' 10:33:41 INFO - no previously-included directories found matching '.git*' 10:33:41 INFO - Installing collected packages: jsonschema, functools32 10:33:41 INFO - Running setup.py install for functools32 10:33:41 INFO - warning: no files found matching '*.txt' 10:33:41 INFO - no previously-included directories found matching 'build' 10:33:41 INFO - no previously-included directories found matching 'dist' 10:33:41 INFO - no previously-included directories found matching '.git*' 10:33:41 INFO - Successfully installed jsonschema functools32 10:33:41 INFO - Cleaning up... 10:33:41 INFO - Return code: 0 10:33:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101220490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101196570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81c96370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101034d30>, '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 0x100e9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10102cb20>, '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.zs0TJPIMCk/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.3lxPDCsava/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 10:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:33:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zs0TJPIMCk/Render', 10:33:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:41 INFO - 'HOME': '/Users/cltbld', 10:33:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:41 INFO - 'LOGNAME': 'cltbld', 10:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:41 INFO - 'MOZ_NO_REMOTE': '1', 10:33:41 INFO - 'NO_EM_RESTART': '1', 10:33:41 INFO - 'PAGER': '/bin/cat', 10:33:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:41 INFO - 'PWD': '/builds/slave/test', 10:33:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:41 INFO - 'SHELL': '/bin/bash', 10:33:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3lxPDCsava/Listeners', 10:33:41 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 10:33:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:41 INFO - 'USER': 'cltbld', 10:33:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:41 INFO - 'XPC_FLAGS': '0x0', 10:33:41 INFO - 'XPC_SERVICE_NAME': '0', 10:33:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:33:41 INFO - Cleaning up... 10:33:41 INFO - Return code: 0 10:33:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101220490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101196570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81c96370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101034d30>, '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 0x100e9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10102cb20>, '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.zs0TJPIMCk/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.3lxPDCsava/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 10:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:33:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zs0TJPIMCk/Render', 10:33:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:41 INFO - 'HOME': '/Users/cltbld', 10:33:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:41 INFO - 'LOGNAME': 'cltbld', 10:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:41 INFO - 'MOZ_NO_REMOTE': '1', 10:33:41 INFO - 'NO_EM_RESTART': '1', 10:33:41 INFO - 'PAGER': '/bin/cat', 10:33:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:41 INFO - 'PWD': '/builds/slave/test', 10:33:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:41 INFO - 'SHELL': '/bin/bash', 10:33:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3lxPDCsava/Listeners', 10:33:41 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 10:33:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:41 INFO - 'USER': 'cltbld', 10:33:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:41 INFO - 'XPC_FLAGS': '0x0', 10:33:41 INFO - 'XPC_SERVICE_NAME': '0', 10:33:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:42 INFO - Downloading/unpacking blobuploader==1.2.4 10:33:42 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 10:33:42 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 10:33:42 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 10:33:42 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 10:33:42 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 10:33:42 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 10:33:44 INFO - Downloading blobuploader-1.2.4.tar.gz 10:33:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:33:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:33: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 10:33: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 10:33: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 10:33: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 10:33: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 10:33: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 10:33:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:33:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:45 INFO - Downloading docopt-0.6.1.tar.gz 10:33:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:33:45 INFO - Installing collected packages: blobuploader, requests, docopt 10:33:45 INFO - Running setup.py install for blobuploader 10:33:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:33:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:33:46 INFO - Running setup.py install for requests 10:33:46 INFO - Running setup.py install for docopt 10:33:46 INFO - Successfully installed blobuploader requests docopt 10:33:46 INFO - Cleaning up... 10:33:46 INFO - Return code: 0 10:33:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:33: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')]} 10:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33: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')]} 10:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:46 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 0x101220490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101196570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81c96370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101034d30>, '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 0x100e9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10102cb20>, '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.zs0TJPIMCk/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.3lxPDCsava/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 10:33:46 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 10:33:46 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 10:33:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zs0TJPIMCk/Render', 10:33:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:46 INFO - 'HOME': '/Users/cltbld', 10:33:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:46 INFO - 'LOGNAME': 'cltbld', 10:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:46 INFO - 'MOZ_NO_REMOTE': '1', 10:33:46 INFO - 'NO_EM_RESTART': '1', 10:33:46 INFO - 'PAGER': '/bin/cat', 10:33:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:46 INFO - 'PWD': '/builds/slave/test', 10:33:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:46 INFO - 'SHELL': '/bin/bash', 10:33:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3lxPDCsava/Listeners', 10:33:46 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 10:33:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:46 INFO - 'USER': 'cltbld', 10:33:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:46 INFO - 'XPC_FLAGS': '0x0', 10:33:46 INFO - 'XPC_SERVICE_NAME': '0', 10:33:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:33:47 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-alNJWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:33:47 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-YUycAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:33:47 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-rL4pXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:33:47 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-nhCn4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:33:47 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-7x5nje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:33:47 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-KXj92s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:33:47 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-G3qBev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:33:47 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-JBwiCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:33:47 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-NhfCZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:33:48 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-DEEKoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:33:48 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-akdNau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:33:48 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-1dsx3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:33:48 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-p_a36K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:33:48 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-UYntEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:48 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-uFj_Rj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:33:48 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-bDGP26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:33:48 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Js8Wd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:33:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:33:48 INFO - Running setup.py install for manifestparser 10:33:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:33:49 INFO - Running setup.py install for mozcrash 10:33:49 INFO - Running setup.py install for mozdebug 10:33:49 INFO - Running setup.py install for mozdevice 10:33:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:33:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:33:49 INFO - Running setup.py install for mozfile 10:33:49 INFO - Running setup.py install for mozhttpd 10:33:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:33:49 INFO - Running setup.py install for mozinfo 10:33:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:33:49 INFO - Running setup.py install for mozInstall 10:33:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:33:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:33:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:33:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:33:50 INFO - Running setup.py install for mozleak 10:33:50 INFO - Running setup.py install for mozlog 10:33:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:33:50 INFO - Running setup.py install for moznetwork 10:33:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:33:50 INFO - Running setup.py install for mozprocess 10:33:50 INFO - Running setup.py install for mozprofile 10:33:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:33:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:33:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:33:50 INFO - Running setup.py install for mozrunner 10:33:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:33:50 INFO - Running setup.py install for mozscreenshot 10:33:51 INFO - Running setup.py install for moztest 10:33:51 INFO - Running setup.py install for mozversion 10:33:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:33:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:33:51 INFO - Cleaning up... 10:33:51 INFO - Return code: 0 10:33:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:33:51 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')]} 10:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:51 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')]} 10:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:51 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 0x101220490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101196570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81c96370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101034d30>, '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 0x100e9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10102cb20>, '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.zs0TJPIMCk/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.3lxPDCsava/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 10:33:51 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 10:33:51 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 10:33:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zs0TJPIMCk/Render', 10:33:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:51 INFO - 'HOME': '/Users/cltbld', 10:33:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:51 INFO - 'LOGNAME': 'cltbld', 10:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:51 INFO - 'MOZ_NO_REMOTE': '1', 10:33:51 INFO - 'NO_EM_RESTART': '1', 10:33:51 INFO - 'PAGER': '/bin/cat', 10:33:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:51 INFO - 'PWD': '/builds/slave/test', 10:33:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:51 INFO - 'SHELL': '/bin/bash', 10:33:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3lxPDCsava/Listeners', 10:33:51 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 10:33:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:51 INFO - 'USER': 'cltbld', 10:33:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:51 INFO - 'XPC_FLAGS': '0x0', 10:33:51 INFO - 'XPC_SERVICE_NAME': '0', 10:33:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:33:51 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-ntC8RJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:33:51 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)) 10:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:33:51 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-_1WJPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:33:51 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-GTxqrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:33:52 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)) 10:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:33:52 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-dS1xXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:33:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:33:52 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Dr00_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:33:52 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)) 10:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:33:52 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-vPemjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:33:52 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)) 10:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:33:52 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-fSaOSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:33:52 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)) 10:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:33:52 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-jUYe5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:33:52 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)) 10:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:33:52 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-Mtpgr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:33:52 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)) 10:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:33:52 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-58ezwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:33:52 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)) 10:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:33:52 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-oDEI7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:33:52 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)) 10:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:33:52 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-2jGmbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:33:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:33:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:33:52 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-KXFFQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:33:53 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)) 10:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:33:53 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-h2wHeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:33:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:53 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-CA9ksd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:53 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)) 10:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:33:53 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-hrubTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:33:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:33:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:33:53 INFO - Running setup.py (path:/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/pip-m3n8Mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:33:53 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)) 10:33:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:33:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:33:53 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)) 10:33:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:33:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:33:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:33:53 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 10:33:53 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 10:33:53 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 10:33:53 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 10:33:53 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 10:33:53 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 10:33:56 INFO - Downloading blessings-1.6.tar.gz 10:33:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:33:56 INFO - Installing collected packages: blessings 10:33:56 INFO - Running setup.py install for blessings 10:33:56 INFO - Successfully installed blessings 10:33:56 INFO - Cleaning up... 10:33:56 INFO - Return code: 0 10:33:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:33:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:33:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:33:56 INFO - Reading from file tmpfile_stdout 10:33:56 INFO - Current package versions: 10:33:56 INFO - blessings == 1.6 10:33:56 INFO - blobuploader == 1.2.4 10:33:56 INFO - docopt == 0.6.1 10:33:56 INFO - functools32 == 3.2.3-2 10:33:56 INFO - jsonschema == 2.5.1 10:33:56 INFO - manifestparser == 1.1 10:33:56 INFO - mozInstall == 1.12 10:33:56 INFO - mozcrash == 0.17 10:33:56 INFO - mozdebug == 0.1 10:33:56 INFO - mozdevice == 0.48 10:33:56 INFO - mozfile == 1.2 10:33:56 INFO - mozhttpd == 0.7 10:33:56 INFO - mozinfo == 0.9 10:33:56 INFO - mozleak == 0.1 10:33:56 INFO - mozlog == 3.4 10:33:56 INFO - moznetwork == 0.27 10:33:56 INFO - mozprocess == 0.23 10:33:56 INFO - mozprofile == 0.28 10:33:56 INFO - mozrunner == 6.12 10:33:56 INFO - mozscreenshot == 0.1 10:33:56 INFO - mozsystemmonitor == 0.3 10:33:56 INFO - moztest == 0.7 10:33:56 INFO - mozversion == 1.4 10:33:56 INFO - psutil == 3.1.1 10:33:56 INFO - requests == 1.2.3 10:33:56 INFO - wsgiref == 0.1.2 10:33:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:33:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:56 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 0x101220490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101196570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81c96370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101034d30>, '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 0x100e9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10102cb20>, '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.zs0TJPIMCk/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.3lxPDCsava/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 10:33:56 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 10:33:56 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 10:33:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zs0TJPIMCk/Render', 10:33:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:56 INFO - 'HOME': '/Users/cltbld', 10:33:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:56 INFO - 'LOGNAME': 'cltbld', 10:33:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:56 INFO - 'MOZ_NO_REMOTE': '1', 10:33:56 INFO - 'NO_EM_RESTART': '1', 10:33:56 INFO - 'PAGER': '/bin/cat', 10:33:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:56 INFO - 'PWD': '/builds/slave/test', 10:33:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:56 INFO - 'SHELL': '/bin/bash', 10:33:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3lxPDCsava/Listeners', 10:33:56 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 10:33:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:56 INFO - 'USER': 'cltbld', 10:33:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:56 INFO - 'XPC_FLAGS': '0x0', 10:33:56 INFO - 'XPC_SERVICE_NAME': '0', 10:33:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:57 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)) 10:33:57 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)) 10:33:57 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)) 10:33:57 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)) 10:33:57 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)) 10:33:57 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)) 10:33:57 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)) 10:33:57 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)) 10:33:57 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)) 10:33:57 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)) 10:33:57 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)) 10:33:57 INFO - Cleaning up... 10:33:57 INFO - Return code: 0 10:33:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:33:57 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')]} 10:33:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:57 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')]} 10:33:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:57 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 0x101220490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101196570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd81c96370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101034d30>, '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 0x100e9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10102cb20>, '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.zs0TJPIMCk/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.3lxPDCsava/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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 10:33:57 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 10:33:57 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 10:33:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zs0TJPIMCk/Render', 10:33:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:57 INFO - 'HOME': '/Users/cltbld', 10:33:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:57 INFO - 'LOGNAME': 'cltbld', 10:33:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:57 INFO - 'MOZ_NO_REMOTE': '1', 10:33:57 INFO - 'NO_EM_RESTART': '1', 10:33:57 INFO - 'PAGER': '/bin/cat', 10:33:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:57 INFO - 'PWD': '/builds/slave/test', 10:33:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:57 INFO - 'SHELL': '/bin/bash', 10:33:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3lxPDCsava/Listeners', 10:33:57 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 10:33:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:57 INFO - 'USER': 'cltbld', 10:33:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:57 INFO - 'XPC_FLAGS': '0x0', 10:33:57 INFO - 'XPC_SERVICE_NAME': '0', 10:33:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:33:57 INFO - Cleaning up... 10:33:57 INFO - Return code: 0 10:33:57 INFO - Running post-action listener: _resource_record_post_action 10:33:57 INFO - Running post-action listener: _start_resource_monitoring 10:33:57 INFO - Starting resource monitoring. 10:33:57 INFO - [mozharness: 2016-12-13 18:33:57.323738Z] Finished create-virtualenv step (success) 10:33:57 INFO - [mozharness: 2016-12-13 18:33:57.324700Z] Running install step. 10:33:57 INFO - Running pre-action listener: _resource_record_pre_action 10:33:57 INFO - Running main action method: install 10:33:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:33:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:33:57 INFO - Reading from file tmpfile_stdout 10:33:57 INFO - Detecting whether we're running mozinstall >=1.0... 10:33:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:33:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:33:57 INFO - Reading from file tmpfile_stdout 10:33:57 INFO - Output received: 10:33:57 INFO - Usage: mozinstall [options] installer 10:33:57 INFO - Options: 10:33:57 INFO - -h, --help show this help message and exit 10:33:57 INFO - -d DEST, --destination=DEST 10:33:57 INFO - Directory to install application into. [default: 10:33:57 INFO - "/builds/slave/test"] 10:33:57 INFO - --app=APP Application being installed. [default: firefox] 10:33:57 INFO - mkdir: /builds/slave/test/build/application 10:33:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:33:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:34:19 INFO - Reading from file tmpfile_stdout 10:34:19 INFO - Output received: 10:34:19 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:34:19 INFO - Running post-action listener: _resource_record_post_action 10:34:19 INFO - [mozharness: 2016-12-13 18:34:19.116306Z] Finished install step (success) 10:34:19 INFO - [mozharness: 2016-12-13 18:34:19.116431Z] Running run-tests step. 10:34:19 INFO - Running pre-action listener: _resource_record_pre_action 10:34:19 INFO - Running main action method: run_tests 10:34:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:34:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:34:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:34:19 INFO - 2016-12-13 10:34:19.129 screenresolution[1668:7868] starting screenresolution argv=screenresolution get 10:34:19 INFO - 2016-12-13 10:34:19.132 screenresolution[1668:7868] Display 0: 1600x1200x32@60 10:34:19 INFO - 2016-12-13 10:34:19.138 screenresolution[1669:7870] starting screenresolution argv=screenresolution list 10:34:19 INFO - Available Modes on Display 0 10:34:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:34:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:34:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:34:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:34:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:34:19 INFO - Intel Iris: 10:34:19 INFO - Chipset Model: Intel Iris 10:34:19 INFO - Type: GPU 10:34:19 INFO - Bus: Built-In 10:34:19 INFO - VRAM (Dynamic, Max): 1536 MB 10:34:19 INFO - Vendor: Intel (0x8086) 10:34:19 INFO - Device ID: 0x0a2e 10:34:19 INFO - Revision ID: 0x0009 10:34:19 INFO - Displays: 10:34:19 INFO - Display: 10:34:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:34:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:34:19 INFO - Display Serial Number: 1600x1200 60 10:34:19 INFO - Main Display: Yes 10:34:19 INFO - Mirror: Off 10:34:19 INFO - Online: Yes 10:34:19 INFO - Rotation: Supported 10:34:19 INFO - Return code: 0 10:34:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:34:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:34:19 INFO - Python 2.7.3 10:34:19 INFO - Return code: 0 10:34:19 INFO - grabbing minidump binary from tooltool 10:34:19 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')]} 10:34:19 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 0x101034d30>, '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 0x100e9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10102cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:34:19 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 10:34:19 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 10:34:19 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 10:34:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:34:19 INFO - Return code: 0 10:34:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:34:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:34:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:34:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:34:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:34:19 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/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--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 10:34:19 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/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0235 --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 10:34:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zs0TJPIMCk/Render', 10:34:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:34:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:34:19 INFO - 'HOME': '/Users/cltbld', 10:34:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:34:19 INFO - 'LOGNAME': 'cltbld', 10:34:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:34:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:34:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:19 INFO - 'MOZ_NO_REMOTE': '1', 10:34:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:34:19 INFO - 'NO_EM_RESTART': '1', 10:34:19 INFO - 'PAGER': '/bin/cat', 10:34:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:34:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:19 INFO - 'PWD': '/builds/slave/test', 10:34:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:34:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:34:19 INFO - 'SHELL': '/bin/bash', 10:34:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3lxPDCsava/Listeners', 10:34:19 INFO - 'TMPDIR': '/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/', 10:34:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:34:19 INFO - 'USER': 'cltbld', 10:34:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:34:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:34:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:19 INFO - 'XPC_FLAGS': '0x0', 10:34:19 INFO - 'XPC_SERVICE_NAME': '0', 10:34:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:34:19 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/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0235', '--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 10:34:19 INFO - mozversion application_buildid: 20161213080202 10:34:19 INFO - mozversion application_changeset: e5997b747aed3e731cfac25c14ecd889cdba40ef 10:34:19 INFO - mozversion application_display_name: Firefox 10:34:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:34:19 INFO - mozversion application_name: Firefox 10:34:19 INFO - mozversion application_remotingname: firefox 10:34:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:34:19 INFO - mozversion application_vendor: Mozilla 10:34:19 INFO - mozversion application_version: 51.0 10:34:19 INFO - mozversion platform_buildid: 20161213080202 10:34:19 INFO - mozversion platform_changeset: e5997b747aed3e731cfac25c14ecd889cdba40ef 10:34:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:34:19 INFO - mozversion platform_version: 51.0 10:34:19 INFO - using testdate: 1481654059 10:34:19 INFO - actual date: 1481654059 10:34:19 INFO - starting webserver on 'localhost:49243' 10:34:19 INFO - SUITE-START | Running 2 tests 10:34:19 INFO - TEST-START | dromaeo_css 10:34:19 INFO - operating with platform_type : mac_ 10:34:19 INFO - Initialising browser for dromaeo_css test... 10:34:19 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpB6eObI/profile http://localhost:49243/getInfo.html) 10:34:22 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 10:34:22 INFO - PROCESS | 1679 | colorDepth:24 10:34:22 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 10:34:22 INFO - PROCESS | 1679 | __metrics 10:34:22 INFO - PROCESS | 1679 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:34:22 INFO - PROCESS | 1679 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:34:22 INFO - TEST-INFO | 1679: exit 0 10:34:22 INFO - Browser initialized. 10:34:22 INFO - Running cycle 1/1 for dromaeo_css test... 10:34:22 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpB6eObI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:34:34 INFO - PROCESS | 1684 | RSS: Main: 169238528 10:34:34 INFO - PROCESS | 1684 | 10:35:26 INFO - PROCESS | 1684 | 1481654126467 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:37:36 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 10:37:37 INFO - PROCESS | 1684 | RSS: Main: 325668864 10:37:37 INFO - PROCESS | 1684 | 10:40:40 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 10:40:41 INFO - PROCESS | 1684 | RSS: Main: 301436928 10:40:41 INFO - PROCESS | 1684 | 10:43:43 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 10:43:44 INFO - PROCESS | 1684 | RSS: Main: 270729216 10:43:44 INFO - PROCESS | 1684 | 10:46:46 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 10:46:47 INFO - PROCESS | 1684 | RSS: Main: 259305472 10:46:47 INFO - PROCESS | 1684 | 10:49:50 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 10:49:50 INFO - PROCESS | 1684 | RSS: Main: 260001792 10:49:50 INFO - PROCESS | 1684 | 10:52:53 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 10:52:54 INFO - PROCESS | 1684 | RSS: Main: 336646144 10:52:54 INFO - PROCESS | 1684 | 10:52:54 INFO - PROCESS | 1684 | __start_tp_report 10:52:54 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 10:52:54 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 10:52:54 INFO - PROCESS | 1684 | |i|pagename|runs| 10:52:54 INFO - PROCESS | 1684 | |0;dojo.html;3405.6934875861175;3416.675415835496;3434.639362866899;3459.4118999770035;3492.7555071145016;4569.908601827961;5629.380768115504;5726.1697053927255;5741.913871291928;5747.942520574793;5734.340550836655;5824.330202026768;5824.534037277018;5831.300243970719;5842.47417732404;5217.113090774558;5225.163973764198;5239.187925871496;5261.710605916673;5264.368275806909;5126.7436628168625;5138.203578445347;5165.405978312505;5314.229436731672;5321.36143662761;5179.922301165486;5190.351206099238;5199.6360254782185;5209.21861720743;5231.372235331746;5193.63644544882;5207.531322181022;5254.553362964152;5275.788968441258;5297.284866543006;5073.771680274396;5127.769250383742;5196.8960620787375;5213.348331458567;5219.530242278213;5615.410381909882;5656.8020119295625;5663.32040155184;5676.858078548028;5695.743691533891;6157.2919114301985;6223.96888015557;6254.781082662085;6256;6257.405546473078;6147.9548476759055;6196.525797251752;6272.5922815016875;6284.717187726517;6314.273858506284;4869.269609558523;5709.685967271798;5755.963926493229;5837.241158649348;5874.73563689635;6251.5905926735395;6292.46514046302;6306.054091886253;6311.747530098836;6323.494120470351;6178.876422471525;6195.690215489208;6213.409726076015;6214.347493513116;6214.440700336901;6124.473467760062;6145.985912324416;6183.96908015457;6210.161628180228;6218.347073557302;6151.415615516608;6163;6164.044573091178;6170.876582468325;6174.413430724074;5169.560587350042;6154.846128846814;6209;6247.875042499125;6259.155014073133;4922.064807686528;4946.579540739005;4962.925556116661;4994.450610432849;5002.749862506933;4454.020115574568;4513.074819661962;4519.141363140992;4520.525344838745;4596.4254468191475;5830.562707796932;5834.387389324144;5842.269716285465;5844.240248767633;5847.3275573308765;6131.540134489931;6260.686965651699;6289;6297.779577714758;6322.272938612118;5674.914876276859;5769.105788602773;5780.88438231233;5785.4214578541805;5787.189793428924;5387.434319396485;5448.945510544923;5473.233747275384;5477.780888764405;5520.53075488588;5347.866303342447;6350.396712312323;6355.491560675135;6378.617282963037;6391.9680401598625;6146.985747351637;6213.03697926822;6254.937450625435;6268.717907694256;6281.685915704105;5233.816816411408;6192.690365481798;6250.1874756281395;6297.275813281532;6331.873362532816;6231.563790534619;6245.6252624842655;6249.750009999549;6258.43674069336;6262.906056409066;6142.345304543789;6273.9372606273355;6277.30949595535;6305.432511074026;6313.43179113882;6057.333693293646;6120.751898419022;6123.173371594778;6123.632582045091;6210.937890621036;6209.96895015522;6220.875582488416;6221.09794079865;6222.191115155001;6229.626222426669;6046.213992181164;6088.086786981989;6090.451859332681;6097.603655762361;6111.511079113571;5073.543381095719;5985.371535988833;6013.458788709037;6029.3669164737075;6080.027195648852;5986;5986.580939334205;5990.760369585342;6003.759849605967;6006.519478441802 10:52:54 INFO - PROCESS | 1684 | |1;ext.html;482.5391750877912;507.340457405373;538.8006437618079;545.8253358925144;558.8770470496489;32011.51982720258;32802.50796238055;34009.659903400956;34044.31911361774;34125;35058.82470587643;35677;35753.1061723457;44052;44934;9987.201023918087;10163.644272450465;10163.695089147337;10164.186865050815;10173.287869849113;9980.750481237954;10091.596336146546;10102.989701029912;10120.746981325488;10142.036506531867;9321.300902432346;9527.190188833958;10103.545340459661;10149.39103653783;12084.274943503375;12261.632151035483;12485.687857803538;12495.562655307112;12504.31226282554;12509.06182036351;12213.633590992284;12305.815412768816;12310.076744244217;12313.507459701601;12349.5060197592;41957.790211049054;42223.36664949998;42232.73301800951;42280.15439691189;42471.78764106159;3618.6562276583945;3626.673599376069;3753.981230093832;3919.2161567686294;4050.8177132028836;32248.35503289921;32458.837705811555;32709.6729032709;32857.67142328594;33038.17404564905;3079.938401231985;3126.901932612956;3206.055994071322;3231.6929891660257;3233.692799184074;552225;552826;553073;555053;555785;59793.505162371286;60175.69912150411;60269;60291.79416411735;60412.697936510915;35701.46447803285;35792.105197369754;36309.09227269339;37749.05627359283;37816.62183378131;17665;17731.468055958343;17892.821071789116;17895;17913.37303194382;13461.663458413617;13563;13617.25105119228;13620.978426617845;13633.590992270249;19393.32123375675;19570.70643940342;19625.607487850448;19654.90172549128;19707.60584788325;5423.83728488146;6745.494087943326;8000.959995199987;8041.437099402986;8127;901.3600343756007;962.3311798300114;1057.7778666479971;1070.7269646240159;1152.6369193703956;24163.7583624165;31236.531452028237;32661.346773064404;32732.018039458853;32768.50847237293;976.7448828255657;1034.255336157965;1045.137761346892;1047.3349423116224;1113.6937342230951;15676.529704108894;15890.682186356207;15940;16012.839871601367;16226.67546649084;723372;727754;730643;731112;733790;58261.41738582645;58346.41653583495;58420.415795842346;58507;58522;1291.9741605167844;1331.3276795218353;1411.985880141206;1434.12518363798;1445.898787084894;30762.84618576893;30954;31828.840855795574;31841;32547;50427;50875.49124508855;50932.981340372244;50942.98114037624;50993.74503127461;569917;574885;576515;579064;580504;23963.640545391485;24447.022119115038;26120.216393508224;26257;26667.466650667266;43971.34042989294;46501.03395570566;46969.765151174026;47342.28986565136;47449.76275118603;37986.151038671655;39228.0192995166;39358.01604959899;39633;40682.9829254271;33852.83073584616;34359;34472.482912755826;34794;34926.30147397089;38208.617913820504;38413.80793096017;38541.4218786724;38973.41539876848;39110.41334379929;32621.510677340335;34327.36450901298;34419.79530716413;34923.65076349204;34985;25865;26026.609600855623;26089.739102609492;26165.850840806866;26233.868830655723 10:52:54 INFO - PROCESS | 1684 | |2;jquery.html;334.5049326996046;392.24101363860916;399.2494111071186;408.9407035979785;418.88061902357833;20048;20558.38324850253;22124.778752212475;22991.770082299194;23318.766812331873;19955;22126.336209913687;22300.776992230072;22318.21886233982;22403.43991400216;5691.146328050794;6207.968960155193;6270.686465676721;6271.686415679221;6292.685365731718;4120.155368149537;4530.501644819067;6173.536984726141;6216.564840461147;6646.435053020499;6849.589024658511;6976.337247961435;6987.35797087684;6995.510314278003;7005.124359455068;6671.666416679171;6935.687894044755;6974.825629359256;6990.405815505688;6995.090638217;6044.788432404889;6054.878902421927;6112.602680825732;6126;6129.325774164839;27973.86013069942;28038.859805700842;28057.438851223065;28148.718512814816;28446.573301400495;2141.100737690174;2443.9511209775883;2502.649629051934;2598.454324591838;3080.722734953865;10461.424621645807;10652;15263.618409539738;15350.07899526032;15448.15035173065;1826.6985947318676;1848.279171123263;1897.2221389230488;1907.4945139538033;1927.5470264487835;135577;136980;138864.99999999898;139011;142515.73647712969;10818.67543973682;11032.393218373067;11367.147463940237;11856.110791690486;11864.406779661154;15154.545363639108;15213.771793423108;15224.314905829264;15225.086494810346;15244.695106097815;8963;9073.80679838755;9107.271418286653;9185.954070229605;9261.814763704688;9270;9276.62893484253;9299.907000929905;9444.0555944405;9449.858252126223;4498.325251212279;4612.400387949545;4632.444106707217;4670.929936050962;4727;1489.6797188604503;1657.0637589761745;1827.1626957585909;1893.9905300473686;1906.979765825277;720.4308596208937;840.7183593496247;964.9951750241204;983.8179936711588;1015.939043657383;21411.785882141292;21982.780172198392;22822.42943926415;22895.542089158458;22970.65544016841;969.60730903984;977.7653363192783;985.4186030242191;1016.2987538598344;1022.5091955861228;9603.567839447242;11295.322280663022;11927.761444771057;12144.33206173669;12146.63560093181;618569;625728;634284;646746;647267;114724.42637786758;116280;116400;117856;121286;955.0974329258922;1026.3328836256494;1057.0697785948316;1061.1722856172198;1062.8405739139191;19112.617747645247;19535.8046419534;19831.504212394804;19866.00669966525;19943.202271908962;54333;55016.44983550113;56587;57231;57562.7121864388;79887.60056199682;79923;83356.58321708352;85996.28007439691;87031.56484217792;6904.689288982108;8015.719449819228;8383.748487545383;8587.484750914966;8672.609732562176;10941.835872461761;11405.372704501333;13590.660233494242;13610.523631672844;14043.50847720325;7862.606869656609;11699.649010529358;11718.23831450953;11738.882611173778;12053.276803391824;5477.67133971963;7774.183710710294;11517.308961462339;11709.590164344549;11933.52265909354;11788.70528236801;11795.941020295188;11880.82178767302;12164.878351216728;12256.693582660504;8432;8454.196851299117;8485.490870547786;8753.730709047026;8839.734807955772;11468.139889508153;11785.764284714429;11787.882121178678;12074.27554346742;12100.03199744036 10:52:54 INFO - PROCESS | 1684 | |3;mootools.html;1504.8344682084971;1550.7751376050473;1736.2360561353003;1907.1799126375654;1930.2568511123213;8213.342932565396;8490.193431623986;8686.044535101133;9220.354575179741;9270.536473176347;8591.226789588936;8915.242204412616;8919.420237684546;9025.142611451902;9031.412958157714;2427.8421902576365;2455.177515532299;2459.5449841779237;2464.470138920132;2474.3195621204222;2088.6449303618347;2391.0738527701023;2447.779699827015;2452.5953217719143;2454.5704501712216;2404.7715467030603;2415.5531226723024;2427.2960841355984;2433.2335314376005;2436.1473484280536;2405.302462285935;2421.9394515137087;2426.5632186206476;2433.2578563538113;2434;2040.2349119080345;2416.9154079607306;2424.9757502424927;2429.5626787178303;2430.1251549442186;9041.77395565116;9066.365354425126;9149.81700365989;9197.448153110834;9212.355135140542;5422.6475279106735;5568.220449137124;5573.052581061229;5574.080276754371;5582.134769110794;3476.5132881396626;3525.894223173309;3544.3620148373284;3583.283343331344;3590.174259920207;1054.4253381906879;1057.5981127171704;1064.7231719752842;1075.5052675769155;1085.039739830248;11981.28112313264;12122.757544849143;12126.211796233216;12148.757024859542;12322.383880806014;4779.761011949388;4791.065742180242;4805.879853003633;4913.533214344631;4955.752212389438;10310.845337319946;10320.638777642896;10320.96790320962;10343.94828025855;10350.016748408889;5519.227308176858;5526.944730552643;5530.336359636869;5533.363663178706;5534.335879694462;4578.496365399803;4727;4931.950680493149;5067.873303167376;5069.670471419346;3779.263043706451;4094;4161.585061079248;4192.11965487245;4196.223698615766;1298.9740205195844;1316.4997301025548;1317.7693903567028;1330.813686083949;1335.4057444437133;901.8411341426366;934.5887809363858;952.4618590496348;955.961761529531;1001.9398836069859;5907.793227237112;6019.488343490765;6027.9095813562835;6034.125051867454;6198.008318668992;446.93519439681063;454.4160753431824;457.36198003784534;458.3239721410959;460.0201570654551;4044.4539987101366;4055.351143817034;4078.7756673382655;4105.486814148231;4110.568390318974;10549.578016879239;11128.610498632508;11135.554577816958;11160.720981975515;11219.831702524469;11040.944795275973;11051.392173430539;11079.058280046125;11098.389588572545;11102.389368584805;8022.79943001418;8369.451651444502;8395.664173433117;8503.404761666749;8586.656533738706;6081.543884208613;6142.815715528542;6204;6221.782237621843;6256.5307601930945;10193.796124077626;10491.108255798343;10499.055085042382;10504.264701470824;10512.684619461428;10052.748681283027;10425.270231083752;10472.633457829244;10617.256792024484;10633;6889.689963951734;7154.962530433162;7179.353858152583;7353.632318384166;7522.661480233293;6651.900221496585;8548.401611887357;8640.438371506083;8781.385303028726;8786.516741579275;7651.4261430391825;7710.460267781202;7751;7877.527348359117;7926;7505.774826755206;7649.88525172134;7685.846283074419;7724.266194711493;7826.608669566613;7115.644217789193;7259.382952449101;7273.454490913308;7274.745383911538;7279.053723015974;4836.46798852133;5054.2923990642075;5077.898442031064;5125.410577783454;5318.946810532;5019.974900125476;5145.7941682333785;5169.06956747774;5197.350331208599;5199.584033277404 10:52:54 INFO - PROCESS | 1684 | |4;prototype.html;309.7011384014426;316.49361022364207;319.359683833913;322.3568979885128;323.30166839626384;4175.6450701690355;4701.670883038189;4845.854624361266;5249.396319423272;5256.185291279849;4518.209313370164;4667.486576476585;5199.350081239845;5207.244949482323;5242.370915490137;3763.8870833875026;3949.34835752102;3959.3766555712164;3961.6434520893113;3978.124812541251;2998.5202367621187;3811.913604622683;3976.5742896832908;4003.7397569158056;4067.959320406788;3932.705047121463;3943.5267767867895;3964;3966.266240745457;4001.899952501182;3863.613638636114;3979.6668116181113;3981.9004524886964;4010.197960407901;4019.5980401959864;3264.020793761862;3485.721142308609;3489.8953031409096;3502.807345595991;3523.4538646509577;4941.382327209099;5028.974855125701;5042.823501177478;5073.188289873602;5119.488051194888;3819.2934307152987;4397.956020439787;4605.37827393301;4623.491415944243;4656.627469802408;4956.603471722289;5001.924971125436;5003.921803729985;5564.972175139098;5593.776248950037;3908.081600823804;3924.4309575111733;3945.309570825094;3946.4869566956113;3969.4442778011103;4804.741771367487;5515.283013208257;5803.564732645026;5829.921464529076;5892.263467066617;3310.4372256716415;3884.6309600587897;3946.625070618287;3952.596828126031;3953.940690889639;4022.1955608878343;4043.3732771420478;4056.8985775355854;4057.2899742544937;4074.633283004544;4168.6039826216465;4549.931751023737;4615;4624.849445008087;4656.95343046572;5400;5554.1391084381985;5570.108782594846;5587.7485513152005;5676.744546495418;1147.9540818367338;1364.597443754095;1375.559820857336;1389.1387339849357;1389.9783659010618;811.9769090945451;842.9199226073513;845.526505157114;853.2661910756744;856.2764464027887;4258.87223383299;4349.217140914666;5026.346574945233;5216.295800067019;5321.414644389114;5066.771995260222;5454.618176727591;5822.592418530662;5829.854253643608;5837.387074357216;5156.484351564814;5187.688738675692;5267.498762852569;5303.946960530422;5323.897060661095;2671.6126161706443;2794.9860250698616;2986.2522534219847;3007.6090108285784;3023.4278175349136;5970.940290597126;5979.5814292999075;5987.371326010706;6002.4897883679505;6047.455728984412;4896.1921282987905;5116.846494605168;5633.887322253532;5934.6142500737315;5951.9107213391835;5438.265834112423;5879.824464947997;5884.588078834526;5967.671778052249;5996.2504686914135;4921.729304888266;5712.343080545625;5768.423157684198;5788.739506722123;5791.710414479344;5231.822839861001;5713.828585142286;5714.314282286152;5715.771369145187;5725;4962.759310172457;5799.710014499343;5954.255718035246;5992.730327135377;6052.546059045501;3646.835892384796;3929.6659783917544;3995.5205375355144;3995.840166393428;3997.9200415990936;5231.947680523146;5456.454354564512;5760.251167348218;5763.971180144073;5781.797637082682;5327.760250788801;5518.089515230103;5644.6330988485615;5645.633033852787;5649.288341595975;4808.783604737725;5427.48438898304;5613.74738136793;5635.351934527582;5640.774369025193;5085.313482679939;5494.2857428535635;5497.642653227527;5536.809585939042;5588.329400471969;5243.344581927259;5269.735263536801;5334.626576139788;5559.888802223852;5642.802501912413;5550.7779688812;5593.720313984203;5600.691961942132;5611.80358687444;5620.1288800236025 10:52:54 INFO - PROCESS | 1684 | |5;yui.html;716.8601922942521;721.1094298541304;759.8480303939211;816.1471262530655;857.4469467193657;15872.444464443746;16672.83327166728;16715.665686686258;16735.83264167358;16740.748888766677;14866.851331486681;14994.775078373807;14996.325165367558;14999.950003499733;15005.249737513135;724.5326764237064;744.3152299884119;744.4119145874753;884.1512148337604;888.7822483491522;750.9436792240576;796.713183254031;897.0715309654508;910.640297082652;913.8949020862586;987.7530617345664;987.8518222266646;987.9407235565889;988.2686811759319;992.9751756206081;974.9366291191085;980.6420656460341;980.9117179453883;982.042508554154;983.2920297385836;728.0571659700701;729.6716477585107;729.919708832028;732.5385007445275;733.2227838491164;15847.286872090783;15874.920625396799;16063.116528590923;16077.839221607752;16089.275982580812;13505.662358441019;13560.45758169672;13721;14010;15060.698786024219;12989.675258118623;13185.406656700376;13215.20708757468;13664.863351366459;13949.232792196424;4774.136271365654;4782.569568738831;4879.4388645305535;4892.192788189945;4979.153543897546;98309.50845245727;100682.49658751732;117866;122180;128530;10834.458277086114;11331.830022549504;11386.715332116763;11415.828762568568;11532;22355.552888942457;22377.55244895093;22415.55168896613;22437.21469748551;22451.21420750266;8219.506829590244;8302.377321700777;8311.542865142354;8569.871451928226;8616.396852220285;4532.116237333688;4589.5181005994555;4592.191190773926;4751.00228951924;4844.297576851337;3635.8545658173375;3776.3013842439236;3784.7539909905768;3786.6592006718975;3799.7910114943393;686.1183379357601;687.2028447001554;691.3190507350256;713.7010640633996;720.5028530314171;644.5971267957526;704.1409480433863;707.7805880177161;720.6973071310063;739.3826155160393;9409.811803763887;9846.359986600848;10052.346597471142;10062.19502439803;10075.042870927251;565.7397597105378;647.863948570796;695.1866316409813;710.7725527831147;720.6108701301239;4626.86119416418;4714.12802985681;4759.214729569651;4806.110869489085;4835.274708793639;142766;149917;153919;156377;163028;122776.77223227832;125856;127629;128459.78427738954;131550;98192;99218.50390748;99826;101011.49494252629;110677.99999999838;8328.708495202638;9778.55996480146;10262.43556604394;10323.587056517656;10383;52010.479895200566;62804;64066.67966660137;64080.03879941711;65978.67010665109;60042.39957600543;86314.56842715746;96766;98584;99959.50060748949;12435;12607.928326092386;12835.743285134431;13155.53955611549;13456.663583410493;13888.444462221802;14533.781993269899;15235.542933712006;15898.12560309148;16013.759793602872;14478.782818257523;14543.781843272147;15026.098434093989;15189.772153417487;15230.390784368945;13951.651208719457;14082.155070695791;14283.571492855232;14580;14828.258587070388;14117.435302588192;14221;14322.427102915766;14830.406783728962;14857.554273371816;10857.728556786144;11203.327800332007;11413.714657133638;11715.882841171479;11914;11366.886331136582;11739.178257522233;11761.764764704829;11996.700082498008;12134.393280336124 10:52:54 INFO - PROCESS | 1684 | __end_tp_report 10:52:54 INFO - PROCESS | 1684 | __start_cc_report 10:52:54 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1444 10:52:54 INFO - PROCESS | 1684 | __end_cc_report 10:52:54 INFO - PROCESS | 1684 | __startTimestamp1481655174097__endTimestamp 10:52:54 INFO - PROCESS | 1684 | 10:52:54 INFO - PROCESS | 1684 | ------- Summary: start ------- 10:52:54 INFO - PROCESS | 1684 | Number of tests: 6 10:52:54 INFO - PROCESS | 1684 | 10:52:54 INFO - PROCESS | 1684 | [#0] dojo.html Cycles:165 Average:5740.71 Median:5990.76 stddev:638.32 (10.7%) stddev-sans-first:613.43 10:52:54 INFO - PROCESS | 1684 | Values: 3405.7 3416.7 3434.6 3459.4 3492.8 4569.9 5629.4 5726.2 5741.9 5747.9 5734.3 5824.3 5824.5 5831.3 5842.5 5217.1 5225.2 5239.2 5261.7 5264.4 5126.7 5138.2 5165.4 5314.2 5321.4 5179.9 5190.4 5199.6 5209.2 5231.4 5193.6 5207.5 5254.6 5275.8 5297.3 5073.8 5127.8 5196.9 5213.3 5219.5 5615.4 5656.8 5663.3 5676.9 5695.7 6157.3 6224.0 6254.8 6256.0 6257.4 6148.0 6196.5 6272.6 6284.7 6314.3 4869.3 5709.7 5756.0 5837.2 5874.7 6251.6 6292.5 6306.1 6311.7 6323.5 6178.9 6195.7 6213.4 6214.3 6214.4 6124.5 6146.0 6184.0 6210.2 6218.3 6151.4 6163.0 6164.0 6170.9 6174.4 5169.6 6154.8 6209.0 6247.9 6259.2 4922.1 4946.6 4962.9 4994.5 5002.7 4454.0 4513.1 4519.1 4520.5 4596.4 5830.6 5834.4 5842.3 5844.2 5847.3 6131.5 6260.7 6289.0 6297.8 6322.3 5674.9 5769.1 5780.9 5785.4 5787.2 5387.4 5448.9 5473.2 5477.8 5520.5 5347.9 6350.4 6355.5 6378.6 6392.0 6147.0 6213.0 6254.9 6268.7 6281.7 5233.8 6192.7 6250.2 6297.3 6331.9 6231.6 6245.6 6249.8 6258.4 6262.9 6142.3 6273.9 6277.3 6305.4 6313.4 6057.3 6120.8 6123.2 6123.6 6210.9 6210.0 6220.9 6221.1 6222.2 6229.6 6046.2 6088.1 6090.5 6097.6 6111.5 5073.5 5985.4 6013.5 6029.4 6080.0 5986.0 5986.6 5990.8 6003.8 6006.5 10:52:54 INFO - PROCESS | 1684 | 10:52:54 INFO - PROCESS | 1684 | [#1] ext.html Cycles:180 Average:73895.58 Median:34343.18 stddev:167399.76 (487.4%) stddev-sans-first:167778.62 10:52:54 INFO - PROCESS | 1684 | Values: 482.5 507.3 538.8 545.8 558.9 32011.5 32802.5 34009.7 34044.3 34125.0 35058.8 35677.0 35753.1 44052.0 44934.0 9987.2 10163.6 10163.7 10164.2 10173.3 9980.8 10091.6 10103.0 10120.7 10142.0 9321.3 9527.2 10103.5 10149.4 12084.3 12261.6 12485.7 12495.6 12504.3 12509.1 12213.6 12305.8 12310.1 12313.5 12349.5 41957.8 42223.4 42232.7 42280.2 42471.8 3618.7 3626.7 3754.0 3919.2 4050.8 32248.4 32458.8 32709.7 32857.7 33038.2 3079.9 3126.9 3206.1 3231.7 3233.7 552225.0 552826.0 553073.0 555053.0 555785.0 59793.5 60175.7 60269.0 60291.8 60412.7 35701.5 35792.1 36309.1 37749.1 37816.6 17665.0 17731.5 17892.8 17895.0 17913.4 13461.7 13563.0 13617.3 13621.0 13633.6 19393.3 19570.7 19625.6 19654.9 19707.6 5423.8 6745.5 8001.0 8041.4 8127.0 901.4 962.3 1057.8 1070.7 1152.6 24163.8 31236.5 32661.3 32732.0 32768.5 976.7 1034.3 1045.1 1047.3 1113.7 15676.5 15890.7 15940.0 16012.8 16226.7 723372.0 727754.0 730643.0 731112.0 733790.0 58261.4 58346.4 58420.4 58507.0 58522.0 1292.0 1331.3 1412.0 1434.1 1445.9 30762.8 30954.0 31828.8 31841.0 32547.0 50427.0 50875.5 50933.0 50943.0 50993.7 569917.0 574885.0 576515.0 579064.0 580504.0 23963.6 24447.0 26120.2 26257.0 26667.5 43971.3 46501.0 46969.8 47342.3 47449.8 37986.2 39228.0 39358.0 39633.0 40683.0 33852.8 34359.0 34472.5 34794.0 34926.3 38208.6 38413.8 38541.4 38973.4 39110.4 32621.5 34327.4 34419.8 34923.7 34985.0 25865.0 26026.6 26089.7 26165.9 26233.9 10:52:54 INFO - PROCESS | 1684 | 10:52:54 INFO - PROCESS | 1684 | [#2] jquery.html Cycles:180 Average:37036.15 Median:2550.55 stddev:105831.35 (4149.4%) stddev-sans-first:106092.36 10:52:54 INFO - PROCESS | 1684 | Values: 334.5 392.2 399.2 408.9 418.9 20048.0 20558.4 22124.8 22991.8 23318.8 19955.0 22126.3 22300.8 22318.2 22403.4 5691.1 6208.0 6270.7 6271.7 6292.7 4120.2 4530.5 6173.5 6216.6 6646.4 6849.6 6976.3 6987.4 6995.5 7005.1 6671.7 6935.7 6974.8 6990.4 6995.1 6044.8 6054.9 6112.6 6126.0 6129.3 27973.9 28038.9 28057.4 28148.7 28446.6 2141.1 2444.0 2502.6 2598.5 3080.7 10461.4 10652.0 15263.6 15350.1 15448.2 1826.7 1848.3 1897.2 1907.5 1927.5 135577.0 136980.0 138865.0 139011.0 142515.7 10818.7 11032.4 11367.1 11856.1 11864.4 15154.5 15213.8 15224.3 15225.1 15244.7 8963.0 9073.8 9107.3 9186.0 9261.8 9270.0 9276.6 9299.9 9444.1 9449.9 4498.3 4612.4 4632.4 4670.9 4727.0 1489.7 1657.1 1827.2 1894.0 1907.0 720.4 840.7 965.0 983.8 1015.9 21411.8 21982.8 22822.4 22895.5 22970.7 969.6 977.8 985.4 1016.3 1022.5 9603.6 11295.3 11927.8 12144.3 12146.6 618569.0 625728.0 634284.0 646746.0 647267.0 114724.4 116280.0 116400.0 117856.0 121286.0 955.1 1026.3 1057.1 1061.2 1062.8 19112.6 19535.8 19831.5 19866.0 19943.2 54333.0 55016.4 56587.0 57231.0 57562.7 79887.6 79923.0 83356.6 85996.3 87031.6 6904.7 8015.7 8383.7 8587.5 8672.6 10941.8 11405.4 13590.7 13610.5 14043.5 7862.6 11699.6 11718.2 11738.9 12053.3 5477.7 7774.2 11517.3 11709.6 11933.5 11788.7 11795.9 11880.8 12164.9 12256.7 8432.0 8454.2 8485.5 8753.7 8839.7 11468.1 11785.8 11787.9 12074.3 12100.0 10:52:54 INFO - PROCESS | 1684 | 10:52:54 INFO - PROCESS | 1684 | [#3] mootools.html Cycles:180 Average:5870.52 Median:459.17 stddev:3329.84 (725.2%) stddev-sans-first:3323.02 10:52:54 INFO - PROCESS | 1684 | Values: 1504.8 1550.8 1736.2 1907.2 1930.3 8213.3 8490.2 8686.0 9220.4 9270.5 8591.2 8915.2 8919.4 9025.1 9031.4 2427.8 2455.2 2459.5 2464.5 2474.3 2088.6 2391.1 2447.8 2452.6 2454.6 2404.8 2415.6 2427.3 2433.2 2436.1 2405.3 2421.9 2426.6 2433.3 2434.0 2040.2 2416.9 2425.0 2429.6 2430.1 9041.8 9066.4 9149.8 9197.4 9212.4 5422.6 5568.2 5573.1 5574.1 5582.1 3476.5 3525.9 3544.4 3583.3 3590.2 1054.4 1057.6 1064.7 1075.5 1085.0 11981.3 12122.8 12126.2 12148.8 12322.4 4779.8 4791.1 4805.9 4913.5 4955.8 10310.8 10320.6 10321.0 10343.9 10350.0 5519.2 5526.9 5530.3 5533.4 5534.3 4578.5 4727.0 4932.0 5067.9 5069.7 3779.3 4094.0 4161.6 4192.1 4196.2 1299.0 1316.5 1317.8 1330.8 1335.4 901.8 934.6 952.5 956.0 1001.9 5907.8 6019.5 6027.9 6034.1 6198.0 446.9 454.4 457.4 458.3 460.0 4044.5 4055.4 4078.8 4105.5 4110.6 10549.6 11128.6 11135.6 11160.7 11219.8 11040.9 11051.4 11079.1 11098.4 11102.4 8022.8 8369.5 8395.7 8503.4 8586.7 6081.5 6142.8 6204.0 6221.8 6256.5 10193.8 10491.1 10499.1 10504.3 10512.7 10052.7 10425.3 10472.6 10617.3 10633.0 6889.7 7155.0 7179.4 7353.6 7522.7 6651.9 8548.4 8640.4 8781.4 8786.5 7651.4 7710.5 7751.0 7877.5 7926.0 7505.8 7649.9 7685.8 7724.3 7826.6 7115.6 7259.4 7273.5 7274.7 7279.1 4836.5 5054.3 5077.9 5125.4 5318.9 5020.0 5145.8 5169.1 5197.4 5199.6 10:52:54 INFO - PROCESS | 1684 | 10:52:54 INFO - PROCESS | 1684 | [#4] prototype.html Cycles:180 Average:4537.50 Median:5079.25 stddev:1395.70 (27.5%) stddev-sans-first:1363.07 10:52:54 INFO - PROCESS | 1684 | Values: 309.7 316.5 319.4 322.4 323.3 4175.6 4701.7 4845.9 5249.4 5256.2 4518.2 4667.5 5199.4 5207.2 5242.4 3763.9 3949.3 3959.4 3961.6 3978.1 2998.5 3811.9 3976.6 4003.7 4068.0 3932.7 3943.5 3964.0 3966.3 4001.9 3863.6 3979.7 3981.9 4010.2 4019.6 3264.0 3485.7 3489.9 3502.8 3523.5 4941.4 5029.0 5042.8 5073.2 5119.5 3819.3 4398.0 4605.4 4623.5 4656.6 4956.6 5001.9 5003.9 5565.0 5593.8 3908.1 3924.4 3945.3 3946.5 3969.4 4804.7 5515.3 5803.6 5829.9 5892.3 3310.4 3884.6 3946.6 3952.6 3953.9 4022.2 4043.4 4056.9 4057.3 4074.6 4168.6 4549.9 4615.0 4624.8 4657.0 5400.0 5554.1 5570.1 5587.7 5676.7 1148.0 1364.6 1375.6 1389.1 1390.0 812.0 842.9 845.5 853.3 856.3 4258.9 4349.2 5026.3 5216.3 5321.4 5066.8 5454.6 5822.6 5829.9 5837.4 5156.5 5187.7 5267.5 5303.9 5323.9 2671.6 2795.0 2986.3 3007.6 3023.4 5970.9 5979.6 5987.4 6002.5 6047.5 4896.2 5116.8 5633.9 5934.6 5951.9 5438.3 5879.8 5884.6 5967.7 5996.3 4921.7 5712.3 5768.4 5788.7 5791.7 5231.8 5713.8 5714.3 5715.8 5725.0 4962.8 5799.7 5954.3 5992.7 6052.5 3646.8 3929.7 3995.5 3995.8 3997.9 5231.9 5456.5 5760.3 5764.0 5781.8 5327.8 5518.1 5644.6 5645.6 5649.3 4808.8 5427.5 5613.7 5635.4 5640.8 5085.3 5494.3 5497.6 5536.8 5588.3 5243.3 5269.7 5334.6 5559.9 5642.8 5550.8 5593.7 5600.7 5611.8 5620.1 10:52:54 INFO - PROCESS | 1684 | 10:52:54 INFO - PROCESS | 1684 | [#5] yui.html Cycles:180 Average:25076.14 Median:22444.21 stddev:39470.57 (175.9%) stddev-sans-first:39538.92 10:52:54 INFO - PROCESS | 1684 | Values: 716.9 721.1 759.8 816.1 857.4 15872.4 16672.8 16715.7 16735.8 16740.7 14866.9 14994.8 14996.3 15000.0 15005.2 724.5 744.3 744.4 884.2 888.8 750.9 796.7 897.1 910.6 913.9 987.8 987.9 987.9 988.3 993.0 974.9 980.6 980.9 982.0 983.3 728.1 729.7 729.9 732.5 733.2 15847.3 15874.9 16063.1 16077.8 16089.3 13505.7 13560.5 13721.0 14010.0 15060.7 12989.7 13185.4 13215.2 13664.9 13949.2 4774.1 4782.6 4879.4 4892.2 4979.2 98309.5 100682.5 117866.0 122180.0 128530.0 10834.5 11331.8 11386.7 11415.8 11532.0 22355.6 22377.6 22415.6 22437.2 22451.2 8219.5 8302.4 8311.5 8569.9 8616.4 4532.1 4589.5 4592.2 4751.0 4844.3 3635.9 3776.3 3784.8 3786.7 3799.8 686.1 687.2 691.3 713.7 720.5 644.6 704.1 707.8 720.7 739.4 9409.8 9846.4 10052.3 10062.2 10075.0 565.7 647.9 695.2 710.8 720.6 4626.9 4714.1 4759.2 4806.1 4835.3 142766.0 149917.0 153919.0 156377.0 163028.0 122776.8 125856.0 127629.0 128459.8 131550.0 98192.0 99218.5 99826.0 101011.5 110678.0 8328.7 9778.6 10262.4 10323.6 10383.0 52010.5 62804.0 64066.7 64080.0 65978.7 60042.4 86314.6 96766.0 98584.0 99959.5 12435.0 12607.9 12835.7 13155.5 13456.7 13888.4 14533.8 15235.5 15898.1 16013.8 14478.8 14543.8 15026.1 15189.8 15230.4 13951.7 14082.2 14283.6 14580.0 14828.3 14117.4 14221.0 14322.4 14830.4 14857.6 10857.7 11203.3 11413.7 11715.9 11914.0 11366.9 11739.2 11761.8 11996.7 12134.4 10:52:54 INFO - PROCESS | 1684 | -------- Summary: end -------- 10:52:54 INFO - PROCESS | 1684 | 10:52:54 INFO - TEST-INFO | 1684: exit 0 10:52:54 INFO - TEST-OK | dromaeo_css | took 1114947ms 10:52:54 INFO - TEST-START | kraken 10:52:54 INFO - operating with platform_type : mac_ 10:52:54 INFO - Initialising browser for kraken test... 10:52:54 INFO - TEST-INFO | started process 1801 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpkm_Gf9/profile http://localhost:49243/getInfo.html) 10:52:56 INFO - PROCESS | 1801 | __metrics Screen width/height:1600/1200 10:52:56 INFO - PROCESS | 1801 | colorDepth:24 10:52:56 INFO - PROCESS | 1801 | Browser inner width/height: 1024/689 10:52:56 INFO - PROCESS | 1801 | __metrics 10:52:56 INFO - PROCESS | 1801 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:52:56 INFO - PROCESS | 1801 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:52:57 INFO - TEST-INFO | 1801: exit 0 10:52:57 INFO - Browser initialized. 10:52:57 INFO - Running cycle 1/1 for kraken test... 10:52:57 INFO - TEST-INFO | started process 1803 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/T/tmpkm_Gf9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:09 INFO - PROCESS | 1803 | RSS: Main: 169062400 10:53:09 INFO - PROCESS | 1803 | 10:53:12 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 10:53:13 INFO - PROCESS | 1803 | RSS: Main: 220286976 10:53:13 INFO - PROCESS | 1803 | 10:53:15 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 10:53:16 INFO - PROCESS | 1803 | RSS: Main: 234962944 10:53:16 INFO - PROCESS | 1803 | 10:53:19 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 10:53:19 INFO - PROCESS | 1803 | RSS: Main: 329240576 10:53:19 INFO - PROCESS | 1803 | 10:53:21 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 10:53:22 INFO - PROCESS | 1803 | RSS: Main: 228188160 10:53:22 INFO - PROCESS | 1803 | 10:53:24 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:53:25 INFO - PROCESS | 1803 | RSS: Main: 228679680 10:53:25 INFO - PROCESS | 1803 | 10:53:27 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 10:53:28 INFO - PROCESS | 1803 | RSS: Main: 265105408 10:53:28 INFO - PROCESS | 1803 | 10:53:31 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 10:53:31 INFO - PROCESS | 1803 | RSS: Main: 265383936 10:53:31 INFO - PROCESS | 1803 | 10:53:34 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 10:53:34 INFO - PROCESS | 1803 | RSS: Main: 267931648 10:53:34 INFO - PROCESS | 1803 | 10:53:36 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:53:37 INFO - PROCESS | 1803 | RSS: Main: 240128000 10:53:37 INFO - PROCESS | 1803 | 10:53:38 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:53:39 INFO - PROCESS | 1803 | RSS: Main: 244535296 10:53:39 INFO - PROCESS | 1803 | 10:53:41 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:53:42 INFO - PROCESS | 1803 | RSS: Main: 255418368 10:53:42 INFO - PROCESS | 1803 | 10:53:45 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:53:45 INFO - PROCESS | 1803 | RSS: Main: 256905216 10:53:45 INFO - PROCESS | 1803 | 10:53:48 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:53:49 INFO - PROCESS | 1803 | RSS: Main: 257998848 10:53:49 INFO - PROCESS | 1803 | 10:53:50 INFO - PROCESS | 1803 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 10:53:51 INFO - PROCESS | 1803 | RSS: Main: 301764608 10:53:51 INFO - PROCESS | 1803 | 10:53:51 INFO - PROCESS | 1803 | __start_tp_report 10:53:51 INFO - PROCESS | 1803 | _x_x_mozilla_page_load 10:53:51 INFO - PROCESS | 1803 | _x_x_mozilla_page_load_details 10:53:51 INFO - PROCESS | 1803 | |i|pagename|runs| 10:53:51 INFO - PROCESS | 1803 | |0;ai-astar;115;111;113;112;111;115;149;164;117;111 10:53:51 INFO - PROCESS | 1803 | |1;audio-beat-detection;141;108;107;138;109;107;105;107;139;130 10:53:51 INFO - PROCESS | 1803 | |2;audio-dft;182;182;184;180;180;180;182;199;260;200 10:53:51 INFO - PROCESS | 1803 | |3;audio-fft;81;58;58;86;58;60;58;57;80;58 10:53:51 INFO - PROCESS | 1803 | |4;audio-oscillator;87;69;91;69;68;68;92;69;68;89 10:53:51 INFO - PROCESS | 1803 | |5;imaging-gaussian-blur;87;84;86;83;86;83;87;83;85;87 10:53:51 INFO - PROCESS | 1803 | |6;imaging-darkroom;92;91;93;93;93;93;92;93;92;92 10:53:51 INFO - PROCESS | 1803 | |7;imaging-desaturate;83;85;83;83;86;83;84;83;83;84 10:53:51 INFO - PROCESS | 1803 | |8;json-parse-financial;55;52;54;52;56;57;55;56;57;56 10:53:51 INFO - PROCESS | 1803 | |9;json-stringify-tinderbox;62;68;76;79;72;66;69;70;69;71 10:53:51 INFO - PROCESS | 1803 | |10;stanford-crypto-aes;82;85;85;83;81;85;87;88;88;111 10:53:51 INFO - PROCESS | 1803 | |11;stanford-crypto-ccm;128;145;147;144;131;132;134;134;145;134 10:53:51 INFO - PROCESS | 1803 | |12;stanford-crypto-pbkdf2;164;159;160;159;160;159;162;159;159;160 10:53:51 INFO - PROCESS | 1803 | |13;stanford-crypto-sha256-iterative;62;82;81;65;66;67;64;73;79;84 10:53:51 INFO - PROCESS | 1803 | __end_tp_report 10:53:51 INFO - PROCESS | 1803 | __start_cc_report 10:53:51 INFO - PROCESS | 1803 | _x_x_mozilla_cycle_collect,1834 10:53:51 INFO - PROCESS | 1803 | __end_cc_report 10:53:51 INFO - PROCESS | 1803 | __startTimestamp1481655231184__endTimestamp 10:53:51 INFO - PROCESS | 1803 | 10:53:51 INFO - PROCESS | 1803 | ------- Summary: start ------- 10:53:51 INFO - PROCESS | 1803 | Number of tests: 14 10:53:51 INFO - PROCESS | 1803 | 10:53:51 INFO - PROCESS | 1803 | [#0] ai-astar Cycles:10 Average:121.80 Median:115.00 stddev:18.74 (16.3%) stddev-sans-first:19.71 10:53:51 INFO - PROCESS | 1803 | Values: 115.0 111.0 113.0 112.0 111.0 115.0 149.0 164.0 117.0 111.0 10:53:51 INFO - PROCESS | 1803 | 10:53:51 INFO - PROCESS | 1803 | [#1] audio-beat-detection Cycles:10 Average:119.10 Median:119.50 stddev:15.69 (13.1%) stddev-sans-first:14.50 10:53:51 INFO - PROCESS | 1803 | Values: 141.0 108.0 107.0 138.0 109.0 107.0 105.0 107.0 139.0 130.0 10:53:51 INFO - PROCESS | 1803 | 10:53:51 INFO - PROCESS | 1803 | [#2] audio-dft Cycles:10 Average:192.90 Median:183.00 stddev:24.78 (13.5%) stddev-sans-first:25.96 10:53:51 INFO - PROCESS | 1803 | Values: 182.0 182.0 184.0 180.0 180.0 180.0 182.0 199.0 260.0 200.0 10:53:51 INFO - PROCESS | 1803 | 10:53:51 INFO - PROCESS | 1803 | [#3] audio-fft Cycles:10 Average:65.40 Median:59.00 stddev:11.81 (20.0%) stddev-sans-first:11.09 10:53:51 INFO - PROCESS | 1803 | Values: 81.0 58.0 58.0 86.0 58.0 60.0 58.0 57.0 80.0 58.0 10:53:51 INFO - PROCESS | 1803 | 10:53:51 INFO - PROCESS | 1803 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:78.00 stddev:11.06 (14.2%) stddev-sans-first:11.12 10:53:51 INFO - PROCESS | 1803 | Values: 87.0 69.0 91.0 69.0 68.0 68.0 92.0 69.0 68.0 89.0 10:53:51 INFO - PROCESS | 1803 | 10:53:51 INFO - PROCESS | 1803 | [#5] imaging-gaussian-blur Cycles:10 Average:85.10 Median:86.00 stddev:1.73 (2.0%) stddev-sans-first:1.69 10:53:51 INFO - PROCESS | 1803 | Values: 87.0 84.0 86.0 83.0 86.0 83.0 87.0 83.0 85.0 87.0 10:53:51 INFO - PROCESS | 1803 | 10:53:51 INFO - PROCESS | 1803 | [#6] imaging-darkroom Cycles:10 Average:92.40 Median:93.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 10:53:51 INFO - PROCESS | 1803 | Values: 92.0 91.0 93.0 93.0 93.0 93.0 92.0 93.0 92.0 92.0 10:53:51 INFO - PROCESS | 1803 | 10:53:51 INFO - PROCESS | 1803 | [#7] imaging-desaturate Cycles:10 Average:83.70 Median:83.50 stddev:1.06 (1.3%) stddev-sans-first:1.09 10:53:51 INFO - PROCESS | 1803 | Values: 83.0 85.0 83.0 83.0 86.0 83.0 84.0 83.0 83.0 84.0 10:53:51 INFO - PROCESS | 1803 | 10:53:51 INFO - PROCESS | 1803 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:56.00 stddev:1.83 (3.3%) stddev-sans-first:1.94 10:53:51 INFO - PROCESS | 1803 | Values: 55.0 52.0 54.0 52.0 56.0 57.0 55.0 56.0 57.0 56.0 10:53:51 INFO - PROCESS | 1803 | 10:53:51 INFO - PROCESS | 1803 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.50 stddev:4.80 (6.8%) stddev-sans-first:4.08 10:53:51 INFO - PROCESS | 1803 | Values: 62.0 68.0 76.0 79.0 72.0 66.0 69.0 70.0 69.0 71.0 10:53:51 INFO - PROCESS | 1803 | 10:53:51 INFO - PROCESS | 1803 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:85.00 stddev:8.59 (10.1%) stddev-sans-first:8.88 10:53:51 INFO - PROCESS | 1803 | Values: 82.0 85.0 85.0 83.0 81.0 85.0 87.0 88.0 88.0 111.0 10:53:51 INFO - PROCESS | 1803 | 10:53:51 INFO - PROCESS | 1803 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:139.00 stddev:7.03 (5.1%) stddev-sans-first:6.58 10:53:51 INFO - PROCESS | 1803 | Values: 128.0 145.0 147.0 144.0 131.0 132.0 134.0 134.0 145.0 134.0 10:53:51 INFO - PROCESS | 1803 | 10:53:51 INFO - PROCESS | 1803 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:160.00 stddev:1.66 (1.0%) stddev-sans-first:1.00 10:53:51 INFO - PROCESS | 1803 | Values: 164.0 159.0 160.0 159.0 160.0 159.0 162.0 159.0 159.0 160.0 10:53:51 INFO - PROCESS | 1803 | 10:53:51 INFO - PROCESS | 1803 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:76.00 stddev:8.49 (11.2%) stddev-sans-first:8.14 10:53:51 INFO - PROCESS | 1803 | Values: 62.0 82.0 81.0 65.0 66.0 67.0 64.0 73.0 79.0 84.0 10:53:51 INFO - PROCESS | 1803 | -------- Summary: end -------- 10:53:51 INFO - PROCESS | 1803 | 10:53:51 INFO - TEST-INFO | 1803: exit 0 10:53:51 INFO - TEST-OK | kraken | took 57327ms 10:53:51 INFO - SUITE-END | took 1172s 10:53:52 INFO - Completed test suite (00:19:32) 10:53:52 INFO - javascript benchmark 10:53:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3405.6934875861175, 3416.675415835496, 3434.639362866899, 3459.4118999770035, 3492.7555071145016, 4569.908601827961, 5629.380768115504, 5726.1697053927255, 5741.913871291928, 5747.942520574793, 5734.340550836655, 5824.330202026768, 5824.534037277018, 5831.300243970719, 5842.47417732404, 5217.113090774558, 5225.163973764198, 5239.187925871496, 5261.710605916673, 5264.368275806909, 5126.7436628168625, 5138.203578445347, 5165.405978312505, 5314.229436731672, 5321.36143662761, 5179.922301165486, 5190.351206099238, 5199.6360254782185, 5209.21861720743, 5231.372235331746, 5193.63644544882, 5207.531322181022, 5254.553362964152, 5275.788968441258, 5297.284866543006, 5073.771680274396, 5127.769250383742, 5196.8960620787375, 5213.348331458567, 5219.530242278213, 5615.410381909882, 5656.8020119295625, 5663.32040155184, 5676.858078548028, 5695.743691533891, 6157.2919114301985, 6223.96888015557, 6254.781082662085, 6256.0, 6257.405546473078, 6147.9548476759055, 6196.525797251752, 6272.5922815016875, 6284.717187726517, 6314.273858506284, 4869.269609558523, 5709.685967271798, 5755.963926493229, 5837.241158649348, 5874.73563689635, 6251.5905926735395, 6292.46514046302, 6306.054091886253, 6311.747530098836, 6323.494120470351, 6178.876422471525, 6195.690215489208, 6213.409726076015, 6214.347493513116, 6214.440700336901, 6124.473467760062, 6145.985912324416, 6183.96908015457, 6210.161628180228, 6218.347073557302, 6151.415615516608, 6163.0, 6164.044573091178, 6170.876582468325, 6174.413430724074, 5169.560587350042, 6154.846128846814, 6209.0, 6247.875042499125, 6259.155014073133, 4922.064807686528, 4946.579540739005, 4962.925556116661, 4994.450610432849, 5002.749862506933, 4454.020115574568, 4513.074819661962, 4519.141363140992, 4520.525344838745, 4596.4254468191475, 5830.562707796932, 5834.387389324144, 5842.269716285465, 5844.240248767633, 5847.3275573308765, 6131.540134489931, 6260.686965651699, 6289.0, 6297.779577714758, 6322.272938612118, 5674.914876276859, 5769.105788602773, 5780.88438231233, 5785.4214578541805, 5787.189793428924, 5387.434319396485, 5448.945510544923, 5473.233747275384, 5477.780888764405, 5520.53075488588, 5347.866303342447, 6350.396712312323, 6355.491560675135, 6378.617282963037, 6391.9680401598625, 6146.985747351637, 6213.03697926822, 6254.937450625435, 6268.717907694256, 6281.685915704105, 5233.816816411408, 6192.690365481798, 6250.1874756281395, 6297.275813281532, 6331.873362532816, 6231.563790534619, 6245.6252624842655, 6249.750009999549, 6258.43674069336, 6262.906056409066, 6142.345304543789, 6273.9372606273355, 6277.30949595535, 6305.432511074026, 6313.43179113882, 6057.333693293646, 6120.751898419022, 6123.173371594778, 6123.632582045091, 6210.937890621036, 6209.96895015522, 6220.875582488416, 6221.09794079865, 6222.191115155001, 6229.626222426669, 6046.213992181164, 6088.086786981989, 6090.451859332681, 6097.603655762361, 6111.511079113571, 5073.543381095719, 5985.371535988833, 6013.458788709037, 6029.3669164737075, 6080.027195648852, 5986.0, 5986.580939334205, 5990.760369585342, 6003.759849605967, 6006.519478441802], "value": 5702.362457037669, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.5391750877912, 507.340457405373, 538.8006437618079, 545.8253358925144, 558.8770470496489, 32011.51982720258, 32802.50796238055, 34009.659903400956, 34044.31911361774, 34125.0, 35058.82470587643, 35677.0, 35753.1061723457, 44052.0, 44934.0, 9987.201023918087, 10163.644272450465, 10163.695089147337, 10164.186865050815, 10173.287869849113, 9980.750481237954, 10091.596336146546, 10102.989701029912, 10120.746981325488, 10142.036506531867, 9321.300902432346, 9527.190188833958, 10103.545340459661, 10149.39103653783, 12084.274943503375, 12261.632151035483, 12485.687857803538, 12495.562655307112, 12504.31226282554, 12509.06182036351, 12213.633590992284, 12305.815412768816, 12310.076744244217, 12313.507459701601, 12349.5060197592, 41957.790211049054, 42223.36664949998, 42232.73301800951, 42280.15439691189, 42471.78764106159, 3618.6562276583945, 3626.673599376069, 3753.981230093832, 3919.2161567686294, 4050.8177132028836, 32248.35503289921, 32458.837705811555, 32709.6729032709, 32857.67142328594, 33038.17404564905, 3079.938401231985, 3126.901932612956, 3206.055994071322, 3231.6929891660257, 3233.692799184074, 552225.0, 552826.0, 553073.0, 555053.0, 555785.0, 59793.505162371286, 60175.69912150411, 60269.0, 60291.79416411735, 60412.697936510915, 35701.46447803285, 35792.105197369754, 36309.09227269339, 37749.05627359283, 37816.62183378131, 17665.0, 17731.468055958343, 17892.821071789116, 17895.0, 17913.37303194382, 13461.663458413617, 13563.0, 13617.25105119228, 13620.978426617845, 13633.590992270249, 19393.32123375675, 19570.70643940342, 19625.607487850448, 19654.90172549128, 19707.60584788325, 5423.83728488146, 6745.494087943326, 8000.959995199987, 8041.437099402986, 8127.0, 901.3600343756007, 962.3311798300114, 1057.7778666479971, 1070.7269646240159, 1152.6369193703956, 24163.7583624165, 31236.531452028237, 32661.346773064404, 32732.018039458853, 32768.50847237293, 976.7448828255657, 1034.255336157965, 1045.137761346892, 1047.3349423116224, 1113.6937342230951, 15676.529704108894, 15890.682186356207, 15940.0, 16012.839871601367, 16226.67546649084, 723372.0, 727754.0, 730643.0, 731112.0, 733790.0, 58261.41738582645, 58346.41653583495, 58420.415795842346, 58507.0, 58522.0, 1291.9741605167844, 1331.3276795218353, 1411.985880141206, 1434.12518363798, 1445.898787084894, 30762.84618576893, 30954.0, 31828.840855795574, 31841.0, 32547.0, 50427.0, 50875.49124508855, 50932.981340372244, 50942.98114037624, 50993.74503127461, 569917.0, 574885.0, 576515.0, 579064.0, 580504.0, 23963.640545391485, 24447.022119115038, 26120.216393508224, 26257.0, 26667.466650667266, 43971.34042989294, 46501.03395570566, 46969.765151174026, 47342.28986565136, 47449.76275118603, 37986.151038671655, 39228.0192995166, 39358.01604959899, 39633.0, 40682.9829254271, 33852.83073584616, 34359.0, 34472.482912755826, 34794.0, 34926.30147397089, 38208.617913820504, 38413.80793096017, 38541.4218786724, 38973.41539876848, 39110.41334379929, 32621.510677340335, 34327.36450901298, 34419.79530716413, 34923.65076349204, 34985.0, 25865.0, 26026.609600855623, 26089.739102609492, 26165.850840806866, 26233.868830655723], "value": 20327.24835934938, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.5049326996046, 392.24101363860916, 399.2494111071186, 408.9407035979785, 418.88061902357833, 20048.0, 20558.38324850253, 22124.778752212475, 22991.770082299194, 23318.766812331873, 19955.0, 22126.336209913687, 22300.776992230072, 22318.21886233982, 22403.43991400216, 5691.146328050794, 6207.968960155193, 6270.686465676721, 6271.686415679221, 6292.685365731718, 4120.155368149537, 4530.501644819067, 6173.536984726141, 6216.564840461147, 6646.435053020499, 6849.589024658511, 6976.337247961435, 6987.35797087684, 6995.510314278003, 7005.124359455068, 6671.666416679171, 6935.687894044755, 6974.825629359256, 6990.405815505688, 6995.090638217, 6044.788432404889, 6054.878902421927, 6112.602680825732, 6126.0, 6129.325774164839, 27973.86013069942, 28038.859805700842, 28057.438851223065, 28148.718512814816, 28446.573301400495, 2141.100737690174, 2443.9511209775883, 2502.649629051934, 2598.454324591838, 3080.722734953865, 10461.424621645807, 10652.0, 15263.618409539738, 15350.07899526032, 15448.15035173065, 1826.6985947318676, 1848.279171123263, 1897.2221389230488, 1907.4945139538033, 1927.5470264487835, 135577.0, 136980.0, 138864.99999999898, 139011.0, 142515.73647712969, 10818.67543973682, 11032.393218373067, 11367.147463940237, 11856.110791690486, 11864.406779661154, 15154.545363639108, 15213.771793423108, 15224.314905829264, 15225.086494810346, 15244.695106097815, 8963.0, 9073.80679838755, 9107.271418286653, 9185.954070229605, 9261.814763704688, 9270.0, 9276.62893484253, 9299.907000929905, 9444.0555944405, 9449.858252126223, 4498.325251212279, 4612.400387949545, 4632.444106707217, 4670.929936050962, 4727.0, 1489.6797188604503, 1657.0637589761745, 1827.1626957585909, 1893.9905300473686, 1906.979765825277, 720.4308596208937, 840.7183593496247, 964.9951750241204, 983.8179936711588, 1015.939043657383, 21411.785882141292, 21982.780172198392, 22822.42943926415, 22895.542089158458, 22970.65544016841, 969.60730903984, 977.7653363192783, 985.4186030242191, 1016.2987538598344, 1022.5091955861228, 9603.567839447242, 11295.322280663022, 11927.761444771057, 12144.33206173669, 12146.63560093181, 618569.0, 625728.0, 634284.0, 646746.0, 647267.0, 114724.42637786758, 116280.0, 116400.0, 117856.0, 121286.0, 955.0974329258922, 1026.3328836256494, 1057.0697785948316, 1061.1722856172198, 1062.8405739139191, 19112.617747645247, 19535.8046419534, 19831.504212394804, 19866.00669966525, 19943.202271908962, 54333.0, 55016.44983550113, 56587.0, 57231.0, 57562.7121864388, 79887.60056199682, 79923.0, 83356.58321708352, 85996.28007439691, 87031.56484217792, 6904.689288982108, 8015.719449819228, 8383.748487545383, 8587.484750914966, 8672.609732562176, 10941.835872461761, 11405.372704501333, 13590.660233494242, 13610.523631672844, 14043.50847720325, 7862.606869656609, 11699.649010529358, 11718.23831450953, 11738.882611173778, 12053.276803391824, 5477.67133971963, 7774.183710710294, 11517.308961462339, 11709.590164344549, 11933.52265909354, 11788.70528236801, 11795.941020295188, 11880.82178767302, 12164.878351216728, 12256.693582660504, 8432.0, 8454.196851299117, 8485.490870547786, 8753.730709047026, 8839.734807955772, 11468.139889508153, 11785.764284714429, 11787.882121178678, 12074.27554346742, 12100.03199744036], "value": 10057.805392411861, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1504.8344682084971, 1550.7751376050473, 1736.2360561353003, 1907.1799126375654, 1930.2568511123213, 8213.342932565396, 8490.193431623986, 8686.044535101133, 9220.354575179741, 9270.536473176347, 8591.226789588936, 8915.242204412616, 8919.420237684546, 9025.142611451902, 9031.412958157714, 2427.8421902576365, 2455.177515532299, 2459.5449841779237, 2464.470138920132, 2474.3195621204222, 2088.6449303618347, 2391.0738527701023, 2447.779699827015, 2452.5953217719143, 2454.5704501712216, 2404.7715467030603, 2415.5531226723024, 2427.2960841355984, 2433.2335314376005, 2436.1473484280536, 2405.302462285935, 2421.9394515137087, 2426.5632186206476, 2433.2578563538113, 2434.0, 2040.2349119080345, 2416.9154079607306, 2424.9757502424927, 2429.5626787178303, 2430.1251549442186, 9041.77395565116, 9066.365354425126, 9149.81700365989, 9197.448153110834, 9212.355135140542, 5422.6475279106735, 5568.220449137124, 5573.052581061229, 5574.080276754371, 5582.134769110794, 3476.5132881396626, 3525.894223173309, 3544.3620148373284, 3583.283343331344, 3590.174259920207, 1054.4253381906879, 1057.5981127171704, 1064.7231719752842, 1075.5052675769155, 1085.039739830248, 11981.28112313264, 12122.757544849143, 12126.211796233216, 12148.757024859542, 12322.383880806014, 4779.761011949388, 4791.065742180242, 4805.879853003633, 4913.533214344631, 4955.752212389438, 10310.845337319946, 10320.638777642896, 10320.96790320962, 10343.94828025855, 10350.016748408889, 5519.227308176858, 5526.944730552643, 5530.336359636869, 5533.363663178706, 5534.335879694462, 4578.496365399803, 4727.0, 4931.950680493149, 5067.873303167376, 5069.670471419346, 3779.263043706451, 4094.0, 4161.585061079248, 4192.11965487245, 4196.223698615766, 1298.9740205195844, 1316.4997301025548, 1317.7693903567028, 1330.813686083949, 1335.4057444437133, 901.8411341426366, 934.5887809363858, 952.4618590496348, 955.961761529531, 1001.9398836069859, 5907.793227237112, 6019.488343490765, 6027.9095813562835, 6034.125051867454, 6198.008318668992, 446.93519439681063, 454.4160753431824, 457.36198003784534, 458.3239721410959, 460.0201570654551, 4044.4539987101366, 4055.351143817034, 4078.7756673382655, 4105.486814148231, 4110.568390318974, 10549.578016879239, 11128.610498632508, 11135.554577816958, 11160.720981975515, 11219.831702524469, 11040.944795275973, 11051.392173430539, 11079.058280046125, 11098.389588572545, 11102.389368584805, 8022.79943001418, 8369.451651444502, 8395.664173433117, 8503.404761666749, 8586.656533738706, 6081.543884208613, 6142.815715528542, 6204.0, 6221.782237621843, 6256.5307601930945, 10193.796124077626, 10491.108255798343, 10499.055085042382, 10504.264701470824, 10512.684619461428, 10052.748681283027, 10425.270231083752, 10472.633457829244, 10617.256792024484, 10633.0, 6889.689963951734, 7154.962530433162, 7179.353858152583, 7353.632318384166, 7522.661480233293, 6651.900221496585, 8548.401611887357, 8640.438371506083, 8781.385303028726, 8786.516741579275, 7651.4261430391825, 7710.460267781202, 7751.0, 7877.527348359117, 7926.0, 7505.774826755206, 7649.88525172134, 7685.846283074419, 7724.266194711493, 7826.608669566613, 7115.644217789193, 7259.382952449101, 7273.454490913308, 7274.745383911538, 7279.053723015974, 4836.46798852133, 5054.2923990642075, 5077.898442031064, 5125.410577783454, 5318.946810532, 5019.974900125476, 5145.7941682333785, 5169.06956747774, 5197.350331208599, 5199.584033277404], "value": 4629.849546931768, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.7011384014426, 316.49361022364207, 319.359683833913, 322.3568979885128, 323.30166839626384, 4175.6450701690355, 4701.670883038189, 4845.854624361266, 5249.396319423272, 5256.185291279849, 4518.209313370164, 4667.486576476585, 5199.350081239845, 5207.244949482323, 5242.370915490137, 3763.8870833875026, 3949.34835752102, 3959.3766555712164, 3961.6434520893113, 3978.124812541251, 2998.5202367621187, 3811.913604622683, 3976.5742896832908, 4003.7397569158056, 4067.959320406788, 3932.705047121463, 3943.5267767867895, 3964.0, 3966.266240745457, 4001.899952501182, 3863.613638636114, 3979.6668116181113, 3981.9004524886964, 4010.197960407901, 4019.5980401959864, 3264.020793761862, 3485.721142308609, 3489.8953031409096, 3502.807345595991, 3523.4538646509577, 4941.382327209099, 5028.974855125701, 5042.823501177478, 5073.188289873602, 5119.488051194888, 3819.2934307152987, 4397.956020439787, 4605.37827393301, 4623.491415944243, 4656.627469802408, 4956.603471722289, 5001.924971125436, 5003.921803729985, 5564.972175139098, 5593.776248950037, 3908.081600823804, 3924.4309575111733, 3945.309570825094, 3946.4869566956113, 3969.4442778011103, 4804.741771367487, 5515.283013208257, 5803.564732645026, 5829.921464529076, 5892.263467066617, 3310.4372256716415, 3884.6309600587897, 3946.625070618287, 3952.596828126031, 3953.940690889639, 4022.1955608878343, 4043.3732771420478, 4056.8985775355854, 4057.2899742544937, 4074.633283004544, 4168.6039826216465, 4549.931751023737, 4615.0, 4624.849445008087, 4656.95343046572, 5400.0, 5554.1391084381985, 5570.108782594846, 5587.7485513152005, 5676.744546495418, 1147.9540818367338, 1364.597443754095, 1375.559820857336, 1389.1387339849357, 1389.9783659010618, 811.9769090945451, 842.9199226073513, 845.526505157114, 853.2661910756744, 856.2764464027887, 4258.87223383299, 4349.217140914666, 5026.346574945233, 5216.295800067019, 5321.414644389114, 5066.771995260222, 5454.618176727591, 5822.592418530662, 5829.854253643608, 5837.387074357216, 5156.484351564814, 5187.688738675692, 5267.498762852569, 5303.946960530422, 5323.897060661095, 2671.6126161706443, 2794.9860250698616, 2986.2522534219847, 3007.6090108285784, 3023.4278175349136, 5970.940290597126, 5979.5814292999075, 5987.371326010706, 6002.4897883679505, 6047.455728984412, 4896.1921282987905, 5116.846494605168, 5633.887322253532, 5934.6142500737315, 5951.9107213391835, 5438.265834112423, 5879.824464947997, 5884.588078834526, 5967.671778052249, 5996.2504686914135, 4921.729304888266, 5712.343080545625, 5768.423157684198, 5788.739506722123, 5791.710414479344, 5231.822839861001, 5713.828585142286, 5714.314282286152, 5715.771369145187, 5725.0, 4962.759310172457, 5799.710014499343, 5954.255718035246, 5992.730327135377, 6052.546059045501, 3646.835892384796, 3929.6659783917544, 3995.5205375355144, 3995.840166393428, 3997.9200415990936, 5231.947680523146, 5456.454354564512, 5760.251167348218, 5763.971180144073, 5781.797637082682, 5327.760250788801, 5518.089515230103, 5644.6330988485615, 5645.633033852787, 5649.288341595975, 4808.783604737725, 5427.48438898304, 5613.74738136793, 5635.351934527582, 5640.774369025193, 5085.313482679939, 5494.2857428535635, 5497.642653227527, 5536.809585939042, 5588.329400471969, 5243.344581927259, 5269.735263536801, 5334.626576139788, 5559.888802223852, 5642.802501912413, 5550.7779688812, 5593.720313984203, 5600.691961942132, 5611.80358687444, 5620.1288800236025], "value": 4092.19714179394, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.8601922942521, 721.1094298541304, 759.8480303939211, 816.1471262530655, 857.4469467193657, 15872.444464443746, 16672.83327166728, 16715.665686686258, 16735.83264167358, 16740.748888766677, 14866.851331486681, 14994.775078373807, 14996.325165367558, 14999.950003499733, 15005.249737513135, 724.5326764237064, 744.3152299884119, 744.4119145874753, 884.1512148337604, 888.7822483491522, 750.9436792240576, 796.713183254031, 897.0715309654508, 910.640297082652, 913.8949020862586, 987.7530617345664, 987.8518222266646, 987.9407235565889, 988.2686811759319, 992.9751756206081, 974.9366291191085, 980.6420656460341, 980.9117179453883, 982.042508554154, 983.2920297385836, 728.0571659700701, 729.6716477585107, 729.919708832028, 732.5385007445275, 733.2227838491164, 15847.286872090783, 15874.920625396799, 16063.116528590923, 16077.839221607752, 16089.275982580812, 13505.662358441019, 13560.45758169672, 13721.0, 14010.0, 15060.698786024219, 12989.675258118623, 13185.406656700376, 13215.20708757468, 13664.863351366459, 13949.232792196424, 4774.136271365654, 4782.569568738831, 4879.4388645305535, 4892.192788189945, 4979.153543897546, 98309.50845245727, 100682.49658751732, 117866.0, 122180.0, 128530.0, 10834.458277086114, 11331.830022549504, 11386.715332116763, 11415.828762568568, 11532.0, 22355.552888942457, 22377.55244895093, 22415.55168896613, 22437.21469748551, 22451.21420750266, 8219.506829590244, 8302.377321700777, 8311.542865142354, 8569.871451928226, 8616.396852220285, 4532.116237333688, 4589.5181005994555, 4592.191190773926, 4751.00228951924, 4844.297576851337, 3635.8545658173375, 3776.3013842439236, 3784.7539909905768, 3786.6592006718975, 3799.7910114943393, 686.1183379357601, 687.2028447001554, 691.3190507350256, 713.7010640633996, 720.5028530314171, 644.5971267957526, 704.1409480433863, 707.7805880177161, 720.6973071310063, 739.3826155160393, 9409.811803763887, 9846.359986600848, 10052.346597471142, 10062.19502439803, 10075.042870927251, 565.7397597105378, 647.863948570796, 695.1866316409813, 710.7725527831147, 720.6108701301239, 4626.86119416418, 4714.12802985681, 4759.214729569651, 4806.110869489085, 4835.274708793639, 142766.0, 149917.0, 153919.0, 156377.0, 163028.0, 122776.77223227832, 125856.0, 127629.0, 128459.78427738954, 131550.0, 98192.0, 99218.50390748, 99826.0, 101011.49494252629, 110677.99999999838, 8328.708495202638, 9778.55996480146, 10262.43556604394, 10323.587056517656, 10383.0, 52010.479895200566, 62804.0, 64066.67966660137, 64080.03879941711, 65978.67010665109, 60042.39957600543, 86314.56842715746, 96766.0, 98584.0, 99959.50060748949, 12435.0, 12607.928326092386, 12835.743285134431, 13155.53955611549, 13456.663583410493, 13888.444462221802, 14533.781993269899, 15235.542933712006, 15898.12560309148, 16013.759793602872, 14478.782818257523, 14543.781843272147, 15026.098434093989, 15189.772153417487, 15230.390784368945, 13951.651208719457, 14082.155070695791, 14283.571492855232, 14580.0, 14828.258587070388, 14117.435302588192, 14221.0, 14322.427102915766, 14830.406783728962, 14857.554273371816, 10857.728556786144, 11203.327800332007, 11413.714657133638, 11715.882841171479, 11914.0, 11366.886331136582, 11739.178257522233, 11761.764764704829, 11996.700082498008, 12134.393280336124], "value": 8193.254813153659, "unit": "score"}], "name": "dromaeo_css", "value": 7521.029329722497, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 113.0, 112.0, 111.0, 115.0, 149.0, 164.0, 117.0, 111.0], "value": 121.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 107.0, 138.0, 109.0, 107.0, 105.0, 107.0, 139.0, 130.0], "value": 119.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 184.0, 180.0, 180.0, 180.0, 182.0, 199.0, 260.0, 200.0], "value": 192.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 58.0, 86.0, 58.0, 60.0, 58.0, 57.0, 80.0, 58.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 91.0, 69.0, 68.0, 68.0, 92.0, 69.0, 68.0, 89.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 83.0, 86.0, 83.0, 87.0, 83.0, 85.0, 87.0], "value": 85.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 93.0, 93.0, 93.0, 93.0, 92.0, 93.0, 92.0, 92.0], "value": 92.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 83.0, 83.0, 86.0, 83.0, 84.0, 83.0, 83.0, 84.0], "value": 83.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 54.0, 52.0, 56.0, 57.0, 55.0, 56.0, 57.0, 56.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 68.0, 76.0, 79.0, 72.0, 66.0, 69.0, 70.0, 69.0, 71.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 85.0, 83.0, 81.0, 85.0, 87.0, 88.0, 88.0, 111.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 145.0, 147.0, 144.0, 131.0, 132.0, 134.0, 134.0, 145.0, 134.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 159.0, 160.0, 159.0, 160.0, 159.0, 162.0, 159.0, 159.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 82.0, 81.0, 65.0, 66.0, 67.0, 64.0, 73.0, 79.0, 84.0], "value": 72.3, "unit": "score"}], "name": "kraken", "value": 1419.8999999999999, "alertThreshold": 2.0}]} 10:53:52 INFO - Return code: 0 10:53:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:53:52 INFO - # TBPL SUCCESS # 10:53:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:53:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:53:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:53:52 INFO - 2016-12-13 10:53:52.454 screenresolution[1813:10237] starting screenresolution argv=screenresolution get 10:53:52 INFO - 2016-12-13 10:53:52.457 screenresolution[1813:10237] Display 0: 1600x1200x32@60 10:53:52 INFO - 2016-12-13 10:53:52.463 screenresolution[1814:10240] starting screenresolution argv=screenresolution list 10:53:52 INFO - Available Modes on Display 0 10:53:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:53:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:53:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:53:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:53:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:53:52 INFO - Intel Iris: 10:53:52 INFO - Chipset Model: Intel Iris 10:53:52 INFO - Type: GPU 10:53:52 INFO - Bus: Built-In 10:53:52 INFO - VRAM (Dynamic, Max): 1536 MB 10:53:52 INFO - Vendor: Intel (0x8086) 10:53:52 INFO - Device ID: 0x0a2e 10:53:52 INFO - Revision ID: 0x0009 10:53:52 INFO - Displays: 10:53:52 INFO - Display: 10:53:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:53:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:53:52 INFO - Display Serial Number: 1600x1200 60 10:53:52 INFO - Main Display: Yes 10:53:52 INFO - Mirror: Off 10:53:52 INFO - Online: Yes 10:53:52 INFO - Rotation: Supported 10:53:52 INFO - Return code: 0 10:53:52 INFO - Running post-action listener: _resource_record_post_action 10:53:52 INFO - [mozharness: 2016-12-13 18:53:52.698492Z] Finished run-tests step (success) 10:53:52 INFO - Running post-run listener: _resource_record_post_run 10:53:52 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 32304128; Write bytes: 497502208; Read time: 194; Write time: 1653 10:53:52 INFO - TinderboxPrint: CPU usage
53.3% 10:53:52 INFO - TinderboxPrint: I/O read bytes / time
32,304,128 / 194 10:53:52 INFO - TinderboxPrint: I/O write bytes / time
497,502,208 / 1,653 10:53:52 INFO - TinderboxPrint: CPU idle
2,229.2 (46.7%) 10:53:52 INFO - TinderboxPrint: CPU system
951.2 (19.9%) 10:53:52 INFO - TinderboxPrint: CPU user
1,597.2 (33.4%) 10:53:52 INFO - TinderboxPrint: Swap in / out
223,428,608 / 0 10:53:52 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 187193856; Write bytes: 187602432; Read time: 16834; Write time: 449 10:53:52 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 31378432; Write bytes: 299737600; Read time: 182; Write time: 1174 10:53:53 INFO - Running post-run listener: _upload_blobber_files 10:53:53 INFO - Blob upload gear active. 10:53:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:53:53 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:53:53 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:53:53 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:53:53 INFO - (blobuploader) - INFO - Open directory for files ... 10:53:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:53:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:53:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:53:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:53:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:53:54 INFO - (blobuploader) - INFO - Done attempting. 10:53:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:53:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:53:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:53:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:53:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:53:55 INFO - (blobuploader) - INFO - Done attempting. 10:53:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:53:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:53:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:53:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:53:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:53:57 INFO - (blobuploader) - INFO - Done attempting. 10:53:57 INFO - (blobuploader) - INFO - Iteration through files over. 10:53:57 INFO - Return code: 0 10:53:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:53:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:53:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2431a50e5eece8f6fc0a2112110a621c1a5211bb463bef4dfb07508b74a21616663bb17a0246d2b37e5a5e3f9572f369d54f653d50cbddc363eb8c5401c95b1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0c484acc2d39c3915208ff2d00e2f0ff8ed4ff8d78d4ebd7f3397447d9e1e5f87d30f7bdef00832eeeecda45d0e07d6a5418c9ec323af559eb88cb41427f47a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/650fb89bf8c342a686a297cc45d50166771883ec47abae9348b06b9e1b95c1a6d725796ee443b8a7c5273300269477969f3ec2ffe9bcbe65efe9dc10fed638b8"} 10:53:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:53:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:53:57 INFO - Contents: 10:53:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2431a50e5eece8f6fc0a2112110a621c1a5211bb463bef4dfb07508b74a21616663bb17a0246d2b37e5a5e3f9572f369d54f653d50cbddc363eb8c5401c95b1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0c484acc2d39c3915208ff2d00e2f0ff8ed4ff8d78d4ebd7f3397447d9e1e5f87d30f7bdef00832eeeecda45d0e07d6a5418c9ec323af559eb88cb41427f47a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/650fb89bf8c342a686a297cc45d50166771883ec47abae9348b06b9e1b95c1a6d725796ee443b8a7c5273300269477969f3ec2ffe9bcbe65efe9dc10fed638b8"} 10:53:57 INFO - Running post-run listener: copy_logs_to_upload_dir 10:53:57 INFO - Copying logs to upload dir... 10:53:57 INFO - mkdir: /builds/slave/test/build/upload/logs 10:53:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.612562 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-12-13 10:53:57.999639) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 10:53:58.007466) ========= 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.zs0TJPIMCk/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.3lxPDCsava/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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/2431a50e5eece8f6fc0a2112110a621c1a5211bb463bef4dfb07508b74a21616663bb17a0246d2b37e5a5e3f9572f369d54f653d50cbddc363eb8c5401c95b1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0c484acc2d39c3915208ff2d00e2f0ff8ed4ff8d78d4ebd7f3397447d9e1e5f87d30f7bdef00832eeeecda45d0e07d6a5418c9ec323af559eb88cb41427f47a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/650fb89bf8c342a686a297cc45d50166771883ec47abae9348b06b9e1b95c1a6d725796ee443b8a7c5273300269477969f3ec2ffe9bcbe65efe9dc10fed638b8"} build_url:https://queue.taskcluster.net/v1/task/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011188 build_url: 'https://queue.taskcluster.net/v1/task/DHnjOaFWQjW25x3dRdiRcw/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2431a50e5eece8f6fc0a2112110a621c1a5211bb463bef4dfb07508b74a21616663bb17a0246d2b37e5a5e3f9572f369d54f653d50cbddc363eb8c5401c95b1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a0c484acc2d39c3915208ff2d00e2f0ff8ed4ff8d78d4ebd7f3397447d9e1e5f87d30f7bdef00832eeeecda45d0e07d6a5418c9ec323af559eb88cb41427f47a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/650fb89bf8c342a686a297cc45d50166771883ec47abae9348b06b9e1b95c1a6d725796ee443b8a7c5273300269477969f3ec2ffe9bcbe65efe9dc10fed638b8"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 10:53:58.044657) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:53:58.044988) ========= 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.zs0TJPIMCk/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.3lxPDCsava/Listeners TMPDIR=/var/folders/q6/ldsh2j4d0v57vmzgg283h63800000w/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.005087 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 10:53:58.093725) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 10:53:58.097079) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 10:53:58.097463) ========= ========= Total master_lag: 0.28 =========