builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0211 starttime: 1491197547.18 results: success (0) buildid: 20170402213523 builduid: 28bc8d2985a14e0d97c040c624a03ef4 revision: b7220fe2a194b39e03e0e2156109fd418d317327 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-02 22:32:27.177570) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-02 22:32:27.178037) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-02 22:32:27.178313) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-02 22:32:27.212651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 22:32:27.213037) ========= 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.MdJfoF4nxd/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.9G7SdMUYPA/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-02 22:32:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 27.1M=0s 2017-04-02 22:32:27 (27.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117045 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 22:32:27.356939) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 22:32:27.357376) ========= 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.MdJfoF4nxd/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.9G7SdMUYPA/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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.026274 ========= master_lag: 0.88 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 22:32:28.267024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 22:32:28.267387) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b7220fe2a194b39e03e0e2156109fd418d317327 --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 b7220fe2a194b39e03e0e2156109fd418d317327 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MdJfoF4nxd/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.9G7SdMUYPA/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-02 22:32:28,337 truncating revision to first 12 chars 2017-04-02 22:32:28,337 Setting DEBUG logging. 2017-04-02 22:32:28,337 attempt 1/10 2017-04-02 22:32:28,337 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b7220fe2a194?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-02 22:32:29,016 unpacking tar archive at: mozilla-beta-b7220fe2a194/testing/mozharness/ program finished with exit code 0 elapsedTime=0.956654 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 22:32:29.248097) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-02 22:32:29.248404) ========= script_repo_revision: b7220fe2a194b39e03e0e2156109fd418d317327 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-02 22:32:29.248789) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-02 22:32:29.249119) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-02 22:32:29.269316) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-04-02 22:32:29.269798) ========= /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.MdJfoF4nxd/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.9G7SdMUYPA/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 22:32:29 INFO - MultiFileLogger online at 20170402 22:32:29 in /builds/slave/test 22:32:29 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 22:32:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:32:29 INFO - {'append_to_log': False, 22:32:29 INFO - 'base_work_dir': '/builds/slave/test', 22:32:29 INFO - 'blob_upload_branch': 'Mozilla-Beta', 22:32:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:32:29 INFO - 'branch': 'Mozilla-Beta', 22:32:29 INFO - 'buildbot_json_path': 'buildprops.json', 22:32:29 INFO - 'config_files': ('talos/mac_config.py',), 22:32:29 INFO - 'default_actions': ('clobber', 22:32:29 INFO - 'read-buildbot-config', 22:32:29 INFO - 'download-and-extract', 22:32:29 INFO - 'populate-webroot', 22:32:29 INFO - 'create-virtualenv', 22:32:29 INFO - 'install', 22:32:29 INFO - 'run-tests'), 22:32:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:32:29 INFO - 'download_minidump_stackwalk': True, 22:32:29 INFO - 'download_symbols': 'ondemand', 22:32:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:32:29 INFO - 'tooltool.py': '/tools/tooltool.py', 22:32:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:32:29 INFO - '/tools/misc-python/virtualenv.py')}, 22:32:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:32:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:32:29 INFO - 'installer_path': 'installer.exe', 22:32:29 INFO - 'log_level': 'info', 22:32:29 INFO - 'log_name': 'talos', 22:32:29 INFO - 'log_to_console': True, 22:32:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:32:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:32:29 INFO - 'opt_config_files': (), 22:32:29 INFO - 'pip_index': False, 22:32:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:32:29 INFO - 'cmd': ('bash', 22:32:29 INFO - '-c', 22:32:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:32:29 INFO - 'enabled': True, 22:32:29 INFO - 'halt_on_failure': False, 22:32:29 INFO - 'name': 'check_screen_resolution'},), 22:32:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:32:29 INFO - 'cmd': ('bash', 22:32:29 INFO - '-c', 22:32:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:32:29 INFO - 'enabled': True, 22:32:29 INFO - 'halt_on_failure': False, 22:32:29 INFO - 'name': 'check_screen_resolution'},), 22:32:29 INFO - 'run_cmd_checks_enabled': True, 22:32:29 INFO - 'sps_profile': False, 22:32:29 INFO - 'sps_profile_interval': 0, 22:32:29 INFO - 'suite': 'dromaeojs', 22:32:29 INFO - 'system_bits': '32', 22:32:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:32:29 INFO - 'title': 't-yosemite-r7-0211', 22:32:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:32:29 INFO - 'use_talos_json': True, 22:32:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:32:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:32:29 INFO - 'work_dir': 'build'} 22:32:29 INFO - [mozharness: 2017-04-03 05:32:29.441327Z] Running clobber step. 22:32:29 INFO - Running pre-action listener: _resource_record_pre_action 22:32:29 INFO - Running main action method: clobber 22:32:29 INFO - rmtree: /builds/slave/test/build 22:32:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:32:31 INFO - Running post-action listener: _resource_record_post_action 22:32:31 INFO - [mozharness: 2017-04-03 05:32:31.969633Z] Finished clobber step (success) 22:32:31 INFO - [mozharness: 2017-04-03 05:32:31.969799Z] Running read-buildbot-config step. 22:32:31 INFO - Running pre-action listener: _resource_record_pre_action 22:32:31 INFO - Running main action method: read_buildbot_config 22:32:31 INFO - Using buildbot properties: 22:32:31 INFO - { 22:32:31 INFO - "project": "", 22:32:31 INFO - "product": "firefox", 22:32:31 INFO - "script_repo_revision": "production", 22:32:31 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 22:32:31 INFO - "repository": "", 22:32:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 22:32:31 INFO - "buildid": "20170402213523", 22:32:31 INFO - "pgo_build": "False", 22:32:31 INFO - "basedir": "/builds/slave/test", 22:32:31 INFO - "buildnumber": 9, 22:32:31 INFO - "slavename": "t-yosemite-r7-0211", 22:32:31 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 22:32:31 INFO - "platform": "yosemite_r7", 22:32:31 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 22:32:31 INFO - "branch": "mozilla-beta", 22:32:31 INFO - "repo_path": "releases/mozilla-beta", 22:32:31 INFO - "revision": "b7220fe2a194b39e03e0e2156109fd418d317327", 22:32:31 INFO - "stage_platform": "macosx64", 22:32:31 INFO - "builduid": "28bc8d2985a14e0d97c040c624a03ef4", 22:32:31 INFO - "slavebuilddir": "test" 22:32:31 INFO - } 22:32:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 22:32:31 INFO - Running post-action listener: _resource_record_post_action 22:32:31 INFO - [mozharness: 2017-04-03 05:32:31.973151Z] Finished read-buildbot-config step (success) 22:32:31 INFO - [mozharness: 2017-04-03 05:32:31.973245Z] Running download-and-extract step. 22:32:31 INFO - Running pre-action listener: _resource_record_pre_action 22:32:31 INFO - Running main action method: download_and_extract 22:32:31 INFO - mkdir: /builds/slave/test/build/tests 22:32:31 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')]} 22:32:31 INFO - trying https://queue.taskcluster.net/v1/task/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 22:32:31 INFO - Downloading https://queue.taskcluster.net/v1/task/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 22:32:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 22:32:32 INFO - Downloaded 1165 bytes. 22:32:32 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 22:32:32 INFO - Using the following test package requirements: 22:32:32 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 22:32:32 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 22:32:32 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 22:32:32 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 22:32:32 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 22:32:32 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 22:32:32 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 22:32:32 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 22:32:32 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 22:32:32 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 22:32:32 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 22:32:32 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 22:32:32 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 22:32:32 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 22:32:32 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 22:32:32 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 22:32:32 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 22:32:32 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 22:32:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 22:32:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 22:32:32 INFO - Fetch https://queue.taskcluster.net/v1/task/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 22:32:33 INFO - Expected file size: 16109788 22:32:33 INFO - Obtained file size: 16109788 22:32:39 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 22:32:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 22:32:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 22:32:39 INFO - Fetch https://queue.taskcluster.net/v1/task/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 22:32:40 INFO - Expected file size: 16109788 22:32:40 INFO - Obtained file size: 16109788 22:32:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 22:32:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 22:32:47 INFO - Fetch https://queue.taskcluster.net/v1/task/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 22:32:47 INFO - Expected file size: 14403663 22:32:47 INFO - Obtained file size: 14403663 22:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:32:48 INFO - trying https://queue.taskcluster.net/v1/task/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 22:32:48 INFO - Downloading https://queue.taskcluster.net/v1/task/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 22:32:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 22:32:50 INFO - Downloaded 58726446 bytes. 22:32:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 22:32:50 INFO - mkdir: /builds/slave/test/properties 22:32:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:32:50 INFO - Writing to file /builds/slave/test/properties/build_url 22:32:50 INFO - Contents: 22:32:50 INFO - build_url:https://queue.taskcluster.net/v1/task/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 22:32:51 INFO - Running post-action listener: _resource_record_post_action 22:32:51 INFO - Running post-action listener: set_extra_try_arguments 22:32:51 INFO - [mozharness: 2017-04-03 05:32:51.126389Z] Finished download-and-extract step (success) 22:32:51 INFO - [mozharness: 2017-04-03 05:32:51.126531Z] Running populate-webroot step. 22:32:51 INFO - Running pre-action listener: _resource_record_pre_action 22:32:51 INFO - Running main action method: populate_webroot 22:32:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:32:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:32:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:32:51 INFO - '--tppagecycles', 22:32:51 INFO - '7'], 22:32:51 INFO - 'tests': ['tsvgm']}}, 22:32:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:32:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:32:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:32:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:32:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:32:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:32:51 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:32:51 INFO - 'talos_options': ['--disable-e10s'], 22:32:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:32:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:32:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:32:51 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:32:51 INFO - 'talos_options': ['--disable-e10s'], 22:32:51 INFO - 'tests': ['damp', 'tps']}, 22:32:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:32:51 INFO - 'tests': ['damp', 'tps']}, 22:32:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:32:51 INFO - 'tests': ['dromaeo_dom']}, 22:32:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:32:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:32:51 INFO - 'tests': ['basic_compositor_video']}, 22:32:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:32:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:32:51 INFO - 'tests': ['a11yr', 22:32:51 INFO - 'ts_paint', 22:32:51 INFO - 'tpaint', 22:32:51 INFO - 'sessionrestore', 22:32:51 INFO - 'sessionrestore_no_auto_restore', 22:32:51 INFO - 'tabpaint']}, 22:32:51 INFO - 'other-e10s': {'tests': ['a11yr', 22:32:51 INFO - 'ts_paint', 22:32:51 INFO - 'tpaint', 22:32:51 INFO - 'sessionrestore', 22:32:51 INFO - 'sessionrestore_no_auto_restore', 22:32:51 INFO - 'tabpaint']}, 22:32:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:32:51 INFO - 'ts_paint', 22:32:51 INFO - 'tpaint', 22:32:51 INFO - 'sessionrestore', 22:32:51 INFO - 'sessionrestore_no_auto_restore', 22:32:51 INFO - 'tabpaint']}, 22:32:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:32:51 INFO - 'ts_paint', 22:32:51 INFO - 'tpaint', 22:32:51 INFO - 'sessionrestore', 22:32:51 INFO - 'sessionrestore_no_auto_restore', 22:32:51 INFO - 'tabpaint']}, 22:32:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:32:51 INFO - 'tests': ['a11yr', 22:32:51 INFO - 'ts_paint', 22:32:51 INFO - 'tpaint', 22:32:51 INFO - 'sessionrestore', 22:32:51 INFO - 'sessionrestore_no_auto_restore', 22:32:51 INFO - 'tabpaint']}, 22:32:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:32:51 INFO - 'tests': ['a11yr', 22:32:51 INFO - 'ts_paint', 22:32:51 INFO - 'tpaint', 22:32:51 INFO - 'sessionrestore', 22:32:51 INFO - 'sessionrestore_no_auto_restore', 22:32:51 INFO - 'tabpaint']}, 22:32:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:32:51 INFO - 'tests': ['tsvgx', 22:32:51 INFO - 'tsvgr_opacity', 22:32:51 INFO - 'tart', 22:32:51 INFO - 'tscrollx', 22:32:51 INFO - 'cart', 22:32:51 INFO - 'tsvg_static']}, 22:32:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:32:51 INFO - 'tsvgr_opacity', 22:32:51 INFO - 'tart', 22:32:51 INFO - 'tscrollx', 22:32:51 INFO - 'cart', 22:32:51 INFO - 'tsvg_static']}, 22:32:51 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:32:51 INFO - 'talos_options': ['--disable-e10s'], 22:32:51 INFO - 'tests': ['tp5o']}, 22:32:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:32:51 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:32:51 INFO - 'talos_options': ['--disable-e10s', 22:32:51 INFO - '--xperf_path', 22:32:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:32:51 INFO - 'tests': ['tp5n']}, 22:32:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:32:51 INFO - 'talos_options': ['--xperf_path', 22:32:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:32:51 INFO - 'tests': ['tp5n']}}, 22:32:51 INFO - 'talos.zip': {'path': '', 22:32:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:32:51 INFO - Running post-action listener: _resource_record_post_action 22:32:51 INFO - [mozharness: 2017-04-03 05:32:51.144788Z] Finished populate-webroot step (success) 22:32:51 INFO - [mozharness: 2017-04-03 05:32:51.144913Z] Running create-virtualenv step. 22:32:51 INFO - Running pre-action listener: _resource_record_pre_action 22:32:51 INFO - Running main action method: create_virtualenv 22:32:51 INFO - Creating virtualenv /builds/slave/test/build/venv 22:32:51 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 22:32:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:32:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:32:51 INFO - Using real prefix '/tools/python27' 22:32:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:32:51 INFO - Installing distribute.............................................................................................................................................................................................done. 22:32:54 INFO - Installing pip.................done. 22:32:54 INFO - Return code: 0 22:32:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:32:55 INFO - Reading from file tmpfile_stdout 22:32:55 INFO - Output received: 22:32:55 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 22:32:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109accb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109acf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99f84abad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098aad30>, '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 0x1097d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10989fbe8>, '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.MdJfoF4nxd/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.9G7SdMUYPA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 22:32:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:32:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MdJfoF4nxd/Render', 22:32:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:32:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:32:55 INFO - 'HOME': '/Users/cltbld', 22:32:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:32:55 INFO - 'LOGNAME': 'cltbld', 22:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:55 INFO - 'MOZ_NO_REMOTE': '1', 22:32:55 INFO - 'NO_EM_RESTART': '1', 22:32:55 INFO - 'PAGER': '/bin/cat', 22:32:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:55 INFO - 'PWD': '/builds/slave/test', 22:32:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:32:55 INFO - 'SHELL': '/bin/bash', 22:32:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9G7SdMUYPA/Listeners', 22:32:55 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 22:32:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:32:55 INFO - 'USER': 'cltbld', 22:32:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:32:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:55 INFO - 'XPC_FLAGS': '0x0', 22:32:55 INFO - 'XPC_SERVICE_NAME': '0', 22:32:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:32:55 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 22:32:55 INFO - Cleaning up... 22:32:55 INFO - Return code: 0 22:32:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109accb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109acf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99f84abad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098aad30>, '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 0x1097d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10989fbe8>, '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.MdJfoF4nxd/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.9G7SdMUYPA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 22:32:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:32:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MdJfoF4nxd/Render', 22:32:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:32:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:32:55 INFO - 'HOME': '/Users/cltbld', 22:32:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:32:55 INFO - 'LOGNAME': 'cltbld', 22:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:55 INFO - 'MOZ_NO_REMOTE': '1', 22:32:55 INFO - 'NO_EM_RESTART': '1', 22:32:55 INFO - 'PAGER': '/bin/cat', 22:32:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:55 INFO - 'PWD': '/builds/slave/test', 22:32:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:32:55 INFO - 'SHELL': '/bin/bash', 22:32:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9G7SdMUYPA/Listeners', 22:32:55 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 22:32:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:32:55 INFO - 'USER': 'cltbld', 22:32:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:32:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:55 INFO - 'XPC_FLAGS': '0x0', 22:32:55 INFO - 'XPC_SERVICE_NAME': '0', 22:32:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:32:55 INFO - Downloading/unpacking psutil>=3.1.1 22:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:32:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:32:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:32:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:32:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:32:59 INFO - Installing collected packages: psutil 22:32:59 INFO - Running setup.py install for psutil 22:32:59 INFO - building 'psutil._psutil_osx' extension 22:32:59 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 22:32:59 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 22:32:59 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 22:32:59 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 22:32:59 INFO - building 'psutil._psutil_posix' extension 22:32:59 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 22:32:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:32:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:32:59 INFO - ^ 22:33:00 INFO - 1 warning generated. 22:33:00 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 22:33:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:33:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:33:00 INFO - Successfully installed psutil 22:33:00 INFO - Cleaning up... 22:33:00 INFO - Return code: 0 22:33:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:33:00 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')]} 22:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:00 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')]} 22:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:00 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 0x109accb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109acf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99f84abad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098aad30>, '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 0x1097d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10989fbe8>, '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.MdJfoF4nxd/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.9G7SdMUYPA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 22:33:00 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 22:33:00 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 22:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MdJfoF4nxd/Render', 22:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:33:00 INFO - 'HOME': '/Users/cltbld', 22:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:33:00 INFO - 'LOGNAME': 'cltbld', 22:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:00 INFO - 'MOZ_NO_REMOTE': '1', 22:33:00 INFO - 'NO_EM_RESTART': '1', 22:33:00 INFO - 'PAGER': '/bin/cat', 22:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:00 INFO - 'PWD': '/builds/slave/test', 22:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:33:00 INFO - 'SHELL': '/bin/bash', 22:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9G7SdMUYPA/Listeners', 22:33:00 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 22:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:33:00 INFO - 'USER': 'cltbld', 22:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:00 INFO - 'XPC_FLAGS': '0x0', 22:33:00 INFO - 'XPC_SERVICE_NAME': '0', 22:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:33:00 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 22:33:00 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 22:33:00 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 22:33:00 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 22:33:00 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 22:33:00 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 22:33:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:33:03 INFO - Installing collected packages: mozsystemmonitor 22:33:03 INFO - Running setup.py install for mozsystemmonitor 22:33:03 INFO - Successfully installed mozsystemmonitor 22:33:03 INFO - Cleaning up... 22:33:03 INFO - Return code: 0 22:33:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:33:03 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')]} 22:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:03 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')]} 22:33:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:03 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 0x109accb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109acf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99f84abad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098aad30>, '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 0x1097d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10989fbe8>, '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.MdJfoF4nxd/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.9G7SdMUYPA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 22:33:03 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 22:33:03 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 22:33:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MdJfoF4nxd/Render', 22:33:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:33:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:33:03 INFO - 'HOME': '/Users/cltbld', 22:33:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:33:03 INFO - 'LOGNAME': 'cltbld', 22:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:03 INFO - 'MOZ_NO_REMOTE': '1', 22:33:03 INFO - 'NO_EM_RESTART': '1', 22:33:03 INFO - 'PAGER': '/bin/cat', 22:33:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:03 INFO - 'PWD': '/builds/slave/test', 22:33:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:33:03 INFO - 'SHELL': '/bin/bash', 22:33:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9G7SdMUYPA/Listeners', 22:33:03 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 22:33:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:33:03 INFO - 'USER': 'cltbld', 22:33:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:33:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:03 INFO - 'XPC_FLAGS': '0x0', 22:33:03 INFO - 'XPC_SERVICE_NAME': '0', 22:33:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:03 INFO - Downloading/unpacking jsonschema==2.5.1 22:33:03 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 22:33:03 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 22:33:03 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 22:33:03 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 22:33:03 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 22:33:03 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 22:33:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:33:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:33:06 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 22:33:06 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 22:33:06 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 22:33:06 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 22:33:06 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 22:33:06 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 22:33:06 INFO - Downloading functools32-3.2.3-2.tar.gz 22:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:33:06 INFO - warning: no files found matching '*.txt' 22:33:06 INFO - no previously-included directories found matching 'build' 22:33:06 INFO - no previously-included directories found matching 'dist' 22:33:06 INFO - no previously-included directories found matching '.git*' 22:33:06 INFO - Installing collected packages: jsonschema, functools32 22:33:06 INFO - Running setup.py install for functools32 22:33:07 INFO - warning: no files found matching '*.txt' 22:33:07 INFO - no previously-included directories found matching 'build' 22:33:07 INFO - no previously-included directories found matching 'dist' 22:33:07 INFO - no previously-included directories found matching '.git*' 22:33:07 INFO - Successfully installed jsonschema functools32 22:33:07 INFO - Cleaning up... 22:33:07 INFO - Return code: 0 22:33:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:07 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 0x109accb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109acf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99f84abad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098aad30>, '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 0x1097d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10989fbe8>, '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.MdJfoF4nxd/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.9G7SdMUYPA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 22:33:07 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 22:33:07 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 22:33:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MdJfoF4nxd/Render', 22:33:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:33:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:33:07 INFO - 'HOME': '/Users/cltbld', 22:33:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:33:07 INFO - 'LOGNAME': 'cltbld', 22:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:07 INFO - 'MOZ_NO_REMOTE': '1', 22:33:07 INFO - 'NO_EM_RESTART': '1', 22:33:07 INFO - 'PAGER': '/bin/cat', 22:33:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:07 INFO - 'PWD': '/builds/slave/test', 22:33:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:33:07 INFO - 'SHELL': '/bin/bash', 22:33:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9G7SdMUYPA/Listeners', 22:33:07 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 22:33:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:33:07 INFO - 'USER': 'cltbld', 22:33:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:33:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:07 INFO - 'XPC_FLAGS': '0x0', 22:33:07 INFO - 'XPC_SERVICE_NAME': '0', 22:33:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:33:07 INFO - Cleaning up... 22:33:07 INFO - Return code: 0 22:33:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:07 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 0x109accb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109acf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99f84abad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098aad30>, '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 0x1097d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10989fbe8>, '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.MdJfoF4nxd/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.9G7SdMUYPA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 22:33:07 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 22:33:07 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 22:33:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MdJfoF4nxd/Render', 22:33:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:33:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:33:07 INFO - 'HOME': '/Users/cltbld', 22:33:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:33:07 INFO - 'LOGNAME': 'cltbld', 22:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:07 INFO - 'MOZ_NO_REMOTE': '1', 22:33:07 INFO - 'NO_EM_RESTART': '1', 22:33:07 INFO - 'PAGER': '/bin/cat', 22:33:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:07 INFO - 'PWD': '/builds/slave/test', 22:33:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:33:07 INFO - 'SHELL': '/bin/bash', 22:33:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9G7SdMUYPA/Listeners', 22:33:07 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 22:33:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:33:07 INFO - 'USER': 'cltbld', 22:33:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:33:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:07 INFO - 'XPC_FLAGS': '0x0', 22:33:07 INFO - 'XPC_SERVICE_NAME': '0', 22:33:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:07 INFO - Downloading/unpacking blobuploader==1.2.4 22:33:07 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 22:33:07 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 22:33:07 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 22:33:07 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 22:33:07 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 22:33:07 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 22:33:10 INFO - Downloading blobuploader-1.2.4.tar.gz 22:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:33:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:33:10 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 22:33:10 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 22:33:10 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 22:33:10 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 22:33:10 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 22:33:10 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 22:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:33:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:33:11 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 22:33:11 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 22:33:11 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 22:33:11 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 22:33:11 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 22:33:11 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 22:33:11 INFO - Downloading docopt-0.6.1.tar.gz 22:33:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:33:11 INFO - Installing collected packages: blobuploader, requests, docopt 22:33:11 INFO - Running setup.py install for blobuploader 22:33:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:33:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:33:11 INFO - Running setup.py install for requests 22:33:12 INFO - Running setup.py install for docopt 22:33:12 INFO - Successfully installed blobuploader requests docopt 22:33:12 INFO - Cleaning up... 22:33:12 INFO - Return code: 0 22:33:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:33:12 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')]} 22:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:12 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')]} 22:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:13 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 0x109accb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109acf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99f84abad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098aad30>, '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 0x1097d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10989fbe8>, '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.MdJfoF4nxd/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.9G7SdMUYPA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 22:33:13 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 22:33:13 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 22:33:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MdJfoF4nxd/Render', 22:33:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:33:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:33:13 INFO - 'HOME': '/Users/cltbld', 22:33:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:33:13 INFO - 'LOGNAME': 'cltbld', 22:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:13 INFO - 'MOZ_NO_REMOTE': '1', 22:33:13 INFO - 'NO_EM_RESTART': '1', 22:33:13 INFO - 'PAGER': '/bin/cat', 22:33:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:13 INFO - 'PWD': '/builds/slave/test', 22:33:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:33:13 INFO - 'SHELL': '/bin/bash', 22:33:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9G7SdMUYPA/Listeners', 22:33:13 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 22:33:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:33:13 INFO - 'USER': 'cltbld', 22:33:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:33:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:13 INFO - 'XPC_FLAGS': '0x0', 22:33:13 INFO - 'XPC_SERVICE_NAME': '0', 22:33:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:33:13 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-OXiD8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:33:13 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-jJCn29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:33:13 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-kGlOCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:33:13 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-kAoDTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:33:14 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-qVVM5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:33:14 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-5V0brM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:33:14 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-nb4U_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:33:14 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-PeZVpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:33:14 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-0rbpfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:33:14 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-0MSmT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:33:14 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-JkYh7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:33:14 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-eFb1_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:33:14 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-840kQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:33:14 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-Tduhkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:15 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-5tI0fe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:33:15 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-ZfE15z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:33:15 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-oTInfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:33:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:33:15 INFO - Running setup.py install for manifestparser 22:33:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:33:15 INFO - Running setup.py install for mozcrash 22:33:15 INFO - Running setup.py install for mozdebug 22:33:15 INFO - Running setup.py install for mozdevice 22:33:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:33:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:33:16 INFO - Running setup.py install for mozfile 22:33:16 INFO - Running setup.py install for mozhttpd 22:33:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:33:16 INFO - Running setup.py install for mozinfo 22:33:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:33:16 INFO - Running setup.py install for mozInstall 22:33:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:33:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:33:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:33:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:33:16 INFO - Running setup.py install for mozleak 22:33:16 INFO - Running setup.py install for mozlog 22:33:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:33:16 INFO - Running setup.py install for moznetwork 22:33:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:33:17 INFO - Running setup.py install for mozprocess 22:33:17 INFO - Running setup.py install for mozprofile 22:33:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:33:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:33:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:33:17 INFO - Running setup.py install for mozrunner 22:33:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:33:17 INFO - Running setup.py install for mozscreenshot 22:33:17 INFO - Running setup.py install for moztest 22:33:17 INFO - Running setup.py install for mozversion 22:33:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:33:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:33:18 INFO - Cleaning up... 22:33:18 INFO - Return code: 0 22:33:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:33:18 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')]} 22:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:18 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')]} 22:33:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:18 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 0x109accb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109acf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99f84abad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098aad30>, '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 0x1097d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10989fbe8>, '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.MdJfoF4nxd/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.9G7SdMUYPA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 22:33:18 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 22:33:18 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 22:33:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MdJfoF4nxd/Render', 22:33:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:33:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:33:18 INFO - 'HOME': '/Users/cltbld', 22:33:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:33:18 INFO - 'LOGNAME': 'cltbld', 22:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:18 INFO - 'MOZ_NO_REMOTE': '1', 22:33:18 INFO - 'NO_EM_RESTART': '1', 22:33:18 INFO - 'PAGER': '/bin/cat', 22:33:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:18 INFO - 'PWD': '/builds/slave/test', 22:33:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:33:18 INFO - 'SHELL': '/bin/bash', 22:33:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9G7SdMUYPA/Listeners', 22:33:18 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 22:33:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:33:18 INFO - 'USER': 'cltbld', 22:33:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:33:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:18 INFO - 'XPC_FLAGS': '0x0', 22:33:18 INFO - 'XPC_SERVICE_NAME': '0', 22:33:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:33:18 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-1fhZDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:33:18 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)) 22:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:33:18 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-_nwRxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:33:18 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-Vx3o7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:33:19 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)) 22:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:33:19 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-ehUtPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:33:19 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-IIMRf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:33:19 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)) 22:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:33:19 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-3DEdXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:33:19 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)) 22:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:33:19 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-TPvzIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:33:19 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)) 22:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:33:19 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-dmEep2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:33:19 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)) 22:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:33:19 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-Fekh4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:33:19 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)) 22:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:33:19 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-3df453-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:33:19 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)) 22:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:33:19 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-S_h3nN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:33:19 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)) 22:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:33:19 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-Y98vTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 22:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:33:20 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-Zk2Uuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:33:20 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)) 22:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:33:20 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-DmLNZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:20 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-SeCwNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:20 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)) 22:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:33:20 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-ckIrsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:33:20 INFO - Running setup.py (path:/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/pip-pxAVpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:33:20 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)) 22:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:33:20 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)) 22:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:33:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:33:20 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 22:33:20 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 22:33:20 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 22:33:20 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 22:33:20 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 22:33:20 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 22:33:23 INFO - Downloading blessings-1.6.tar.gz 22:33:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:33:23 INFO - Installing collected packages: blessings 22:33:23 INFO - Running setup.py install for blessings 22:33:23 INFO - Successfully installed blessings 22:33:23 INFO - Cleaning up... 22:33:23 INFO - Return code: 0 22:33:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:33:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:33:24 INFO - Reading from file tmpfile_stdout 22:33:24 INFO - Current package versions: 22:33:24 INFO - blessings == 1.6 22:33:24 INFO - blobuploader == 1.2.4 22:33:24 INFO - docopt == 0.6.1 22:33:24 INFO - functools32 == 3.2.3-2 22:33:24 INFO - jsonschema == 2.5.1 22:33:24 INFO - manifestparser == 1.1 22:33:24 INFO - mozInstall == 1.12 22:33:24 INFO - mozcrash == 1.0 22:33:24 INFO - mozdebug == 0.1 22:33:24 INFO - mozdevice == 0.49 22:33:24 INFO - mozfile == 1.2 22:33:24 INFO - mozhttpd == 0.7 22:33:24 INFO - mozinfo == 0.9 22:33:24 INFO - mozleak == 0.1 22:33:24 INFO - mozlog == 3.4 22:33:24 INFO - moznetwork == 0.27 22:33:24 INFO - mozprocess == 0.24 22:33:24 INFO - mozprofile == 0.28 22:33:24 INFO - mozrunner == 6.13 22:33:24 INFO - mozscreenshot == 0.1 22:33:24 INFO - mozsystemmonitor == 0.3 22:33:24 INFO - moztest == 0.8 22:33:24 INFO - mozversion == 1.4 22:33:24 INFO - psutil == 3.1.1 22:33:24 INFO - requests == 1.2.3 22:33:24 INFO - wsgiref == 0.1.2 22:33:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:24 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 0x109accb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109acf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99f84abad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098aad30>, '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 0x1097d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10989fbe8>, '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.MdJfoF4nxd/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.9G7SdMUYPA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 22:33:24 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 22:33:24 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 22:33:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MdJfoF4nxd/Render', 22:33:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:33:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:33:24 INFO - 'HOME': '/Users/cltbld', 22:33:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:33:24 INFO - 'LOGNAME': 'cltbld', 22:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:24 INFO - 'MOZ_NO_REMOTE': '1', 22:33:24 INFO - 'NO_EM_RESTART': '1', 22:33:24 INFO - 'PAGER': '/bin/cat', 22:33:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:24 INFO - 'PWD': '/builds/slave/test', 22:33:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:33:24 INFO - 'SHELL': '/bin/bash', 22:33:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9G7SdMUYPA/Listeners', 22:33:24 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 22:33:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:33:24 INFO - 'USER': 'cltbld', 22:33:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:33:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:24 INFO - 'XPC_FLAGS': '0x0', 22:33:24 INFO - 'XPC_SERVICE_NAME': '0', 22:33:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:33:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:24 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)) 22:33:24 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)) 22:33:24 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)) 22:33:24 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)) 22:33:24 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)) 22:33:24 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)) 22:33:24 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)) 22:33:24 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)) 22:33:24 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)) 22:33:24 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)) 22:33:24 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)) 22:33:24 INFO - Cleaning up... 22:33:24 INFO - Return code: 0 22:33:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109accb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109acf768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99f84abad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1098aad30>, '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 0x1097d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10989fbe8>, '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.MdJfoF4nxd/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.9G7SdMUYPA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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 22:33:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:33:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MdJfoF4nxd/Render', 22:33:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:33:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:33:24 INFO - 'HOME': '/Users/cltbld', 22:33:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:33:24 INFO - 'LOGNAME': 'cltbld', 22:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:24 INFO - 'MOZ_NO_REMOTE': '1', 22:33:24 INFO - 'NO_EM_RESTART': '1', 22:33:24 INFO - 'PAGER': '/bin/cat', 22:33:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:24 INFO - 'PWD': '/builds/slave/test', 22:33:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:33:24 INFO - 'SHELL': '/bin/bash', 22:33:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9G7SdMUYPA/Listeners', 22:33:24 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 22:33:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:33:24 INFO - 'USER': 'cltbld', 22:33:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:33:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:24 INFO - 'XPC_FLAGS': '0x0', 22:33:24 INFO - 'XPC_SERVICE_NAME': '0', 22:33:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:33:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:33:24 INFO - Cleaning up... 22:33:24 INFO - Return code: 0 22:33:24 INFO - Running post-action listener: _resource_record_post_action 22:33:24 INFO - Running post-action listener: _start_resource_monitoring 22:33:24 INFO - Starting resource monitoring. 22:33:24 INFO - [mozharness: 2017-04-03 05:33:24.780098Z] Finished create-virtualenv step (success) 22:33:24 INFO - [mozharness: 2017-04-03 05:33:24.781020Z] Running install step. 22:33:24 INFO - Running pre-action listener: _resource_record_pre_action 22:33:24 INFO - Running main action method: install 22:33:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:33:25 INFO - Reading from file tmpfile_stdout 22:33:25 INFO - Detecting whether we're running mozinstall >=1.0... 22:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:33:25 INFO - Reading from file tmpfile_stdout 22:33:25 INFO - Output received: 22:33:25 INFO - Usage: mozinstall [options] installer 22:33:25 INFO - Options: 22:33:25 INFO - -h, --help show this help message and exit 22:33:25 INFO - -d DEST, --destination=DEST 22:33:25 INFO - Directory to install application into. [default: 22:33:25 INFO - "/builds/slave/test"] 22:33:25 INFO - --app=APP Application being installed. [default: firefox] 22:33:25 INFO - mkdir: /builds/slave/test/build/application 22:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 22:33:39 INFO - Reading from file tmpfile_stdout 22:33:39 INFO - Output received: 22:33:39 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 22:33:39 INFO - Running post-action listener: _resource_record_post_action 22:33:39 INFO - [mozharness: 2017-04-03 05:33:39.736176Z] Finished install step (success) 22:33:39 INFO - [mozharness: 2017-04-03 05:33:39.736305Z] Running run-tests step. 22:33:39 INFO - Running pre-action listener: _resource_record_pre_action 22:33:39 INFO - Running main action method: run_tests 22:33:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:33:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:33:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:33:39 INFO - 2017-04-02 22:33:39.750 screenresolution[1622:7462] starting screenresolution argv=screenresolution get 22:33:39 INFO - 2017-04-02 22:33:39.753 screenresolution[1622:7462] Display 0: 1600x1200x32@60 22:33:39 INFO - 2017-04-02 22:33:39.759 screenresolution[1623:7464] starting screenresolution argv=screenresolution list 22:33:39 INFO - Available Modes on Display 0 22:33:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:33:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:33:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:33:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:33:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:33:39 INFO - Intel Iris: 22:33:39 INFO - Chipset Model: Intel Iris 22:33:39 INFO - Type: GPU 22:33:39 INFO - Bus: Built-In 22:33:39 INFO - VRAM (Dynamic, Max): 1536 MB 22:33:39 INFO - Vendor: Intel (0x8086) 22:33:39 INFO - Device ID: 0x0a2e 22:33:39 INFO - Revision ID: 0x0009 22:33:39 INFO - Displays: 22:33:39 INFO - Display: 22:33:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:33:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:33:39 INFO - Display Serial Number: 1600x1200 60 22:33:39 INFO - Main Display: Yes 22:33:39 INFO - Mirror: Off 22:33:39 INFO - Online: Yes 22:33:39 INFO - Rotation: Supported 22:33:39 INFO - Return code: 0 22:33:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:33:39 INFO - Python 2.7.3 22:33:39 INFO - Return code: 0 22:33:39 INFO - grabbing minidump binary from tooltool 22:33:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:33:39 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 0x1098aad30>, '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 0x1097d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10989fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:33:39 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 22:33:39 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 22:33:39 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 22:33:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:33:40 INFO - Return code: 0 22:33:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:33:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:33:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:33:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:33:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:33:40 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/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0211', '--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 22:33:40 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/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0211 --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 22:33:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MdJfoF4nxd/Render', 22:33:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:33:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:33:40 INFO - 'HOME': '/Users/cltbld', 22:33:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:33:40 INFO - 'LOGNAME': 'cltbld', 22:33:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:33:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:40 INFO - 'MOZ_NO_REMOTE': '1', 22:33:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:33:40 INFO - 'NO_EM_RESTART': '1', 22:33:40 INFO - 'PAGER': '/bin/cat', 22:33:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:40 INFO - 'PWD': '/builds/slave/test', 22:33:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:33:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:33:40 INFO - 'SHELL': '/bin/bash', 22:33:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9G7SdMUYPA/Listeners', 22:33:40 INFO - 'TMPDIR': '/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/', 22:33:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:33:40 INFO - 'USER': 'cltbld', 22:33:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:33:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:40 INFO - 'XPC_FLAGS': '0x0', 22:33:40 INFO - 'XPC_SERVICE_NAME': '0', 22:33:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:33:40 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/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0211', '--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 22:33:40 INFO - mozversion application_buildid: 20170402213523 22:33:40 INFO - mozversion application_changeset: b7220fe2a194b39e03e0e2156109fd418d317327 22:33:40 INFO - mozversion application_display_name: Firefox 22:33:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:33:40 INFO - mozversion application_name: Firefox 22:33:40 INFO - mozversion application_remotingname: firefox 22:33:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 22:33:40 INFO - mozversion application_vendor: Mozilla 22:33:40 INFO - mozversion application_version: 53.0 22:33:40 INFO - mozversion platform_buildid: 20170402213523 22:33:40 INFO - mozversion platform_changeset: b7220fe2a194b39e03e0e2156109fd418d317327 22:33:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 22:33:40 INFO - mozversion platform_version: 53.0 22:33:40 INFO - using testdate: 1491197620 22:33:40 INFO - actual date: 1491197620 22:33:40 INFO - starting webserver on 'localhost:49250' 22:33:40 INFO - SUITE-START | Running 2 tests 22:33:40 INFO - TEST-START | dromaeo_css 22:33:40 INFO - operating with platform_type : mac_ 22:33:40 INFO - Initialising browser for dromaeo_css test... 22:33:40 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/tmpv8mhqK/profile http://localhost:49250/getInfo.html) 22:33:42 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 22:33:42 INFO - PROCESS | 1633 | colorDepth:24 22:33:42 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 22:33:42 INFO - PROCESS | 1633 | __metrics 22:33:42 INFO - PROCESS | 1633 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:33:42 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:33:43 INFO - TEST-INFO | 1633: exit 0 22:33:43 INFO - Browser initialized. 22:33:43 INFO - Running cycle 1/1 for dromaeo_css test... 22:33:43 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/tmpv8mhqK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:33:55 INFO - PROCESS | 1636 | RSS: Main: 163459072 22:33:55 INFO - PROCESS | 1636 | 22:36:57 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 22:36:59 INFO - PROCESS | 1636 | RSS: Main: 332951552 22:36:59 INFO - PROCESS | 1636 | 22:40:02 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 22:40:03 INFO - PROCESS | 1636 | RSS: Main: 310083584 22:40:03 INFO - PROCESS | 1636 | 22:43:05 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 22:43:05 INFO - PROCESS | 1636 | RSS: Main: 269758464 22:43:05 INFO - PROCESS | 1636 | 22:46:08 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 22:46:08 INFO - PROCESS | 1636 | RSS: Main: 299393024 22:46:08 INFO - PROCESS | 1636 | 22:49:12 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 22:49:12 INFO - PROCESS | 1636 | RSS: Main: 266850304 22:49:12 INFO - PROCESS | 1636 | 22:52:15 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 22:52:16 INFO - PROCESS | 1636 | RSS: Main: 463048704 22:52:16 INFO - PROCESS | 1636 | 22:52:16 INFO - PROCESS | 1636 | __start_tp_report 22:52:16 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 22:52:16 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 22:52:16 INFO - PROCESS | 1636 | |i|pagename|runs| 22:52:16 INFO - PROCESS | 1636 | |0;dojo.html;3489.1626009757656;3522.1898963238455;3526.7531272810897;3557.644235576441;3596.29872174926;5966.940330596693;6040.848978775522;6080.543959203061;6088.512918966483;6104.328523862378;5928.584999050068;6044.818655440333;6117.969410152943;6124.693765311739;6143.539234557404;5380.166074258486;5413.350397952251;5443.564514838823;5469.671819690831;5538.667679939196;5373.650712703681;5397.676139431627;5406.135018397057;5532.114861622142;5564.248826408444;5380.9507146106525;5409.675419474825;5418.485243901823;5467.152591348347;5506.339239291291;5496.587755918282;5502.80740174094;5503.944960550383;5506.339239291291;5518.696471694056;5273.604479664041;5284.81503147388;5387.542058924996;5403.540699040586;5420.13277875542;4890.951090489085;5955.13650520672;5955.642661440284;5996.730147143389;6024.909626355608;5313.787448502056;6330.525210609177;6333.651649159295;6344.904826427607;6354.714037868307;6374.840628984312;6419.3259707730485;6421.582597131218;6444.484441244689;6515.3810388013535;5644.209810626516;6099.359567245419;6119.390351379491;6178.7219575119225;6199.318075011745;6503.739850405931;6559.639219842859;6575.079488871562;6581.736730530821;6582.275949645536;6289.8742025159245;6294.464970477469;6303.905441418382;6309.085182648582;6313.652749098752;6250.312465628777;6301.495880329654;6319.8104056878365;6341.746330146835;6411.1024456576115;6274.560780745304;6318.684065796691;6322.462590679844;6324.683765811691;6326.082718005863;4961.975190124026;5839.226367475415;6289.496840252768;6290.905636415458;6302.716377763011;5100.6429549931145;5124.5131712487255;5132.486751324837;5171.81898633546;5209.947900521022;4592.839250626212;4617.699849509771;4632.930506042412;4638.79125439356;4679.4618618858585;4711.976440117846;6063.302720187146;6078.057901025348;6089.604175728564;6105.175801266861;6349.333320001426;6366.5861718989045;6368.458681012074;6370.713317900706;6375.139356186948;5882.911756323659;5965.015772397506;5979.043353063489;6035.577509574287;6063.272407311151;4984.626153038536;5521.1442226454965;5691.487766100988;5694.572907031989;5724.16999535065;6564.081028656087;6597.30728273534;6616.834579135368;6617.4706023518;6619.404253617197;6205.689715514297;6249.625022498664;6328.873422531431;6330.9050364245495;6375.489960803217;6477.125588045554;6494.220693516808;6506.967465162644;6575;6577;6304.148939893055;6313.684315784284;6316.684165791784;6317.273513546001;6345.524085693499;6250.343713909974;6303.149074874833;6304.3380445054445;6347.809565713036;6377.617342959437;6224.470919971853;6231.688415579112;6274;6279.466245369194;6289.96855015722;6270.184875966095;6272.749090036347;6281.780137695158;6283.2774230962195;6286.811395658137;6263.248410190807;6304;6305.716242769178;6320.778772742932;6324.968375158095;6219.0982307566055;6228.875422491616;6241.687915604292;6261.592996455216;6302.086197501429;6300.401461861115;6305.5270854687;6310.7791227306825;6312.05319202105;6317.873642527032 22:52:16 INFO - PROCESS | 1636 | |1;ext.html;504.4299941066594;536.1421725239617;544.6296518367511;544.8719550905537;554.0276814191094;31436;32829.67170328296;32879.34241315175;33018.8349058255;41437.58562414375;42939.785301073454;45304.546954530444;45425.77287113568;45451.545484545226;45461.545384546145;9647.131758141748;9831.754206144868;9833.803323933516;9846.753831154243;9874;9103.590338434786;9318.394304370227;9647.565859536338;9762.219022478184;9762.90237097627;11760.941195294012;11984.7603047939;12060.758784824298;12163;12211;11977.98187154093;12024.977876880475;12028.819567706492;12040.698982525462;12065.095117866194;11815.172937894351;11893;11913.22564033335;11913.94043029788;11915.344656043913;42359;42489;42615.57384426147;42706;42736.93157671052;4050.392441133824;4069.308217603015;4116.444280022189;4118.279301122292;4173.9582604173875;30368.54447183294;30741.077767667004;31390;32148;32420.837895810604;3384.1032126486502;3401.829908504565;3414.607320158189;3534.2224710563637;3550.6981906537976;494342;499009;499155;501285.99999999633;502582;65839.01241481381;66275.33724662788;66288;66325.33674663192;66446;69192.30807691859;69195.30804691989;69359.65320173468;69408.65295673489;69484;17239.82760172407;17983.460496184875;17997.370092046716;18006.099695015197;18014.909925450287;13723.245221512912;13828.861711382757;13840;13845.615438456074;13851.445942162401;12703.682407939876;14616.926915365355;15812.367505299659;16259.756103658454;17334.47996560105;7288.781336559911;7337.41300695943;7426.145993210742;7434.107907051189;7434.1450733166375;804.63389157933;913.6254135804288;920.1948295241664;942.137943781446;957.8275910336206;24774.25677229686;30134;31226.687733122377;31684.683153168175;32087.358252834812;1106.7841770854768;1110.9888901111046;1143.4968613809897;1159.2580748321082;1248.825164476974;15637.921810390875;16084.839151608568;16307.021578705315;16351.918240408722;16648.25082871274;631561;632963;633472;633940;635963;55698;56498.43501565014;63465;63614.68192659007;64188;1447.4789075932656;1465.3918623771228;1479.8520147985116;1492.4925525321444;1499.5801175670829;28959;30580.84709576438;32627.858024969013;32742.672573274915;33340.999770006936;47481.525184749094;54419.27903604725;54521;54542.909141817734;54588.72705636605;556929;767083;767713;767940;768444;35025.64974350326;42215.944601385214;42255.366169506866;43870;44511.55488445204;48951.75524122357;49126.280580179526;49154.01691966212;49377.75311123421;49945;32850.50724239091;33513;33704.83147584246;33781.3243735119;34426.31147377088;29365.853170734863;30046.24884377908;33402.66597333996;34327;34546.65453345535;38677.41983870188;39517.01207469836;39683.404748929366;39803.80588582347;39954.200915982095;32805.68067193294;33751.83124084364;33957.9106496406;34729.47905781466;34732.47901281533;24677.259682209562;25198.992040318182;25851.61222581625;26256.8687156563;26422.424928953154 22:52:16 INFO - PROCESS | 1636 | |2;jquery.html;345.4386621739673;391.68860755699217;397.4197671399758;406.9226846899087;437.982480700772;15681.686366272668;21029;21953.012114454847;22261.666075008867;22283.108675652955;17163.672654690617;18714.1578628962;20691;22521.211757588488;22595.983180756863;5812.622179558326;6152.84617884552;6153.169322141498;6160.322364539897;6190.41191086846;5851.7074146292725;6061.939380606182;6113.5414843886665;6143.078538219281;6160.599561028519;5037.49625037497;5957.970210148943;6087.11736798164;6093.634381937076;6093.78671746489;5834;5979.551533634973;6039.909401358983;6045.546584006217;6083.6045657032155;5349.545288650469;5351.785928562892;5352.197170424429;5357.366003368971;5359.651622644555;26342.604860927102;26833.46333073347;27260.59109113365;27529.587056194174;27584.172474825587;3131.2171957010746;3132.9373412531622;3198.072558957899;3214.8231847248394;3347.548081009057;13969.79045314321;15715.214239288105;16011.439599613957;16027.91986040074;16858;1923.3460623388116;1945.095530578288;1952.8730632508984;1977.940661780149;2002.4493264352275;130789.0381644276;134904;136747.31626341905;137847;141811;11401.828972565418;11551.480183391768;11666.300021998708;11915.2255103418;12102.939485302517;15086.622834429227;15474.690506189812;15561.377544898078;15565.22173891301;15631.765523517157;7081.398081163055;7457.888131678029;8264.256216940385;8503.532305723122;8765.342599305077;9060.365774395728;9193.862092068624;9213.355065145375;9227.492487913229;9370.344075914756;7483.588402637907;7618.200088990687;7642.121156067124;7647.808804779925;7668.693252269847;1689.4509284482592;1982.4052784164694;2024.5849600831793;2025.2810252360493;2026.179397344078;687.059058160698;861.8362511122866;909.8953620333614;911.7629416351797;921.7925966657449;20512.58974820495;21805.188536052272;21873.562528749335;21881.67177492339;21921.123155073936;912.8224590278598;915.8626206069143;922.262190247799;926.1340646495548;956.5121787888227;8755.956220218986;9500.95489496155;11447.599334023269;11476.770464590662;11492.310461372344;446193;729368;781647;810878;813561;137015.94476082866;137593;138355;143791.28104359412;144925;913.3013244867682;963.942163470194;1052.8052310322614;1062.9574817007233;1098.9670309890716;18638.881667100017;18978.43064708061;19114.235430583176;19220.71168932495;19271.22915083381;55375;57957;58581.4141858593;58795.70602146962;58910.70544647249;60345.698271508365;72313.6384318075;75312.87030694434;77000.22999769931;80585.19414806011;6329.7468101275435;6414.743410263537;6482.189726284215;6484.254310754135;6539.574927629689;9395.24838012971;12396.31820249895;13036.262384898899;13187.80218296707;13284.202947823162;11218.887811121784;11355.045360496591;11414.714632134263;11492.253003554742;11719.589814356457;9318.301127415607;10226.693199204035;10504.00635818788;10641.467926603793;10660.147188224768;11432;11528.423578820857;11604.30374177552;11700.70748231301;11933.343666098448;6346.333634968447;6479.935200648122;6595.604263744191;6617.073609694743;6905.620190889348;7646.541207527566;9766.169875560658;10258.28192026551;10515.842262366225;10551.525181366704 22:52:16 INFO - PROCESS | 1636 | |3;mootools.html;1257.8364812574366;1473.9041962272452;1491.746403111471;1493.589262952688;1494.7234761569114;8300.792480187998;8683.956580217098;8696.260817830476;8699.695510657128;8704.869426958601;7682;7956.6021698914965;8293.170682931719;8517.48895066295;8546.700865469695;2383.725871524771;2423.212455951814;2426.0295881647394;2427.0898413095088;2432.2460037388378;2382.344855164835;2415.758424157579;2416.8549887006748;2421.309926670899;2426.9757302427015;1889.9149538270742;2205.4155648753094;2320.6403007533777;2371.312319427364;2394.365493144318;2342.7071616047992;2362.716474023111;2362.7637236276405;2367.7987371073395;2370.3718514593647;2363.775441333071;2385.5348207099623;2397.113068164773;2397.4246180916452;2403.639454081884;8564.186402291773;8577.228049475578;8655.523946182957;8665.610047547812;8678.262347700453;4320.438343015419;5354.651947623392;5362.490563396471;5363;5364.91952620711;3431.571053618298;3571.8571257149683;3573.3925232710503;3588.6949609283242;3627.147620309225;1222.541546919905;1265.4432049898016;1293.4308904082175;1312.61277923012;1319.9538016169483;9140.588673509708;11090.445477726162;11119.499622517005;11123.499442525106;11125.944370278177;4523.457185137804;4756.524347565216;4815.2054910939305;4837.95162048375;4840.564349208588;9572.473513956798;9592.66425675098;9596.23230141587;9598.568064436977;9614;5312.017276803804;5398.1362981923485;5403.108487099663;5405.513503784599;5418.376886658085;4434.423524941737;4436.334549817489;4665.46347170073;4962.776675049631;4965.35450391454;3856.710746693953;3875.806209689504;3992.061865461614;3997.700172487075;4009.859654912064;1268.8604253532103;1275.5280546197966;1286.8777466140702;1287.0925997171971;1295.520657356784;913.5751875377981;915.8368871533115;935.5602866652663;937.2970272295778;987.225028352754;5601.5238704710555;5601.915971260434;5833.150559288591;5834.737436815353;5874.882502350015;585.1486087742325;594.1207013619867;959.2326139088701;1001.5042553935848;1051.085555566662;3771.73597848148;3804.1250512382308;3833.290841194332;3916.4712763777097;3968.7023473239046;8721.43310684816;10312;10408.271421000609;10418.01028902253;10419.218558608134;10039;10099.646512372032;10424.739381515372;10426.478676066166;10435.739106522398;7971.60141992898;7999.400044996649;8098.554579498066;8146.5519396433765;8151.429399942066;5532.751026203911;5559.33288005442;5693.4875861172695;5698.344690360495;5874.412558744262;9291.519170364407;9418.811623767624;9421.057894210524;9526.523673816142;9542.99798521173;9526.571304291461;9576.808463830825;9637.325387222827;9648.469334186688;9691.176250018827;6431.967840160769;6641.103451034049;6937.306269373023;7058.082449281561;7060.223375428802;7860.764177074697;8139.023317201973;8218.753437396888;8245.546494942835;8248.587570621325;5861.794837180678;6398.0402939559435;6817.216020157745;7116.25279345682;7147.142342918883;6968.825779355557;6977.232504424408;6980.7905762827195;7003.719851205895;7020.508564400443;6434.549581529248;6467.256265529336;6475.838104047248;6510.869782604416;6527.379898909596;5014.272930425141;5036.597072234285;5068.341115655089;5117.641765076409;5118.38579370478;4202.621764041251;5015.22264049073;5155.123628983157;5176.223566465061;5179.19722443022 22:52:16 INFO - PROCESS | 1636 | |4;prototype.html;309.8868912846811;368.1661037749496;377.43573357830047;387.1405479834766;388.98444062237513;5409.215663728757;5449;5514.255575497306;5527.198556209347;5537.8061767838135;4345.804438800254;4999.675021123624;5038.84883453497;5240.266362709223;5457.208704737811;3820.312343778112;3825.617438256166;4196.601322874338;4233.661307095425;4271.893202669942;3791.981040094796;3849.942250866239;3943.960560394388;4053.4122552230056;4095;3553.502509648651;3877.4571559981623;4147.440095587087;4183.569473032115;4199.202151591203;3785.5835858055593;3861.1119442528234;3946.2699400610977;4141.772202528859;4171.520275168364;3696.7042636589276;3697.759645623026;3709.870154544605;3713.4429835524616;3718.219173973469;5067.2145817397995;5236.502532259429;5247.140308531822;5279.86800329991;5280.996610643965;3996.820143093568;4795.0100708206055;4852.8301509447;4855.441624213226;4874.585660218886;4799.920017995958;5644.717764111778;5650.434956504358;5662.37713851476;5671.914921276184;3953.644172024503;4158.7296825706235;4166.437530933315;4167.874963751093;4172.165566886635;4853.417589889201;5573.804916827891;5624.578156638268;5827.941720582782;5844.707764611752;3454.775439596418;4188.623023927861;4191.413202151702;4193.517745459311;4195.16096780639;3793.279276937373;4234.280172370704;4263.866058447039;4268.304864648861;4299.183155200564;3970.940435893464;4614.960467108434;4800.35195248644;4826.251930950708;4878.878028049327;5609.775608975595;5641.856094683993;5659.424961642443;5664.433556644302;5666.829995100154;1257.8867901888873;1271.0806681910383;1315.5592876386327;1384.8742180752697;1397.699494608664;785.395245660838;847.576211894053;942.6700654770913;947.6588428165854;984.247051005981;4163.417121602978;4914.70511769295;4990.525900039491;5053.8736531587;5069.847904562869;4674.813007479731;5193.610479214074;5424.891502169935;5505.4584716279505;5529.834104976857;4636.976815115903;4699.530046995342;4840.88659608285;4953.950460495421;5043.51997121992;2283.794458498743;2486.3908342456216;2551.706553746306;2750.5697037540367;2794.5389010813396;4822.517748225149;5018.5232402921665;5048.081728942978;5620.3255609326325;5647.068233741469;4735.366298626968;5054.873628159326;5658.603897727202;5897.426931549644;6037.9396206038255;5457.263269458652;5792.304923409133;5948.8810223796145;6002.729877155539;6015.428534289235;5490.972545137249;5616.943830561642;5776.526985618809;5795.362510123968;5816.47651711348;4795.664303498722;5653.773849045992;5676.886462270649;5734.5125664319;5740.741666624928;5499.395066542597;5984.670843103671;6005.3967619427995;6029.487493563096;6033.78881739137;3491.8428670710387;3612.9638703612627;3705.5368078990127;3897.5517815450453;3961.504811898513;5025.698458092526;5670.943290567042;5797.5361971041375;5817.709114544171;5826.94173058264;4798.904021919612;5059.620528460307;5630.284012551696;5664.320281566238;5707.486326230493;4482.529334419839;4847.491013443679;5616.775328986958;5658.801941932013;5706.857328566819;5296.232046353334;5554.917021053354;5571.774209673866;5585.156898223495;5602;4595.655325850507;4835.516448355136;5525.502704756591;5565.415631358649;5634.718264086698;4967.230079337708;5142.408623008252;5328.254044433705;5409.1594967573465;5436.483534064258 22:52:16 INFO - PROCESS | 1636 | |5;yui.html;728.1880703016132;736.9557826530408;757.3524636435844;802.9785361463955;857.6226460357443;15779.526614201564;16010.519684409457;16156.515304540882;16163;16186.190690465488;16234.269457874394;16868.49394518163;17020.48938531843;17388.82611173888;17403.91298043511;839.8446287436814;917.4907926101012;934.4533447932968;935.8315503209419;937.6296362936636;928.749237705819;929.6142101028065;930.2372054914972;931.1805611062256;932.4405356785908;766.7048186448229;798.7963069417291;952.5284983932928;976.3360914578084;985.7929834734714;974.7270764185969;976.1848856205041;976.7558110472382;978.6868202175307;978.8042391521689;729.1869565434555;730.1165589636546;730.6821532633269;733.1532080447092;733.8568979049088;16202.513924582281;16215.513534593982;16301.266443010092;16335.918320408322;16357.59106022347;14030.649233769238;14231;14317.42730290787;14368.13791172533;14373.640658983504;12765.170263932814;12932.547360842325;12956.80564791529;13660.180389176681;13692.863071369258;4568.931466028012;4644.777371187802;4651.5813576778255;4779.283107533898;4795.448523419816;106843;116845;116905.6618867618;119456;119813;10833.83749243762;11165.330080195214;11185.776284474265;11428.885711142782;11474.54101835934;21977.67033494499;22182.667259991114;22228.222012229817;22242.66636000429;22270;7928.405369597303;7967.482113662593;7999.240072193133;8147.470414423044;8194.180581941877;4362.847300344472;4380.474343078851;4523.751193684313;4666.673332866667;4709.175894218567;3542.787432754043;3576.266865292661;3609.8556057757396;3635.836387362575;3646.507721457622;578.4389142531737;688.1398252184769;688.2016860441963;701.2846896165883;704.5842952657956;536.9221462887859;650.778735230024;661.9536632435779;667.8731041102175;668.2248591633681;9753.756156096013;9957.153641940517;10013.79972400548;10312.226583006304;10443.216758743125;619.3960888134034;629.9322648111498;639.9232092148878;641.563736659067;741.985160296791;4926.359573255454;5235.947640523622;5240.633155679142;5245.291885595472;5257.106291930381;99641.50179249202;103335.96664033414;105573.47213264038;105780;107412;88052.5597372009;91656.54171729232;91952;93284.60073098908;93588;71700;76226;77306.84039739409;77851.22148778666;78531.60734196292;10928;11103.57293188383;11164.274322169033;11191.32852028881;11434.94282528582;50428.991420170656;51319;51953;53237;53432.46567534275;60214.69892650684;61951.76096478135;72465.63767181341;73624.89562656672;76617.85073223794;12707.36463176856;12824.294663793207;13033.057025866146;13215.273159976294;13526.52657157034;14521.419143234574;14873.405063797327;14943.324780150058;15045.548633541011;15046.32291546861;13539.932300338829;13691.24698141572;14118.576442706735;14164.575062748134;14171.362288696828;13450.730985380433;13597.728045438838;13979.44082236699;14135.64660883486;14384.784228236795;13029.283389413673;13841.653958651113;13995.790063148857;14155.079919805179;14400.783988240395;9635.951820240854;9883.950580247052;10302.381857088598;10383.376997380181;10515.57937682484;10019.198464122706;10498.947505262426;11487.36819474937;11551.191416600757;11584.478698458759 22:52:16 INFO - PROCESS | 1636 | __end_tp_report 22:52:16 INFO - PROCESS | 1636 | __start_cc_report 22:52:16 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,1790 22:52:16 INFO - PROCESS | 1636 | __end_cc_report 22:52:16 INFO - PROCESS | 1636 | __startTimestamp1491198736026__endTimestamp 22:52:16 INFO - PROCESS | 1636 | 22:52:16 INFO - PROCESS | 1636 | ------- Summary: start ------- 22:52:16 INFO - PROCESS | 1636 | Number of tests: 6 22:52:16 INFO - PROCESS | 1636 | 22:52:16 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5927.82 Median:6231.69 stddev:648.04 (10.4%) stddev-sans-first:621.14 22:52:16 INFO - PROCESS | 1636 | Values: 3489.2 3522.2 3526.8 3557.6 3596.3 5966.9 6040.8 6080.5 6088.5 6104.3 5928.6 6044.8 6118.0 6124.7 6143.5 5380.2 5413.4 5443.6 5469.7 5538.7 5373.7 5397.7 5406.1 5532.1 5564.2 5381.0 5409.7 5418.5 5467.2 5506.3 5496.6 5502.8 5503.9 5506.3 5518.7 5273.6 5284.8 5387.5 5403.5 5420.1 4891.0 5955.1 5955.6 5996.7 6024.9 5313.8 6330.5 6333.7 6344.9 6354.7 6374.8 6419.3 6421.6 6444.5 6515.4 5644.2 6099.4 6119.4 6178.7 6199.3 6503.7 6559.6 6575.1 6581.7 6582.3 6289.9 6294.5 6303.9 6309.1 6313.7 6250.3 6301.5 6319.8 6341.7 6411.1 6274.6 6318.7 6322.5 6324.7 6326.1 4962.0 5839.2 6289.5 6290.9 6302.7 5100.6 5124.5 5132.5 5171.8 5209.9 4592.8 4617.7 4632.9 4638.8 4679.5 4712.0 6063.3 6078.1 6089.6 6105.2 6349.3 6366.6 6368.5 6370.7 6375.1 5882.9 5965.0 5979.0 6035.6 6063.3 4984.6 5521.1 5691.5 5694.6 5724.2 6564.1 6597.3 6616.8 6617.5 6619.4 6205.7 6249.6 6328.9 6330.9 6375.5 6477.1 6494.2 6507.0 6575.0 6577.0 6304.1 6313.7 6316.7 6317.3 6345.5 6250.3 6303.1 6304.3 6347.8 6377.6 6224.5 6231.7 6274.0 6279.5 6290.0 6270.2 6272.7 6281.8 6283.3 6286.8 6263.2 6304.0 6305.7 6320.8 6325.0 6219.1 6228.9 6241.7 6261.6 6302.1 6300.4 6305.5 6310.8 6312.1 6317.9 22:52:16 INFO - PROCESS | 1636 | 22:52:16 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:75453.03 Median:39097.22 stddev:168337.82 (430.6%) stddev-sans-first:168716.00 22:52:16 INFO - PROCESS | 1636 | Values: 504.4 536.1 544.6 544.9 554.0 31436.0 32829.7 32879.3 33018.8 41437.6 42939.8 45304.5 45425.8 45451.5 45461.5 9647.1 9831.8 9833.8 9846.8 9874.0 9103.6 9318.4 9647.6 9762.2 9762.9 11760.9 11984.8 12060.8 12163.0 12211.0 11978.0 12025.0 12028.8 12040.7 12065.1 11815.2 11893.0 11913.2 11913.9 11915.3 42359.0 42489.0 42615.6 42706.0 42736.9 4050.4 4069.3 4116.4 4118.3 4174.0 30368.5 30741.1 31390.0 32148.0 32420.8 3384.1 3401.8 3414.6 3534.2 3550.7 494342.0 499009.0 499155.0 501286.0 502582.0 65839.0 66275.3 66288.0 66325.3 66446.0 69192.3 69195.3 69359.7 69408.7 69484.0 17239.8 17983.5 17997.4 18006.1 18014.9 13723.2 13828.9 13840.0 13845.6 13851.4 12703.7 14616.9 15812.4 16259.8 17334.5 7288.8 7337.4 7426.1 7434.1 7434.1 804.6 913.6 920.2 942.1 957.8 24774.3 30134.0 31226.7 31684.7 32087.4 1106.8 1111.0 1143.5 1159.3 1248.8 15637.9 16084.8 16307.0 16351.9 16648.3 631561.0 632963.0 633472.0 633940.0 635963.0 55698.0 56498.4 63465.0 63614.7 64188.0 1447.5 1465.4 1479.9 1492.5 1499.6 28959.0 30580.8 32627.9 32742.7 33341.0 47481.5 54419.3 54521.0 54542.9 54588.7 556929.0 767083.0 767713.0 767940.0 768444.0 35025.6 42215.9 42255.4 43870.0 44511.6 48951.8 49126.3 49154.0 49377.8 49945.0 32850.5 33513.0 33704.8 33781.3 34426.3 29365.9 30046.2 33402.7 34327.0 34546.7 38677.4 39517.0 39683.4 39803.8 39954.2 32805.7 33751.8 33957.9 34729.5 34732.5 24677.3 25199.0 25851.6 26256.9 26422.4 22:52:16 INFO - PROCESS | 1636 | 22:52:16 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:39422.53 Median:3281.19 stddev:121406.77 (3700.1%) stddev-sans-first:121711.89 22:52:16 INFO - PROCESS | 1636 | Values: 345.4 391.7 397.4 406.9 438.0 15681.7 21029.0 21953.0 22261.7 22283.1 17163.7 18714.2 20691.0 22521.2 22596.0 5812.6 6152.8 6153.2 6160.3 6190.4 5851.7 6061.9 6113.5 6143.1 6160.6 5037.5 5958.0 6087.1 6093.6 6093.8 5834.0 5979.6 6039.9 6045.5 6083.6 5349.5 5351.8 5352.2 5357.4 5359.7 26342.6 26833.5 27260.6 27529.6 27584.2 3131.2 3132.9 3198.1 3214.8 3347.5 13969.8 15715.2 16011.4 16027.9 16858.0 1923.3 1945.1 1952.9 1977.9 2002.4 130789.0 134904.0 136747.3 137847.0 141811.0 11401.8 11551.5 11666.3 11915.2 12102.9 15086.6 15474.7 15561.4 15565.2 15631.8 7081.4 7457.9 8264.3 8503.5 8765.3 9060.4 9193.9 9213.4 9227.5 9370.3 7483.6 7618.2 7642.1 7647.8 7668.7 1689.5 1982.4 2024.6 2025.3 2026.2 687.1 861.8 909.9 911.8 921.8 20512.6 21805.2 21873.6 21881.7 21921.1 912.8 915.9 922.3 926.1 956.5 8756.0 9501.0 11447.6 11476.8 11492.3 446193.0 729368.0 781647.0 810878.0 813561.0 137015.9 137593.0 138355.0 143791.3 144925.0 913.3 963.9 1052.8 1063.0 1099.0 18638.9 18978.4 19114.2 19220.7 19271.2 55375.0 57957.0 58581.4 58795.7 58910.7 60345.7 72313.6 75312.9 77000.2 80585.2 6329.7 6414.7 6482.2 6484.3 6539.6 9395.2 12396.3 13036.3 13187.8 13284.2 11218.9 11355.0 11414.7 11492.3 11719.6 9318.3 10226.7 10504.0 10641.5 10660.1 11432.0 11528.4 11604.3 11700.7 11933.3 6346.3 6479.9 6595.6 6617.1 6905.6 7646.5 9766.2 10258.3 10515.8 10551.5 22:52:16 INFO - PROCESS | 1636 | 22:52:16 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5520.32 Median:5245.61 stddev:3006.07 (57.3%) stddev-sans-first:2997.43 22:52:16 INFO - PROCESS | 1636 | Values: 1257.8 1473.9 1491.7 1493.6 1494.7 8300.8 8684.0 8696.3 8699.7 8704.9 7682.0 7956.6 8293.2 8517.5 8546.7 2383.7 2423.2 2426.0 2427.1 2432.2 2382.3 2415.8 2416.9 2421.3 2427.0 1889.9 2205.4 2320.6 2371.3 2394.4 2342.7 2362.7 2362.8 2367.8 2370.4 2363.8 2385.5 2397.1 2397.4 2403.6 8564.2 8577.2 8655.5 8665.6 8678.3 4320.4 5354.7 5362.5 5363.0 5364.9 3431.6 3571.9 3573.4 3588.7 3627.1 1222.5 1265.4 1293.4 1312.6 1320.0 9140.6 11090.4 11119.5 11123.5 11125.9 4523.5 4756.5 4815.2 4838.0 4840.6 9572.5 9592.7 9596.2 9598.6 9614.0 5312.0 5398.1 5403.1 5405.5 5418.4 4434.4 4436.3 4665.5 4962.8 4965.4 3856.7 3875.8 3992.1 3997.7 4009.9 1268.9 1275.5 1286.9 1287.1 1295.5 913.6 915.8 935.6 937.3 987.2 5601.5 5601.9 5833.2 5834.7 5874.9 585.1 594.1 959.2 1001.5 1051.1 3771.7 3804.1 3833.3 3916.5 3968.7 8721.4 10312.0 10408.3 10418.0 10419.2 10039.0 10099.6 10424.7 10426.5 10435.7 7971.6 7999.4 8098.6 8146.6 8151.4 5532.8 5559.3 5693.5 5698.3 5874.4 9291.5 9418.8 9421.1 9526.5 9543.0 9526.6 9576.8 9637.3 9648.5 9691.2 6432.0 6641.1 6937.3 7058.1 7060.2 7860.8 8139.0 8218.8 8245.5 8248.6 5861.8 6398.0 6817.2 7116.3 7147.1 6968.8 6977.2 6980.8 7003.7 7020.5 6434.5 6467.3 6475.8 6510.9 6527.4 5014.3 5036.6 5068.3 5117.6 5118.4 4202.6 5015.2 5155.1 5176.2 5179.2 22:52:16 INFO - PROCESS | 1636 | 22:52:16 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4542.49 Median:5009.10 stddev:1373.19 (27.4%) stddev-sans-first:1339.79 22:52:16 INFO - PROCESS | 1636 | Values: 309.9 368.2 377.4 387.1 389.0 5409.2 5449.0 5514.3 5527.2 5537.8 4345.8 4999.7 5038.8 5240.3 5457.2 3820.3 3825.6 4196.6 4233.7 4271.9 3792.0 3849.9 3944.0 4053.4 4095.0 3553.5 3877.5 4147.4 4183.6 4199.2 3785.6 3861.1 3946.3 4141.8 4171.5 3696.7 3697.8 3709.9 3713.4 3718.2 5067.2 5236.5 5247.1 5279.9 5281.0 3996.8 4795.0 4852.8 4855.4 4874.6 4799.9 5644.7 5650.4 5662.4 5671.9 3953.6 4158.7 4166.4 4167.9 4172.2 4853.4 5573.8 5624.6 5827.9 5844.7 3454.8 4188.6 4191.4 4193.5 4195.2 3793.3 4234.3 4263.9 4268.3 4299.2 3970.9 4615.0 4800.4 4826.3 4878.9 5609.8 5641.9 5659.4 5664.4 5666.8 1257.9 1271.1 1315.6 1384.9 1397.7 785.4 847.6 942.7 947.7 984.2 4163.4 4914.7 4990.5 5053.9 5069.8 4674.8 5193.6 5424.9 5505.5 5529.8 4637.0 4699.5 4840.9 4954.0 5043.5 2283.8 2486.4 2551.7 2750.6 2794.5 4822.5 5018.5 5048.1 5620.3 5647.1 4735.4 5054.9 5658.6 5897.4 6037.9 5457.3 5792.3 5948.9 6002.7 6015.4 5491.0 5616.9 5776.5 5795.4 5816.5 4795.7 5653.8 5676.9 5734.5 5740.7 5499.4 5984.7 6005.4 6029.5 6033.8 3491.8 3613.0 3705.5 3897.6 3961.5 5025.7 5670.9 5797.5 5817.7 5826.9 4798.9 5059.6 5630.3 5664.3 5707.5 4482.5 4847.5 5616.8 5658.8 5706.9 5296.2 5554.9 5571.8 5585.2 5602.0 4595.7 4835.5 5525.5 5565.4 5634.7 4967.2 5142.4 5328.3 5409.2 5436.5 22:52:16 INFO - PROCESS | 1636 | 22:52:16 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:21248.22 Median:4371.66 stddev:30479.91 (697.2%) stddev-sans-first:30526.47 22:52:16 INFO - PROCESS | 1636 | Values: 728.2 737.0 757.4 803.0 857.6 15779.5 16010.5 16156.5 16163.0 16186.2 16234.3 16868.5 17020.5 17388.8 17403.9 839.8 917.5 934.5 935.8 937.6 928.7 929.6 930.2 931.2 932.4 766.7 798.8 952.5 976.3 985.8 974.7 976.2 976.8 978.7 978.8 729.2 730.1 730.7 733.2 733.9 16202.5 16215.5 16301.3 16335.9 16357.6 14030.6 14231.0 14317.4 14368.1 14373.6 12765.2 12932.5 12956.8 13660.2 13692.9 4568.9 4644.8 4651.6 4779.3 4795.4 106843.0 116845.0 116905.7 119456.0 119813.0 10833.8 11165.3 11185.8 11428.9 11474.5 21977.7 22182.7 22228.2 22242.7 22270.0 7928.4 7967.5 7999.2 8147.5 8194.2 4362.8 4380.5 4523.8 4666.7 4709.2 3542.8 3576.3 3609.9 3635.8 3646.5 578.4 688.1 688.2 701.3 704.6 536.9 650.8 662.0 667.9 668.2 9753.8 9957.2 10013.8 10312.2 10443.2 619.4 629.9 639.9 641.6 742.0 4926.4 5235.9 5240.6 5245.3 5257.1 99641.5 103336.0 105573.5 105780.0 107412.0 88052.6 91656.5 91952.0 93284.6 93588.0 71700.0 76226.0 77306.8 77851.2 78531.6 10928.0 11103.6 11164.3 11191.3 11434.9 50429.0 51319.0 51953.0 53237.0 53432.5 60214.7 61951.8 72465.6 73624.9 76617.9 12707.4 12824.3 13033.1 13215.3 13526.5 14521.4 14873.4 14943.3 15045.5 15046.3 13539.9 13691.2 14118.6 14164.6 14171.4 13450.7 13597.7 13979.4 14135.6 14384.8 13029.3 13841.7 13995.8 14155.1 14400.8 9636.0 9884.0 10302.4 10383.4 10515.6 10019.2 10498.9 11487.4 11551.2 11584.5 22:52:16 INFO - PROCESS | 1636 | -------- Summary: end -------- 22:52:16 INFO - PROCESS | 1636 | 22:52:16 INFO - TEST-INFO | 1636: exit 0 22:52:16 INFO - TEST-OK | dromaeo_css | took 1116345ms 22:52:16 INFO - TEST-START | kraken 22:52:16 INFO - operating with platform_type : mac_ 22:52:16 INFO - Initialising browser for kraken test... 22:52:16 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/tmpMhIGYz/profile http://localhost:49250/getInfo.html) 22:52:18 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 22:52:18 INFO - PROCESS | 1645 | colorDepth:24 22:52:18 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 22:52:18 INFO - PROCESS | 1645 | __metrics 22:52:19 INFO - PROCESS | 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:52:19 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:52:19 INFO - TEST-INFO | 1645: exit 0 22:52:19 INFO - Browser initialized. 22:52:19 INFO - Running cycle 1/1 for kraken test... 22:52:19 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/T/tmpMhIGYz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:52:31 INFO - PROCESS | 1647 | RSS: Main: 163729408 22:52:31 INFO - PROCESS | 1647 | 22:52:34 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 22:52:35 INFO - PROCESS | 1647 | RSS: Main: 214290432 22:52:35 INFO - PROCESS | 1647 | 22:52:38 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 22:52:38 INFO - PROCESS | 1647 | RSS: Main: 228143104 22:52:38 INFO - PROCESS | 1647 | 22:52:41 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 22:52:42 INFO - PROCESS | 1647 | RSS: Main: 324734976 22:52:42 INFO - PROCESS | 1647 | 22:52:44 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 22:52:44 INFO - PROCESS | 1647 | RSS: Main: 229130240 22:52:44 INFO - PROCESS | 1647 | 22:52:46 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:52:47 INFO - PROCESS | 1647 | RSS: Main: 230850560 22:52:47 INFO - PROCESS | 1647 | 22:52:50 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 22:52:50 INFO - PROCESS | 1647 | RSS: Main: 270876672 22:52:50 INFO - PROCESS | 1647 | 22:52:53 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 22:52:54 INFO - PROCESS | 1647 | RSS: Main: 272068608 22:52:54 INFO - PROCESS | 1647 | 22:52:57 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 22:52:57 INFO - PROCESS | 1647 | RSS: Main: 267231232 22:52:57 INFO - PROCESS | 1647 | 22:52:59 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:53:00 INFO - PROCESS | 1647 | RSS: Main: 245280768 22:53:00 INFO - PROCESS | 1647 | 22:53:01 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:53:02 INFO - PROCESS | 1647 | RSS: Main: 246951936 22:53:02 INFO - PROCESS | 1647 | 22:53:04 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:53:05 INFO - PROCESS | 1647 | RSS: Main: 252874752 22:53:05 INFO - PROCESS | 1647 | 22:53:08 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:53:08 INFO - PROCESS | 1647 | RSS: Main: 268259328 22:53:08 INFO - PROCESS | 1647 | 22:53:11 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:53:12 INFO - PROCESS | 1647 | RSS: Main: 262160384 22:53:12 INFO - PROCESS | 1647 | 22:53:14 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 22:53:14 INFO - PROCESS | 1647 | RSS: Main: 306049024 22:53:14 INFO - PROCESS | 1647 | 22:53:14 INFO - PROCESS | 1647 | __start_tp_report 22:53:14 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 22:53:14 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 22:53:14 INFO - PROCESS | 1647 | |i|pagename|runs| 22:53:14 INFO - PROCESS | 1647 | |0;ai-astar;103;113;113;113;114;114;113;113;113;114 22:53:14 INFO - PROCESS | 1647 | |1;audio-beat-detection;137;105;104;140;105;106;106;100;125;106 22:53:14 INFO - PROCESS | 1647 | |2;audio-dft;183;180;182;181;181;181;182;181;181;181 22:53:14 INFO - PROCESS | 1647 | |3;audio-fft;80;57;57;87;59;59;57;82;71;57 22:53:14 INFO - PROCESS | 1647 | |4;audio-oscillator;83;69;84;69;67;69;80;67;68;80 22:53:14 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;89;130;88;86;88;85;89;86;89;85 22:53:14 INFO - PROCESS | 1647 | |6;imaging-darkroom;96;94;93;93;93;95;95;94;94;94 22:53:14 INFO - PROCESS | 1647 | |7;imaging-desaturate;86;87;84;87;87;97;139;131;87;87 22:53:14 INFO - PROCESS | 1647 | |8;json-parse-financial;51;52;54;52;55;56;55;56;54;55 22:53:14 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;64;70;69;75;70;67;68;67;69;68 22:53:14 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;84;81;85;82;92;99;100;80;87;81 22:53:14 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;132;130;130;133;128;132;133;134;187;154 22:53:14 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;166;161;162;162;159;159;160;159;160;158 22:53:14 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;56;64;79;64;60;70;82;80;81;67 22:53:14 INFO - PROCESS | 1647 | __end_tp_report 22:53:14 INFO - PROCESS | 1647 | __start_cc_report 22:53:14 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1919 22:53:14 INFO - PROCESS | 1647 | __end_cc_report 22:53:14 INFO - PROCESS | 1647 | __startTimestamp1491198794270__endTimestamp 22:53:14 INFO - PROCESS | 1647 | 22:53:14 INFO - PROCESS | 1647 | ------- Summary: start ------- 22:53:14 INFO - PROCESS | 1647 | Number of tests: 14 22:53:14 INFO - PROCESS | 1647 | 22:53:14 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:3.30 (2.9%) stddev-sans-first:0.50 22:53:14 INFO - PROCESS | 1647 | Values: 103.0 113.0 113.0 113.0 114.0 114.0 113.0 113.0 113.0 114.0 22:53:14 INFO - PROCESS | 1647 | 22:53:14 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:113.40 Median:106.00 stddev:14.80 (14.0%) stddev-sans-first:13.01 22:53:14 INFO - PROCESS | 1647 | Values: 137.0 105.0 104.0 140.0 105.0 106.0 106.0 100.0 125.0 106.0 22:53:14 INFO - PROCESS | 1647 | 22:53:14 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:181.30 Median:181.00 stddev:0.82 (0.5%) stddev-sans-first:0.60 22:53:14 INFO - PROCESS | 1647 | Values: 183.0 180.0 182.0 181.0 181.0 181.0 182.0 181.0 181.0 181.0 22:53:14 INFO - PROCESS | 1647 | 22:53:14 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:66.60 Median:65.00 stddev:12.19 (18.7%) stddev-sans-first:11.92 22:53:14 INFO - PROCESS | 1647 | Values: 80.0 57.0 57.0 87.0 59.0 59.0 57.0 82.0 71.0 57.0 22:53:14 INFO - PROCESS | 1647 | 22:53:14 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:73.60 Median:74.50 stddev:7.15 (9.6%) stddev-sans-first:6.73 22:53:14 INFO - PROCESS | 1647 | Values: 83.0 69.0 84.0 69.0 67.0 69.0 80.0 67.0 68.0 80.0 22:53:14 INFO - PROCESS | 1647 | 22:53:14 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:91.50 Median:88.00 stddev:13.62 (15.5%) stddev-sans-first:14.42 22:53:14 INFO - PROCESS | 1647 | Values: 89.0 130.0 88.0 86.0 88.0 85.0 89.0 86.0 89.0 85.0 22:53:14 INFO - PROCESS | 1647 | 22:53:14 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:94.00 stddev:0.99 (1.1%) stddev-sans-first:0.78 22:53:14 INFO - PROCESS | 1647 | Values: 96.0 94.0 93.0 93.0 93.0 95.0 95.0 94.0 94.0 94.0 22:53:14 INFO - PROCESS | 1647 | 22:53:14 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:87.00 stddev:20.30 (23.3%) stddev-sans-first:21.13 22:53:14 INFO - PROCESS | 1647 | Values: 86.0 87.0 84.0 87.0 87.0 97.0 139.0 131.0 87.0 87.0 22:53:14 INFO - PROCESS | 1647 | 22:53:14 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:55.00 stddev:1.76 (3.2%) stddev-sans-first:1.50 22:53:14 INFO - PROCESS | 1647 | Values: 51.0 52.0 54.0 52.0 55.0 56.0 55.0 56.0 54.0 55.0 22:53:14 INFO - PROCESS | 1647 | 22:53:14 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:2.83 (4.1%) stddev-sans-first:2.44 22:53:14 INFO - PROCESS | 1647 | Values: 64.0 70.0 69.0 75.0 70.0 67.0 68.0 67.0 69.0 68.0 22:53:14 INFO - PROCESS | 1647 | 22:53:14 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:84.50 stddev:7.43 (8.8%) stddev-sans-first:7.80 22:53:14 INFO - PROCESS | 1647 | Values: 84.0 81.0 85.0 82.0 92.0 99.0 100.0 80.0 87.0 81.0 22:53:14 INFO - PROCESS | 1647 | 22:53:14 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:133.00 stddev:18.28 (13.7%) stddev-sans-first:19.19 22:53:14 INFO - PROCESS | 1647 | Values: 132.0 130.0 130.0 133.0 128.0 132.0 133.0 134.0 187.0 154.0 22:53:14 INFO - PROCESS | 1647 | 22:53:14 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:160.50 stddev:2.32 (1.4%) stddev-sans-first:1.41 22:53:14 INFO - PROCESS | 1647 | Values: 166.0 161.0 162.0 162.0 159.0 159.0 160.0 159.0 160.0 158.0 22:53:14 INFO - PROCESS | 1647 | 22:53:14 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:74.50 stddev:9.56 (12.8%) stddev-sans-first:8.62 22:53:14 INFO - PROCESS | 1647 | Values: 56.0 64.0 79.0 64.0 60.0 70.0 82.0 80.0 81.0 67.0 22:53:14 INFO - PROCESS | 1647 | -------- Summary: end -------- 22:53:14 INFO - PROCESS | 1647 | 22:53:15 INFO - TEST-INFO | 1647: exit 0 22:53:15 INFO - TEST-OK | kraken | took 58433ms 22:53:15 INFO - SUITE-END | took 1174s 22:53:15 INFO - Completed test suite (00:19:35) 22:53:15 INFO - javascript benchmark 22:53:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3489.1626009757656, 3522.1898963238455, 3526.7531272810897, 3557.644235576441, 3596.29872174926, 5966.940330596693, 6040.848978775522, 6080.543959203061, 6088.512918966483, 6104.328523862378, 5928.584999050068, 6044.818655440333, 6117.969410152943, 6124.693765311739, 6143.539234557404, 5380.166074258486, 5413.350397952251, 5443.564514838823, 5469.671819690831, 5538.667679939196, 5373.650712703681, 5397.676139431627, 5406.135018397057, 5532.114861622142, 5564.248826408444, 5380.9507146106525, 5409.675419474825, 5418.485243901823, 5467.152591348347, 5506.339239291291, 5496.587755918282, 5502.80740174094, 5503.944960550383, 5506.339239291291, 5518.696471694056, 5273.604479664041, 5284.81503147388, 5387.542058924996, 5403.540699040586, 5420.13277875542, 4890.951090489085, 5955.13650520672, 5955.642661440284, 5996.730147143389, 6024.909626355608, 5313.787448502056, 6330.525210609177, 6333.651649159295, 6344.904826427607, 6354.714037868307, 6374.840628984312, 6419.3259707730485, 6421.582597131218, 6444.484441244689, 6515.3810388013535, 5644.209810626516, 6099.359567245419, 6119.390351379491, 6178.7219575119225, 6199.318075011745, 6503.739850405931, 6559.639219842859, 6575.079488871562, 6581.736730530821, 6582.275949645536, 6289.8742025159245, 6294.464970477469, 6303.905441418382, 6309.085182648582, 6313.652749098752, 6250.312465628777, 6301.495880329654, 6319.8104056878365, 6341.746330146835, 6411.1024456576115, 6274.560780745304, 6318.684065796691, 6322.462590679844, 6324.683765811691, 6326.082718005863, 4961.975190124026, 5839.226367475415, 6289.496840252768, 6290.905636415458, 6302.716377763011, 5100.6429549931145, 5124.5131712487255, 5132.486751324837, 5171.81898633546, 5209.947900521022, 4592.839250626212, 4617.699849509771, 4632.930506042412, 4638.79125439356, 4679.4618618858585, 4711.976440117846, 6063.302720187146, 6078.057901025348, 6089.604175728564, 6105.175801266861, 6349.333320001426, 6366.5861718989045, 6368.458681012074, 6370.713317900706, 6375.139356186948, 5882.911756323659, 5965.015772397506, 5979.043353063489, 6035.577509574287, 6063.272407311151, 4984.626153038536, 5521.1442226454965, 5691.487766100988, 5694.572907031989, 5724.16999535065, 6564.081028656087, 6597.30728273534, 6616.834579135368, 6617.4706023518, 6619.404253617197, 6205.689715514297, 6249.625022498664, 6328.873422531431, 6330.9050364245495, 6375.489960803217, 6477.125588045554, 6494.220693516808, 6506.967465162644, 6575.0, 6577.0, 6304.148939893055, 6313.684315784284, 6316.684165791784, 6317.273513546001, 6345.524085693499, 6250.343713909974, 6303.149074874833, 6304.3380445054445, 6347.809565713036, 6377.617342959437, 6224.470919971853, 6231.688415579112, 6274.0, 6279.466245369194, 6289.96855015722, 6270.184875966095, 6272.749090036347, 6281.780137695158, 6283.2774230962195, 6286.811395658137, 6263.248410190807, 6304.0, 6305.716242769178, 6320.778772742932, 6324.968375158095, 6219.0982307566055, 6228.875422491616, 6241.687915604292, 6261.592996455216, 6302.086197501429, 6300.401461861115, 6305.5270854687, 6310.7791227306825, 6312.05319202105, 6317.873642527032], "value": 5889.181893316059, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.4299941066594, 536.1421725239617, 544.6296518367511, 544.8719550905537, 554.0276814191094, 31436.0, 32829.67170328296, 32879.34241315175, 33018.8349058255, 41437.58562414375, 42939.785301073454, 45304.546954530444, 45425.77287113568, 45451.545484545226, 45461.545384546145, 9647.131758141748, 9831.754206144868, 9833.803323933516, 9846.753831154243, 9874.0, 9103.590338434786, 9318.394304370227, 9647.565859536338, 9762.219022478184, 9762.90237097627, 11760.941195294012, 11984.7603047939, 12060.758784824298, 12163.0, 12211.0, 11977.98187154093, 12024.977876880475, 12028.819567706492, 12040.698982525462, 12065.095117866194, 11815.172937894351, 11893.0, 11913.22564033335, 11913.94043029788, 11915.344656043913, 42359.0, 42489.0, 42615.57384426147, 42706.0, 42736.93157671052, 4050.392441133824, 4069.308217603015, 4116.444280022189, 4118.279301122292, 4173.9582604173875, 30368.54447183294, 30741.077767667004, 31390.0, 32148.0, 32420.837895810604, 3384.1032126486502, 3401.829908504565, 3414.607320158189, 3534.2224710563637, 3550.6981906537976, 494342.0, 499009.0, 499155.0, 501285.99999999633, 502582.0, 65839.01241481381, 66275.33724662788, 66288.0, 66325.33674663192, 66446.0, 69192.30807691859, 69195.30804691989, 69359.65320173468, 69408.65295673489, 69484.0, 17239.82760172407, 17983.460496184875, 17997.370092046716, 18006.099695015197, 18014.909925450287, 13723.245221512912, 13828.861711382757, 13840.0, 13845.615438456074, 13851.445942162401, 12703.682407939876, 14616.926915365355, 15812.367505299659, 16259.756103658454, 17334.47996560105, 7288.781336559911, 7337.41300695943, 7426.145993210742, 7434.107907051189, 7434.1450733166375, 804.63389157933, 913.6254135804288, 920.1948295241664, 942.137943781446, 957.8275910336206, 24774.25677229686, 30134.0, 31226.687733122377, 31684.683153168175, 32087.358252834812, 1106.7841770854768, 1110.9888901111046, 1143.4968613809897, 1159.2580748321082, 1248.825164476974, 15637.921810390875, 16084.839151608568, 16307.021578705315, 16351.918240408722, 16648.25082871274, 631561.0, 632963.0, 633472.0, 633940.0, 635963.0, 55698.0, 56498.43501565014, 63465.0, 63614.68192659007, 64188.0, 1447.4789075932656, 1465.3918623771228, 1479.8520147985116, 1492.4925525321444, 1499.5801175670829, 28959.0, 30580.84709576438, 32627.858024969013, 32742.672573274915, 33340.999770006936, 47481.525184749094, 54419.27903604725, 54521.0, 54542.909141817734, 54588.72705636605, 556929.0, 767083.0, 767713.0, 767940.0, 768444.0, 35025.64974350326, 42215.944601385214, 42255.366169506866, 43870.0, 44511.55488445204, 48951.75524122357, 49126.280580179526, 49154.01691966212, 49377.75311123421, 49945.0, 32850.50724239091, 33513.0, 33704.83147584246, 33781.3243735119, 34426.31147377088, 29365.853170734863, 30046.24884377908, 33402.66597333996, 34327.0, 34546.65453345535, 38677.41983870188, 39517.01207469836, 39683.404748929366, 39803.80588582347, 39954.200915982095, 32805.68067193294, 33751.83124084364, 33957.9106496406, 34729.47905781466, 34732.47901281533, 24677.259682209562, 25198.992040318182, 25851.61222581625, 26256.8687156563, 26422.424928953154], "value": 21060.01278653908, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.4386621739673, 391.68860755699217, 397.4197671399758, 406.9226846899087, 437.982480700772, 15681.686366272668, 21029.0, 21953.012114454847, 22261.666075008867, 22283.108675652955, 17163.672654690617, 18714.1578628962, 20691.0, 22521.211757588488, 22595.983180756863, 5812.622179558326, 6152.84617884552, 6153.169322141498, 6160.322364539897, 6190.41191086846, 5851.7074146292725, 6061.939380606182, 6113.5414843886665, 6143.078538219281, 6160.599561028519, 5037.49625037497, 5957.970210148943, 6087.11736798164, 6093.634381937076, 6093.78671746489, 5834.0, 5979.551533634973, 6039.909401358983, 6045.546584006217, 6083.6045657032155, 5349.545288650469, 5351.785928562892, 5352.197170424429, 5357.366003368971, 5359.651622644555, 26342.604860927102, 26833.46333073347, 27260.59109113365, 27529.587056194174, 27584.172474825587, 3131.2171957010746, 3132.9373412531622, 3198.072558957899, 3214.8231847248394, 3347.548081009057, 13969.79045314321, 15715.214239288105, 16011.439599613957, 16027.91986040074, 16858.0, 1923.3460623388116, 1945.095530578288, 1952.8730632508984, 1977.940661780149, 2002.4493264352275, 130789.0381644276, 134904.0, 136747.31626341905, 137847.0, 141811.0, 11401.828972565418, 11551.480183391768, 11666.300021998708, 11915.2255103418, 12102.939485302517, 15086.622834429227, 15474.690506189812, 15561.377544898078, 15565.22173891301, 15631.765523517157, 7081.398081163055, 7457.888131678029, 8264.256216940385, 8503.532305723122, 8765.342599305077, 9060.365774395728, 9193.862092068624, 9213.355065145375, 9227.492487913229, 9370.344075914756, 7483.588402637907, 7618.200088990687, 7642.121156067124, 7647.808804779925, 7668.693252269847, 1689.4509284482592, 1982.4052784164694, 2024.5849600831793, 2025.2810252360493, 2026.179397344078, 687.059058160698, 861.8362511122866, 909.8953620333614, 911.7629416351797, 921.7925966657449, 20512.58974820495, 21805.188536052272, 21873.562528749335, 21881.67177492339, 21921.123155073936, 912.8224590278598, 915.8626206069143, 922.262190247799, 926.1340646495548, 956.5121787888227, 8755.956220218986, 9500.95489496155, 11447.599334023269, 11476.770464590662, 11492.310461372344, 446193.0, 729368.0, 781647.0, 810878.0, 813561.0, 137015.94476082866, 137593.0, 138355.0, 143791.28104359412, 144925.0, 913.3013244867682, 963.942163470194, 1052.8052310322614, 1062.9574817007233, 1098.9670309890716, 18638.881667100017, 18978.43064708061, 19114.235430583176, 19220.71168932495, 19271.22915083381, 55375.0, 57957.0, 58581.4141858593, 58795.70602146962, 58910.70544647249, 60345.698271508365, 72313.6384318075, 75312.87030694434, 77000.22999769931, 80585.19414806011, 6329.7468101275435, 6414.743410263537, 6482.189726284215, 6484.254310754135, 6539.574927629689, 9395.24838012971, 12396.31820249895, 13036.262384898899, 13187.80218296707, 13284.202947823162, 11218.887811121784, 11355.045360496591, 11414.714632134263, 11492.253003554742, 11719.589814356457, 9318.301127415607, 10226.693199204035, 10504.00635818788, 10641.467926603793, 10660.147188224768, 11432.0, 11528.423578820857, 11604.30374177552, 11700.70748231301, 11933.343666098448, 6346.333634968447, 6479.935200648122, 6595.604263744191, 6617.073609694743, 6905.620190889348, 7646.541207527566, 9766.169875560658, 10258.28192026551, 10515.842262366225, 10551.525181366704], "value": 9963.039949940023, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1257.8364812574366, 1473.9041962272452, 1491.746403111471, 1493.589262952688, 1494.7234761569114, 8300.792480187998, 8683.956580217098, 8696.260817830476, 8699.695510657128, 8704.869426958601, 7682.0, 7956.6021698914965, 8293.170682931719, 8517.48895066295, 8546.700865469695, 2383.725871524771, 2423.212455951814, 2426.0295881647394, 2427.0898413095088, 2432.2460037388378, 2382.344855164835, 2415.758424157579, 2416.8549887006748, 2421.309926670899, 2426.9757302427015, 1889.9149538270742, 2205.4155648753094, 2320.6403007533777, 2371.312319427364, 2394.365493144318, 2342.7071616047992, 2362.716474023111, 2362.7637236276405, 2367.7987371073395, 2370.3718514593647, 2363.775441333071, 2385.5348207099623, 2397.113068164773, 2397.4246180916452, 2403.639454081884, 8564.186402291773, 8577.228049475578, 8655.523946182957, 8665.610047547812, 8678.262347700453, 4320.438343015419, 5354.651947623392, 5362.490563396471, 5363.0, 5364.91952620711, 3431.571053618298, 3571.8571257149683, 3573.3925232710503, 3588.6949609283242, 3627.147620309225, 1222.541546919905, 1265.4432049898016, 1293.4308904082175, 1312.61277923012, 1319.9538016169483, 9140.588673509708, 11090.445477726162, 11119.499622517005, 11123.499442525106, 11125.944370278177, 4523.457185137804, 4756.524347565216, 4815.2054910939305, 4837.95162048375, 4840.564349208588, 9572.473513956798, 9592.66425675098, 9596.23230141587, 9598.568064436977, 9614.0, 5312.017276803804, 5398.1362981923485, 5403.108487099663, 5405.513503784599, 5418.376886658085, 4434.423524941737, 4436.334549817489, 4665.46347170073, 4962.776675049631, 4965.35450391454, 3856.710746693953, 3875.806209689504, 3992.061865461614, 3997.700172487075, 4009.859654912064, 1268.8604253532103, 1275.5280546197966, 1286.8777466140702, 1287.0925997171971, 1295.520657356784, 913.5751875377981, 915.8368871533115, 935.5602866652663, 937.2970272295778, 987.225028352754, 5601.5238704710555, 5601.915971260434, 5833.150559288591, 5834.737436815353, 5874.882502350015, 585.1486087742325, 594.1207013619867, 959.2326139088701, 1001.5042553935848, 1051.085555566662, 3771.73597848148, 3804.1250512382308, 3833.290841194332, 3916.4712763777097, 3968.7023473239046, 8721.43310684816, 10312.0, 10408.271421000609, 10418.01028902253, 10419.218558608134, 10039.0, 10099.646512372032, 10424.739381515372, 10426.478676066166, 10435.739106522398, 7971.60141992898, 7999.400044996649, 8098.554579498066, 8146.5519396433765, 8151.429399942066, 5532.751026203911, 5559.33288005442, 5693.4875861172695, 5698.344690360495, 5874.412558744262, 9291.519170364407, 9418.811623767624, 9421.057894210524, 9526.523673816142, 9542.99798521173, 9526.571304291461, 9576.808463830825, 9637.325387222827, 9648.469334186688, 9691.176250018827, 6431.967840160769, 6641.103451034049, 6937.306269373023, 7058.082449281561, 7060.223375428802, 7860.764177074697, 8139.023317201973, 8218.753437396888, 8245.546494942835, 8248.587570621325, 5861.794837180678, 6398.0402939559435, 6817.216020157745, 7116.25279345682, 7147.142342918883, 6968.825779355557, 6977.232504424408, 6980.7905762827195, 7003.719851205895, 7020.508564400443, 6434.549581529248, 6467.256265529336, 6475.838104047248, 6510.869782604416, 6527.379898909596, 5014.272930425141, 5036.597072234285, 5068.341115655089, 5117.641765076409, 5118.38579370478, 4202.621764041251, 5015.22264049073, 5155.123628983157, 5176.223566465061, 5179.19722443022], "value": 4489.705769434332, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.8868912846811, 368.1661037749496, 377.43573357830047, 387.1405479834766, 388.98444062237513, 5409.215663728757, 5449.0, 5514.255575497306, 5527.198556209347, 5537.8061767838135, 4345.804438800254, 4999.675021123624, 5038.84883453497, 5240.266362709223, 5457.208704737811, 3820.312343778112, 3825.617438256166, 4196.601322874338, 4233.661307095425, 4271.893202669942, 3791.981040094796, 3849.942250866239, 3943.960560394388, 4053.4122552230056, 4095.0, 3553.502509648651, 3877.4571559981623, 4147.440095587087, 4183.569473032115, 4199.202151591203, 3785.5835858055593, 3861.1119442528234, 3946.2699400610977, 4141.772202528859, 4171.520275168364, 3696.7042636589276, 3697.759645623026, 3709.870154544605, 3713.4429835524616, 3718.219173973469, 5067.2145817397995, 5236.502532259429, 5247.140308531822, 5279.86800329991, 5280.996610643965, 3996.820143093568, 4795.0100708206055, 4852.8301509447, 4855.441624213226, 4874.585660218886, 4799.920017995958, 5644.717764111778, 5650.434956504358, 5662.37713851476, 5671.914921276184, 3953.644172024503, 4158.7296825706235, 4166.437530933315, 4167.874963751093, 4172.165566886635, 4853.417589889201, 5573.804916827891, 5624.578156638268, 5827.941720582782, 5844.707764611752, 3454.775439596418, 4188.623023927861, 4191.413202151702, 4193.517745459311, 4195.16096780639, 3793.279276937373, 4234.280172370704, 4263.866058447039, 4268.304864648861, 4299.183155200564, 3970.940435893464, 4614.960467108434, 4800.35195248644, 4826.251930950708, 4878.878028049327, 5609.775608975595, 5641.856094683993, 5659.424961642443, 5664.433556644302, 5666.829995100154, 1257.8867901888873, 1271.0806681910383, 1315.5592876386327, 1384.8742180752697, 1397.699494608664, 785.395245660838, 847.576211894053, 942.6700654770913, 947.6588428165854, 984.247051005981, 4163.417121602978, 4914.70511769295, 4990.525900039491, 5053.8736531587, 5069.847904562869, 4674.813007479731, 5193.610479214074, 5424.891502169935, 5505.4584716279505, 5529.834104976857, 4636.976815115903, 4699.530046995342, 4840.88659608285, 4953.950460495421, 5043.51997121992, 2283.794458498743, 2486.3908342456216, 2551.706553746306, 2750.5697037540367, 2794.5389010813396, 4822.517748225149, 5018.5232402921665, 5048.081728942978, 5620.3255609326325, 5647.068233741469, 4735.366298626968, 5054.873628159326, 5658.603897727202, 5897.426931549644, 6037.9396206038255, 5457.263269458652, 5792.304923409133, 5948.8810223796145, 6002.729877155539, 6015.428534289235, 5490.972545137249, 5616.943830561642, 5776.526985618809, 5795.362510123968, 5816.47651711348, 4795.664303498722, 5653.773849045992, 5676.886462270649, 5734.5125664319, 5740.741666624928, 5499.395066542597, 5984.670843103671, 6005.3967619427995, 6029.487493563096, 6033.78881739137, 3491.8428670710387, 3612.9638703612627, 3705.5368078990127, 3897.5517815450453, 3961.504811898513, 5025.698458092526, 5670.943290567042, 5797.5361971041375, 5817.709114544171, 5826.94173058264, 4798.904021919612, 5059.620528460307, 5630.284012551696, 5664.320281566238, 5707.486326230493, 4482.529334419839, 4847.491013443679, 5616.775328986958, 5658.801941932013, 5706.857328566819, 5296.232046353334, 5554.917021053354, 5571.774209673866, 5585.156898223495, 5602.0, 4595.655325850507, 4835.516448355136, 5525.502704756591, 5565.415631358649, 5634.718264086698, 4967.230079337708, 5142.408623008252, 5328.254044433705, 5409.1594967573465, 5436.483534064258], "value": 4120.316690659509, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.1880703016132, 736.9557826530408, 757.3524636435844, 802.9785361463955, 857.6226460357443, 15779.526614201564, 16010.519684409457, 16156.515304540882, 16163.0, 16186.190690465488, 16234.269457874394, 16868.49394518163, 17020.48938531843, 17388.82611173888, 17403.91298043511, 839.8446287436814, 917.4907926101012, 934.4533447932968, 935.8315503209419, 937.6296362936636, 928.749237705819, 929.6142101028065, 930.2372054914972, 931.1805611062256, 932.4405356785908, 766.7048186448229, 798.7963069417291, 952.5284983932928, 976.3360914578084, 985.7929834734714, 974.7270764185969, 976.1848856205041, 976.7558110472382, 978.6868202175307, 978.8042391521689, 729.1869565434555, 730.1165589636546, 730.6821532633269, 733.1532080447092, 733.8568979049088, 16202.513924582281, 16215.513534593982, 16301.266443010092, 16335.918320408322, 16357.59106022347, 14030.649233769238, 14231.0, 14317.42730290787, 14368.13791172533, 14373.640658983504, 12765.170263932814, 12932.547360842325, 12956.80564791529, 13660.180389176681, 13692.863071369258, 4568.931466028012, 4644.777371187802, 4651.5813576778255, 4779.283107533898, 4795.448523419816, 106843.0, 116845.0, 116905.6618867618, 119456.0, 119813.0, 10833.83749243762, 11165.330080195214, 11185.776284474265, 11428.885711142782, 11474.54101835934, 21977.67033494499, 22182.667259991114, 22228.222012229817, 22242.66636000429, 22270.0, 7928.405369597303, 7967.482113662593, 7999.240072193133, 8147.470414423044, 8194.180581941877, 4362.847300344472, 4380.474343078851, 4523.751193684313, 4666.673332866667, 4709.175894218567, 3542.787432754043, 3576.266865292661, 3609.8556057757396, 3635.836387362575, 3646.507721457622, 578.4389142531737, 688.1398252184769, 688.2016860441963, 701.2846896165883, 704.5842952657956, 536.9221462887859, 650.778735230024, 661.9536632435779, 667.8731041102175, 668.2248591633681, 9753.756156096013, 9957.153641940517, 10013.79972400548, 10312.226583006304, 10443.216758743125, 619.3960888134034, 629.9322648111498, 639.9232092148878, 641.563736659067, 741.985160296791, 4926.359573255454, 5235.947640523622, 5240.633155679142, 5245.291885595472, 5257.106291930381, 99641.50179249202, 103335.96664033414, 105573.47213264038, 105780.0, 107412.0, 88052.5597372009, 91656.54171729232, 91952.0, 93284.60073098908, 93588.0, 71700.0, 76226.0, 77306.84039739409, 77851.22148778666, 78531.60734196292, 10928.0, 11103.57293188383, 11164.274322169033, 11191.32852028881, 11434.94282528582, 50428.991420170656, 51319.0, 51953.0, 53237.0, 53432.46567534275, 60214.69892650684, 61951.76096478135, 72465.63767181341, 73624.89562656672, 76617.85073223794, 12707.36463176856, 12824.294663793207, 13033.057025866146, 13215.273159976294, 13526.52657157034, 14521.419143234574, 14873.405063797327, 14943.324780150058, 15045.548633541011, 15046.32291546861, 13539.932300338829, 13691.24698141572, 14118.576442706735, 14164.575062748134, 14171.362288696828, 13450.730985380433, 13597.728045438838, 13979.44082236699, 14135.64660883486, 14384.784228236795, 13029.283389413673, 13841.653958651113, 13995.790063148857, 14155.079919805179, 14400.783988240395, 9635.951820240854, 9883.950580247052, 10302.381857088598, 10383.376997380181, 10515.57937682484, 10019.198464122706, 10498.947505262426, 11487.36819474937, 11551.191416600757, 11584.478698458759], "value": 7843.299578325879, "unit": "score"}], "name": "dromaeo_css", "value": 7509.312873819244, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0, 113.0, 114.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 105.0, 104.0, 140.0, 105.0, 106.0, 106.0, 100.0, 125.0, 106.0], "value": 113.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 180.0, 182.0, 181.0, 181.0, 181.0, 182.0, 181.0, 181.0, 181.0], "value": 181.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 57.0, 87.0, 59.0, 59.0, 57.0, 82.0, 71.0, 57.0], "value": 66.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 69.0, 84.0, 69.0, 67.0, 69.0, 80.0, 67.0, 68.0, 80.0], "value": 73.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 130.0, 88.0, 86.0, 88.0, 85.0, 89.0, 86.0, 89.0, 85.0], "value": 91.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 93.0, 93.0, 93.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 84.0, 87.0, 87.0, 97.0, 139.0, 131.0, 87.0, 87.0], "value": 97.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 54.0, 52.0, 55.0, 56.0, 55.0, 56.0, 54.0, 55.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 69.0, 75.0, 70.0, 67.0, 68.0, 67.0, 69.0, 68.0], "value": 68.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 85.0, 82.0, 92.0, 99.0, 100.0, 80.0, 87.0, 81.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 130.0, 130.0, 133.0, 128.0, 132.0, 133.0, 134.0, 187.0, 154.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 161.0, 162.0, 162.0, 159.0, 159.0, 160.0, 159.0, 160.0, 158.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 64.0, 79.0, 64.0, 60.0, 70.0, 82.0, 80.0, 81.0, 67.0], "value": 70.3, "unit": "score"}], "name": "kraken", "value": 1410.0, "alertThreshold": 2.0}]} 22:53:15 INFO - Return code: 0 22:53:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:53:15 INFO - # TBPL SUCCESS # 22:53:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:53:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:53:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:53:15 INFO - 2017-04-02 22:53:15.597 screenresolution[1651:9965] starting screenresolution argv=screenresolution get 22:53:15 INFO - 2017-04-02 22:53:15.600 screenresolution[1651:9965] Display 0: 1600x1200x32@60 22:53:15 INFO - 2017-04-02 22:53:15.606 screenresolution[1652:9968] starting screenresolution argv=screenresolution list 22:53:15 INFO - Available Modes on Display 0 22:53:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:53:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:53:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:53:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:53:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:53:15 INFO - Intel Iris: 22:53:15 INFO - Chipset Model: Intel Iris 22:53:15 INFO - Type: GPU 22:53:15 INFO - Bus: Built-In 22:53:15 INFO - VRAM (Dynamic, Max): 1536 MB 22:53:15 INFO - Vendor: Intel (0x8086) 22:53:15 INFO - Device ID: 0x0a2e 22:53:15 INFO - Revision ID: 0x0009 22:53:15 INFO - Displays: 22:53:15 INFO - Display: 22:53:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:53:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:53:15 INFO - Display Serial Number: 1600x1200 60 22:53:15 INFO - Main Display: Yes 22:53:15 INFO - Mirror: Off 22:53:15 INFO - Online: Yes 22:53:15 INFO - Rotation: Supported 22:53:15 INFO - Return code: 0 22:53:15 INFO - Running post-action listener: _resource_record_post_action 22:53:15 INFO - [mozharness: 2017-04-03 05:53:15.840634Z] Finished run-tests step (success) 22:53:15 INFO - Running post-run listener: _resource_record_post_run 22:53:15 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 39089152; Write bytes: 421340672; Read time: 250; Write time: 1376 22:53:15 INFO - TinderboxPrint: CPU usage
53.6% 22:53:15 INFO - TinderboxPrint: I/O read bytes / time
39,089,152 / 250 22:53:15 INFO - TinderboxPrint: I/O write bytes / time
421,340,672 / 1,376 22:53:15 INFO - TinderboxPrint: CPU idle
2,207.5 (46.4%) 22:53:15 INFO - TinderboxPrint: CPU system
952.2 (20.0%) 22:53:15 INFO - TinderboxPrint: CPU user
1,602.0 (33.6%) 22:53:15 INFO - TinderboxPrint: Swap in / out
159,858,688 / 0 22:53:15 INFO - install - Wall time: 15s; CPU: 53.0%; Read bytes: 109820416; Write bytes: 102166528; Read time: 9949; Write time: 225 22:53:15 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 38122496; Write bytes: 298644992; Read time: 238; Write time: 1090 22:53:16 INFO - Running post-run listener: _upload_blobber_files 22:53:16 INFO - Blob upload gear active. 22:53:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:53:16 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 22:53:16 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'] 22:53:16 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 22:53:16 INFO - (blobuploader) - INFO - Open directory for files ... 22:53:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:53:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:53:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:53:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:53:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:53:17 INFO - (blobuploader) - INFO - Done attempting. 22:53:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:53:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:53:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:53:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:53:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:53:18 INFO - (blobuploader) - INFO - Done attempting. 22:53:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:53:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:53:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:53:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:53:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:53:19 INFO - (blobuploader) - INFO - Done attempting. 22:53:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:53:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:53:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:53:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:53:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:53:22 INFO - (blobuploader) - INFO - Done attempting. 22:53:22 INFO - (blobuploader) - INFO - Iteration through files over. 22:53:22 INFO - Return code: 0 22:53:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:53:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:53:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b798e1571ca98ff7414e54d23e12c6a379605ebf6d2aa1204ca17aa7fa03227ca3af30ef332ac8462bb76340dcce00fa4587a6a2681e91184ca14b66262f108b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0db661d22ba10fa038395a42b840b6dd13aabc0b4572a21155d34e13315225635c9923e7a3734ab21a0a0576a4b8c5ee00863a8269eceab7b030a7e4afda4d44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/78387bc4e64f96440293f94b13ed63c3e51b00b54e7cd0952ddaf1d20124708dce091db9f3004d7f83a687142a2657105f882cace7081781fb8f8892d206e8ac", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/db214b20b52f2b99afb64c013128b52a16c069f24ed743c5fb5afd7e769107e7f84896598853036a558708edfc68e2678df6eed1acd8ab70723c73589ef9d675"} 22:53:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:53:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:53:22 INFO - Contents: 22:53:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b798e1571ca98ff7414e54d23e12c6a379605ebf6d2aa1204ca17aa7fa03227ca3af30ef332ac8462bb76340dcce00fa4587a6a2681e91184ca14b66262f108b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0db661d22ba10fa038395a42b840b6dd13aabc0b4572a21155d34e13315225635c9923e7a3734ab21a0a0576a4b8c5ee00863a8269eceab7b030a7e4afda4d44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/78387bc4e64f96440293f94b13ed63c3e51b00b54e7cd0952ddaf1d20124708dce091db9f3004d7f83a687142a2657105f882cace7081781fb8f8892d206e8ac", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/db214b20b52f2b99afb64c013128b52a16c069f24ed743c5fb5afd7e769107e7f84896598853036a558708edfc68e2678df6eed1acd8ab70723c73589ef9d675"} 22:53:22 INFO - Running post-run listener: copy_logs_to_upload_dir 22:53:22 INFO - Copying logs to upload dir... 22:53:22 INFO - mkdir: /builds/slave/test/build/upload/logs 22:53:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.885363 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-04-02 22:53:22.194611) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-02 22:53:22.198173) ========= 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.MdJfoF4nxd/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.9G7SdMUYPA/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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/b798e1571ca98ff7414e54d23e12c6a379605ebf6d2aa1204ca17aa7fa03227ca3af30ef332ac8462bb76340dcce00fa4587a6a2681e91184ca14b66262f108b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0db661d22ba10fa038395a42b840b6dd13aabc0b4572a21155d34e13315225635c9923e7a3734ab21a0a0576a4b8c5ee00863a8269eceab7b030a7e4afda4d44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/78387bc4e64f96440293f94b13ed63c3e51b00b54e7cd0952ddaf1d20124708dce091db9f3004d7f83a687142a2657105f882cace7081781fb8f8892d206e8ac", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/db214b20b52f2b99afb64c013128b52a16c069f24ed743c5fb5afd7e769107e7f84896598853036a558708edfc68e2678df6eed1acd8ab70723c73589ef9d675"} build_url:https://queue.taskcluster.net/v1/task/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011081 build_url: 'https://queue.taskcluster.net/v1/task/OiK5arCoR0Cq1gy5tOSAvg/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b798e1571ca98ff7414e54d23e12c6a379605ebf6d2aa1204ca17aa7fa03227ca3af30ef332ac8462bb76340dcce00fa4587a6a2681e91184ca14b66262f108b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0db661d22ba10fa038395a42b840b6dd13aabc0b4572a21155d34e13315225635c9923e7a3734ab21a0a0576a4b8c5ee00863a8269eceab7b030a7e4afda4d44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/78387bc4e64f96440293f94b13ed63c3e51b00b54e7cd0952ddaf1d20124708dce091db9f3004d7f83a687142a2657105f882cace7081781fb8f8892d206e8ac", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/db214b20b52f2b99afb64c013128b52a16c069f24ed743c5fb5afd7e769107e7f84896598853036a558708edfc68e2678df6eed1acd8ab70723c73589ef9d675"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-02 22:53:22.232615) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 22:53:22.232947) ========= 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.MdJfoF4nxd/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.9G7SdMUYPA/Listeners TMPDIR=/var/folders/f2/j76sx_xn7bbccz1zz5dv8zth00000w/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.005234 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 22:53:22.281348) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-02 22:53:22.281643) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-02 22:53:22.281973) ========= ========= Total master_lag: 1.04 =========