builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0362 starttime: 1474596584.58 results: success (0) buildid: 20160922165659 builduid: 8490fcee4df24f71a33684dbcf3162e5 revision: bc17447fefc995c71a6a97a5a5a0f19783df5ad1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 19:09:44.577102) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 19:09:44.577640) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 19:09:44.578009) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 19:09:44.606536) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 19:09:44.606866) ========= 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.UmVrfe8Gek/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.FfnUX0OJPx/Listeners TMPDIR=/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-22 19:09:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 163M=0s 2016-09-22 19:09:45 (163 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.513159 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 19:09:45.146396) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 19:09:45.146774) ========= 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.UmVrfe8Gek/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.FfnUX0OJPx/Listeners TMPDIR=/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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.021027 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 19:09:45.195727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 30 secs) (at 2016-09-22 19:09:45.196125) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bc17447fefc995c71a6a97a5a5a0f19783df5ad1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bc17447fefc995c71a6a97a5a5a0f19783df5ad1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UmVrfe8Gek/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.FfnUX0OJPx/Listeners TMPDIR=/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-22 19:09:45,281 truncating revision to first 12 chars 2016-09-22 19:09:45,281 Setting DEBUG logging. 2016-09-22 19:09:45,281 attempt 1/10 2016-09-22 19:09:45,281 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bc17447fefc9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 19:09:51,864 unpacking tar archive at: mozilla-aurora-bc17447fefc9/testing/mozharness/ program finished with exit code 0 elapsedTime=30.705572 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 30 secs) (at 2016-09-22 19:10:15.927603) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 19:10:15.928383) ========= script_repo_revision: bc17447fefc995c71a6a97a5a5a0f19783df5ad1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 19:10:15.928866) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 19:10:15.929179) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 19:10:15.948363) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-09-22 19:10:15.948715) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UmVrfe8Gek/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.FfnUX0OJPx/Listeners TMPDIR=/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 19:10:16 INFO - MultiFileLogger online at 20160922 19:10:16 in /builds/slave/test 19:10:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:10:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:10:16 INFO - {'append_to_log': False, 19:10:16 INFO - 'base_work_dir': '/builds/slave/test', 19:10:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:10:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:10:16 INFO - 'branch': 'Mozilla-Aurora', 19:10:16 INFO - 'buildbot_json_path': 'buildprops.json', 19:10:16 INFO - 'config_files': ('talos/mac_config.py',), 19:10:16 INFO - 'default_actions': ('clobber', 19:10:16 INFO - 'read-buildbot-config', 19:10:16 INFO - 'download-and-extract', 19:10:16 INFO - 'populate-webroot', 19:10:16 INFO - 'create-virtualenv', 19:10:16 INFO - 'install', 19:10:16 INFO - 'run-tests'), 19:10:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:10:16 INFO - 'download_minidump_stackwalk': True, 19:10:16 INFO - 'download_symbols': 'ondemand', 19:10:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:10:16 INFO - 'tooltool.py': '/tools/tooltool.py', 19:10:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:10:16 INFO - '/tools/misc-python/virtualenv.py')}, 19:10:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:10:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:10:16 INFO - 'installer_path': 'installer.exe', 19:10:16 INFO - 'log_level': 'info', 19:10:16 INFO - 'log_name': 'talos', 19:10:16 INFO - 'log_to_console': True, 19:10:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:10:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:10:16 INFO - 'opt_config_files': (), 19:10:16 INFO - 'pip_index': False, 19:10:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:10:16 INFO - 'cmd': ('bash', 19:10:16 INFO - '-c', 19:10:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:10:16 INFO - 'enabled': True, 19:10:16 INFO - 'halt_on_failure': False, 19:10:16 INFO - 'name': 'check_screen_resolution'},), 19:10:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:10:16 INFO - 'cmd': ('bash', 19:10:16 INFO - '-c', 19:10:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:10:16 INFO - 'enabled': True, 19:10:16 INFO - 'halt_on_failure': False, 19:10:16 INFO - 'name': 'check_screen_resolution'},), 19:10:16 INFO - 'run_cmd_checks_enabled': True, 19:10:16 INFO - 'sps_profile': False, 19:10:16 INFO - 'sps_profile_interval': 0, 19:10:16 INFO - 'suite': 'dromaeojs', 19:10:16 INFO - 'system_bits': '32', 19:10:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:10:16 INFO - 'title': 't-yosemite-r7-0362', 19:10:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:10:16 INFO - 'use_talos_json': True, 19:10:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:10:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:10:16 INFO - 'work_dir': 'build'} 19:10:16 INFO - [mozharness: 2016-09-23 02:10:16.145956Z] Running clobber step. 19:10:16 INFO - Running pre-action listener: _resource_record_pre_action 19:10:16 INFO - Running main action method: clobber 19:10:16 INFO - rmtree: /builds/slave/test/build 19:10:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:10:16 INFO - Running post-action listener: _resource_record_post_action 19:10:16 INFO - [mozharness: 2016-09-23 02:10:16.331916Z] Finished clobber step (success) 19:10:16 INFO - [mozharness: 2016-09-23 02:10:16.332075Z] Running read-buildbot-config step. 19:10:16 INFO - Running pre-action listener: _resource_record_pre_action 19:10:16 INFO - Running main action method: read_buildbot_config 19:10:16 INFO - Using buildbot properties: 19:10:16 INFO - { 19:10:16 INFO - "project": "", 19:10:16 INFO - "product": "firefox", 19:10:16 INFO - "script_repo_revision": "production", 19:10:16 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 19:10:16 INFO - "repository": "", 19:10:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 19:10:16 INFO - "buildid": "20160922165659", 19:10:16 INFO - "pgo_build": "False", 19:10:16 INFO - "basedir": "/builds/slave/test", 19:10:16 INFO - "buildnumber": 13, 19:10:16 INFO - "slavename": "t-yosemite-r7-0362", 19:10:16 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 19:10:16 INFO - "platform": "yosemite_r7", 19:10:16 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 19:10:16 INFO - "branch": "mozilla-aurora", 19:10:16 INFO - "repo_path": "releases/mozilla-aurora", 19:10:16 INFO - "revision": "bc17447fefc995c71a6a97a5a5a0f19783df5ad1", 19:10:16 INFO - "stage_platform": "macosx64", 19:10:16 INFO - "builduid": "8490fcee4df24f71a33684dbcf3162e5", 19:10:16 INFO - "slavebuilddir": "test" 19:10:16 INFO - } 19:10:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 19:10:16 INFO - Running post-action listener: _resource_record_post_action 19:10:16 INFO - [mozharness: 2016-09-23 02:10:16.335288Z] Finished read-buildbot-config step (success) 19:10:16 INFO - [mozharness: 2016-09-23 02:10:16.335407Z] Running download-and-extract step. 19:10:16 INFO - Running pre-action listener: _resource_record_pre_action 19:10:16 INFO - Running main action method: download_and_extract 19:10:16 INFO - mkdir: /builds/slave/test/build/tests 19:10:16 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')]} 19:10:16 INFO - trying https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 19:10:16 INFO - Downloading https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 19:10:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 19:10:17 INFO - Downloaded 1199 bytes. 19:10:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 19:10:17 INFO - Using the following test package requirements: 19:10:17 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 19:10:17 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:10:17 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 19:10:17 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:10:17 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 19:10:17 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:10:17 INFO - u'jsshell-mac.zip'], 19:10:17 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:10:17 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 19:10:17 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 19:10:17 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:10:17 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 19:10:17 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:10:17 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 19:10:17 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:10:17 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 19:10:17 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:10:17 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 19:10:17 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 19:10:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 19:10:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:10:17 INFO - Fetch https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 19:10:17 INFO - Expected file size: 16426587 19:10:24 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 19:10:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 19:10:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:10:24 INFO - Fetch https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 19:10:25 INFO - Expected file size: 16426587 19:10:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 19:10:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 19:10:32 INFO - Fetch https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 19:10:32 INFO - Expected file size: 14414059 19:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:33 INFO - trying https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:10:33 INFO - Downloading https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 19:10:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 19:10:36 INFO - Downloaded 115246970 bytes. 19:10:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:10:36 INFO - mkdir: /builds/slave/test/properties 19:10:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:10:36 INFO - Writing to file /builds/slave/test/properties/build_url 19:10:36 INFO - Contents: 19:10:36 INFO - build_url:https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:10:37 INFO - Running post-action listener: _resource_record_post_action 19:10:37 INFO - Running post-action listener: set_extra_try_arguments 19:10:37 INFO - [mozharness: 2016-09-23 02:10:37.026224Z] Finished download-and-extract step (success) 19:10:37 INFO - [mozharness: 2016-09-23 02:10:37.026344Z] Running populate-webroot step. 19:10:37 INFO - Running pre-action listener: _resource_record_pre_action 19:10:37 INFO - Running main action method: populate_webroot 19:10:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:10:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:10:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:10:37 INFO - '--tppagecycles', 19:10:37 INFO - '7'], 19:10:37 INFO - 'tests': ['tsvgm']}}, 19:10:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:10:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:10:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:10:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:10:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:10:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:10:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:37 INFO - 'talos_options': ['--disable-e10s'], 19:10:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:10:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:10:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:37 INFO - 'talos_options': ['--disable-e10s'], 19:10:37 INFO - 'tests': ['damp', 'tps']}, 19:10:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:37 INFO - 'tests': ['damp', 'tps']}, 19:10:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:10:37 INFO - 'tests': ['dromaeo_dom']}, 19:10:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:10:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:10:37 INFO - 'tests': ['basic_compositor_video']}, 19:10:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:10:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:10:37 INFO - 'tests': ['a11yr', 19:10:37 INFO - 'ts_paint', 19:10:37 INFO - 'tpaint', 19:10:37 INFO - 'sessionrestore', 19:10:37 INFO - 'sessionrestore_no_auto_restore', 19:10:37 INFO - 'tabpaint']}, 19:10:37 INFO - 'other-e10s': {'tests': ['a11yr', 19:10:37 INFO - 'ts_paint', 19:10:37 INFO - 'tpaint', 19:10:37 INFO - 'sessionrestore', 19:10:37 INFO - 'sessionrestore_no_auto_restore', 19:10:37 INFO - 'tabpaint']}, 19:10:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:10:37 INFO - 'ts_paint', 19:10:37 INFO - 'tpaint', 19:10:37 INFO - 'sessionrestore', 19:10:37 INFO - 'sessionrestore_no_auto_restore', 19:10:37 INFO - 'tabpaint']}, 19:10:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:10:37 INFO - 'ts_paint', 19:10:37 INFO - 'tpaint', 19:10:37 INFO - 'sessionrestore', 19:10:37 INFO - 'sessionrestore_no_auto_restore', 19:10:37 INFO - 'tabpaint']}, 19:10:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:10:37 INFO - 'tests': ['a11yr', 19:10:37 INFO - 'ts_paint', 19:10:37 INFO - 'tpaint', 19:10:37 INFO - 'sessionrestore', 19:10:37 INFO - 'sessionrestore_no_auto_restore', 19:10:37 INFO - 'tabpaint']}, 19:10:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:10:37 INFO - 'tests': ['a11yr', 19:10:37 INFO - 'ts_paint', 19:10:37 INFO - 'tpaint', 19:10:37 INFO - 'sessionrestore', 19:10:37 INFO - 'sessionrestore_no_auto_restore', 19:10:37 INFO - 'tabpaint']}, 19:10:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:10:37 INFO - 'tests': ['tsvgx', 19:10:37 INFO - 'tsvgr_opacity', 19:10:37 INFO - 'tart', 19:10:37 INFO - 'tscrollx', 19:10:37 INFO - 'cart']}, 19:10:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:10:37 INFO - 'tsvgr_opacity', 19:10:37 INFO - 'tart', 19:10:37 INFO - 'tscrollx', 19:10:37 INFO - 'cart']}, 19:10:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:37 INFO - 'talos_options': ['--disable-e10s'], 19:10:37 INFO - 'tests': ['tp5o']}, 19:10:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:37 INFO - 'tests': ['tp5o']}, 19:10:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:37 INFO - 'talos_options': ['--disable-e10s', 19:10:37 INFO - '--xperf_path', 19:10:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:10:37 INFO - 'tests': ['tp5n']}, 19:10:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:37 INFO - 'talos_options': ['--xperf_path', 19:10:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:10:37 INFO - 'tests': ['tp5n']}}, 19:10:37 INFO - 'talos.zip': {'path': '', 19:10:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:10:37 INFO - Running post-action listener: _resource_record_post_action 19:10:37 INFO - [mozharness: 2016-09-23 02:10:37.044640Z] Finished populate-webroot step (success) 19:10:37 INFO - [mozharness: 2016-09-23 02:10:37.044757Z] Running create-virtualenv step. 19:10:37 INFO - Running pre-action listener: _resource_record_pre_action 19:10:37 INFO - Running main action method: create_virtualenv 19:10:37 INFO - Creating virtualenv /builds/slave/test/build/venv 19:10:37 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 19:10:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:10:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:10:37 INFO - Using real prefix '/tools/python27' 19:10:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:10:37 INFO - Installing distribute.............................................................................................................................................................................................done. 19:10:40 INFO - Installing pip.................done. 19:10:40 INFO - Return code: 0 19:10:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:40 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 0x107f8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4e3cc6fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107da0d30>, '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 0x107c06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d98b20>, '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.UmVrfe8Gek/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.FfnUX0OJPx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 19:10:40 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 19:10:40 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 19:10:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UmVrfe8Gek/Render', 19:10:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:40 INFO - 'HOME': '/Users/cltbld', 19:10:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:40 INFO - 'LOGNAME': 'cltbld', 19:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:40 INFO - 'MOZ_NO_REMOTE': '1', 19:10:40 INFO - 'NO_EM_RESTART': '1', 19:10:40 INFO - 'PAGER': '/bin/cat', 19:10:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:40 INFO - 'PWD': '/builds/slave/test', 19:10:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:40 INFO - 'SHELL': '/bin/bash', 19:10:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfnUX0OJPx/Listeners', 19:10:40 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 19:10:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:40 INFO - 'USER': 'cltbld', 19:10:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:40 INFO - 'XPC_FLAGS': '0x0', 19:10:40 INFO - 'XPC_SERVICE_NAME': '0', 19:10:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:40 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 19:10:40 INFO - Cleaning up... 19:10:41 INFO - Return code: 0 19:10:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107f8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4e3cc6fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107da0d30>, '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 0x107c06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d98b20>, '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.UmVrfe8Gek/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.FfnUX0OJPx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 19:10:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:10:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UmVrfe8Gek/Render', 19:10:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:41 INFO - 'HOME': '/Users/cltbld', 19:10:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:41 INFO - 'LOGNAME': 'cltbld', 19:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:41 INFO - 'MOZ_NO_REMOTE': '1', 19:10:41 INFO - 'NO_EM_RESTART': '1', 19:10:41 INFO - 'PAGER': '/bin/cat', 19:10:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:41 INFO - 'PWD': '/builds/slave/test', 19:10:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:41 INFO - 'SHELL': '/bin/bash', 19:10:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfnUX0OJPx/Listeners', 19:10:41 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 19:10:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:41 INFO - 'USER': 'cltbld', 19:10:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:41 INFO - 'XPC_FLAGS': '0x0', 19:10:41 INFO - 'XPC_SERVICE_NAME': '0', 19:10:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:41 INFO - Downloading/unpacking psutil>=3.1.1 19:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:10:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:10:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:10:44 INFO - Installing collected packages: psutil 19:10:44 INFO - Running setup.py install for psutil 19:10:44 INFO - building 'psutil._psutil_osx' extension 19:10:44 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 19:10:44 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 19:10:44 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 19:10:44 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 19:10:44 INFO - building 'psutil._psutil_posix' extension 19:10:44 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 19:10:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:10:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:10:44 INFO - ^ 19:10:44 INFO - 1 warning generated. 19:10:44 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 19:10:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:10:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:10:45 INFO - Successfully installed psutil 19:10:45 INFO - Cleaning up... 19:10:45 INFO - Return code: 0 19:10:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:10:45 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')]} 19:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:45 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')]} 19:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:45 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 0x107f8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4e3cc6fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107da0d30>, '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 0x107c06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d98b20>, '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.UmVrfe8Gek/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.FfnUX0OJPx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 19:10:45 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 19:10:45 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 19:10:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UmVrfe8Gek/Render', 19:10:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:45 INFO - 'HOME': '/Users/cltbld', 19:10:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:45 INFO - 'LOGNAME': 'cltbld', 19:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:45 INFO - 'MOZ_NO_REMOTE': '1', 19:10:45 INFO - 'NO_EM_RESTART': '1', 19:10:45 INFO - 'PAGER': '/bin/cat', 19:10:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:45 INFO - 'PWD': '/builds/slave/test', 19:10:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:45 INFO - 'SHELL': '/bin/bash', 19:10:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfnUX0OJPx/Listeners', 19:10:45 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 19:10:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:45 INFO - 'USER': 'cltbld', 19:10:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:45 INFO - 'XPC_FLAGS': '0x0', 19:10:45 INFO - 'XPC_SERVICE_NAME': '0', 19:10:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:10:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:10:48 INFO - Installing collected packages: mozsystemmonitor 19:10:48 INFO - Running setup.py install for mozsystemmonitor 19:10:48 INFO - Successfully installed mozsystemmonitor 19:10:48 INFO - Cleaning up... 19:10:48 INFO - Return code: 0 19:10:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:10: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')]} 19:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10: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')]} 19:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:48 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 0x107f8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4e3cc6fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107da0d30>, '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 0x107c06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d98b20>, '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.UmVrfe8Gek/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.FfnUX0OJPx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 19:10:48 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 19:10:48 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 19:10:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UmVrfe8Gek/Render', 19:10:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:48 INFO - 'HOME': '/Users/cltbld', 19:10:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:48 INFO - 'LOGNAME': 'cltbld', 19:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:48 INFO - 'MOZ_NO_REMOTE': '1', 19:10:48 INFO - 'NO_EM_RESTART': '1', 19:10:48 INFO - 'PAGER': '/bin/cat', 19:10:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:48 INFO - 'PWD': '/builds/slave/test', 19:10:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:48 INFO - 'SHELL': '/bin/bash', 19:10:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfnUX0OJPx/Listeners', 19:10:48 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 19:10:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:48 INFO - 'USER': 'cltbld', 19:10:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:48 INFO - 'XPC_FLAGS': '0x0', 19:10:48 INFO - 'XPC_SERVICE_NAME': '0', 19:10:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:48 INFO - Downloading/unpacking jsonschema==2.5.1 19:10:48 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 19:10:48 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 19:10:48 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 19:10:48 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 19:10:48 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 19:10:48 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 19:10:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:10:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:10:51 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 19:10:51 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 19:10:51 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 19:10:51 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 19:10:51 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 19:10:51 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 19:10:51 INFO - Downloading functools32-3.2.3-2.tar.gz 19:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:10:51 INFO - warning: no files found matching '*.txt' 19:10:51 INFO - no previously-included directories found matching 'build' 19:10:51 INFO - no previously-included directories found matching 'dist' 19:10:51 INFO - no previously-included directories found matching '.git*' 19:10:51 INFO - Installing collected packages: jsonschema, functools32 19:10:51 INFO - Running setup.py install for functools32 19:10:51 INFO - warning: no files found matching '*.txt' 19:10:51 INFO - no previously-included directories found matching 'build' 19:10:51 INFO - no previously-included directories found matching 'dist' 19:10:51 INFO - no previously-included directories found matching '.git*' 19:10:51 INFO - Successfully installed jsonschema functools32 19:10:51 INFO - Cleaning up... 19:10:51 INFO - Return code: 0 19:10:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:51 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 0x107f8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4e3cc6fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107da0d30>, '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 0x107c06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d98b20>, '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.UmVrfe8Gek/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.FfnUX0OJPx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 19:10:51 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 19:10:51 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 19:10:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UmVrfe8Gek/Render', 19:10:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:51 INFO - 'HOME': '/Users/cltbld', 19:10:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:51 INFO - 'LOGNAME': 'cltbld', 19:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:51 INFO - 'MOZ_NO_REMOTE': '1', 19:10:51 INFO - 'NO_EM_RESTART': '1', 19:10:51 INFO - 'PAGER': '/bin/cat', 19:10:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:51 INFO - 'PWD': '/builds/slave/test', 19:10:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:51 INFO - 'SHELL': '/bin/bash', 19:10:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfnUX0OJPx/Listeners', 19:10:51 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 19:10:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:51 INFO - 'USER': 'cltbld', 19:10:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:51 INFO - 'XPC_FLAGS': '0x0', 19:10:51 INFO - 'XPC_SERVICE_NAME': '0', 19:10:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:10:52 INFO - Cleaning up... 19:10:52 INFO - Return code: 0 19:10:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:10:52 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')]} 19:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:52 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')]} 19:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:52 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 0x107f8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4e3cc6fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107da0d30>, '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 0x107c06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d98b20>, '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.UmVrfe8Gek/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.FfnUX0OJPx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 19:10:52 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 19:10:52 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 19:10:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UmVrfe8Gek/Render', 19:10:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:52 INFO - 'HOME': '/Users/cltbld', 19:10:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:52 INFO - 'LOGNAME': 'cltbld', 19:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:52 INFO - 'MOZ_NO_REMOTE': '1', 19:10:52 INFO - 'NO_EM_RESTART': '1', 19:10:52 INFO - 'PAGER': '/bin/cat', 19:10:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:52 INFO - 'PWD': '/builds/slave/test', 19:10:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:52 INFO - 'SHELL': '/bin/bash', 19:10:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfnUX0OJPx/Listeners', 19:10:52 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 19:10:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:52 INFO - 'USER': 'cltbld', 19:10:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:52 INFO - 'XPC_FLAGS': '0x0', 19:10:52 INFO - 'XPC_SERVICE_NAME': '0', 19:10:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:52 INFO - Downloading/unpacking blobuploader==1.2.4 19:10:52 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 19:10:52 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 19:10:52 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 19:10:52 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 19:10:52 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 19:10:52 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 19:10:54 INFO - Downloading blobuploader-1.2.4.tar.gz 19:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:10:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:10:54 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 19:10:54 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 19:10:54 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 19:10:54 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 19:10:54 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 19:10:54 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 19:10:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:10:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:10: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 19:10: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 19:10: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 19:10: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 19:10: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 19:10: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 19:10:56 INFO - Downloading docopt-0.6.1.tar.gz 19:10:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:10:56 INFO - Installing collected packages: blobuploader, requests, docopt 19:10:56 INFO - Running setup.py install for blobuploader 19:10:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:10:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:10:56 INFO - Running setup.py install for requests 19:10:56 INFO - Running setup.py install for docopt 19:10:56 INFO - Successfully installed blobuploader requests docopt 19:10:56 INFO - Cleaning up... 19:10:57 INFO - Return code: 0 19:10:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:57 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 0x107f8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4e3cc6fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107da0d30>, '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 0x107c06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d98b20>, '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.UmVrfe8Gek/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.FfnUX0OJPx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 19:10:57 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 19:10:57 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 19:10:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UmVrfe8Gek/Render', 19:10:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:10:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:10:57 INFO - 'HOME': '/Users/cltbld', 19:10:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:10:57 INFO - 'LOGNAME': 'cltbld', 19:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:57 INFO - 'MOZ_NO_REMOTE': '1', 19:10:57 INFO - 'NO_EM_RESTART': '1', 19:10:57 INFO - 'PAGER': '/bin/cat', 19:10:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:57 INFO - 'PWD': '/builds/slave/test', 19:10:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:10:57 INFO - 'SHELL': '/bin/bash', 19:10:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfnUX0OJPx/Listeners', 19:10:57 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 19:10:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:10:57 INFO - 'USER': 'cltbld', 19:10:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:10:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:57 INFO - 'XPC_FLAGS': '0x0', 19:10:57 INFO - 'XPC_SERVICE_NAME': '0', 19:10:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:10:57 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-GYJJUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:10:57 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-qtTScg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:10:57 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-s8gGhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:10:57 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-rRWS36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:10:57 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-egfEts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:10:57 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-LbB7Hi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:10:57 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-yS1nsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:10:58 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-5Rv1cY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:10:58 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-PSAxDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:10:58 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-4117Ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:10:58 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-5ZTjpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:10:58 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-3Tj6jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:10:58 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-QareJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:10:58 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-nlFNdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:58 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-S8qSz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:10:58 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-vssJqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:10:58 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-4uU3l3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:10:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:10:59 INFO - Running setup.py install for manifestparser 19:10:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:10:59 INFO - Running setup.py install for mozcrash 19:10:59 INFO - Running setup.py install for mozdebug 19:10:59 INFO - Running setup.py install for mozdevice 19:10:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:10:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:10:59 INFO - Running setup.py install for mozfile 19:10:59 INFO - Running setup.py install for mozhttpd 19:10:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:10:59 INFO - Running setup.py install for mozinfo 19:11:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:11:00 INFO - Running setup.py install for mozInstall 19:11:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:11:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:11:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:11:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:11:00 INFO - Running setup.py install for mozleak 19:11:00 INFO - Running setup.py install for mozlog 19:11:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:11:00 INFO - Running setup.py install for moznetwork 19:11:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:11:00 INFO - Running setup.py install for mozprocess 19:11:00 INFO - Running setup.py install for mozprofile 19:11:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:11:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:11:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:11:01 INFO - Running setup.py install for mozrunner 19:11:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:11:01 INFO - Running setup.py install for mozscreenshot 19:11:01 INFO - Running setup.py install for moztest 19:11:01 INFO - Running setup.py install for mozversion 19:11:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:11:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:11:01 INFO - Cleaning up... 19:11:01 INFO - Return code: 0 19:11:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:01 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')]} 19:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:01 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')]} 19:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:01 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 0x107f8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4e3cc6fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107da0d30>, '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 0x107c06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d98b20>, '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.UmVrfe8Gek/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.FfnUX0OJPx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 19:11:01 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 19:11:01 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 19:11:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UmVrfe8Gek/Render', 19:11:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:01 INFO - 'HOME': '/Users/cltbld', 19:11:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:01 INFO - 'LOGNAME': 'cltbld', 19:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:01 INFO - 'MOZ_NO_REMOTE': '1', 19:11:01 INFO - 'NO_EM_RESTART': '1', 19:11:01 INFO - 'PAGER': '/bin/cat', 19:11:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:01 INFO - 'PWD': '/builds/slave/test', 19:11:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:01 INFO - 'SHELL': '/bin/bash', 19:11:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfnUX0OJPx/Listeners', 19:11:01 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 19:11:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:01 INFO - 'USER': 'cltbld', 19:11:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:01 INFO - 'XPC_FLAGS': '0x0', 19:11:01 INFO - 'XPC_SERVICE_NAME': '0', 19:11:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:01 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-Qyf037-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:02 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)) 19:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:02 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-Nm_BLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:02 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-VT4dJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:02 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)) 19:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:02 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-QQ35wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:02 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-uOupan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:02 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)) 19:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:02 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-YZ0kEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:02 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)) 19:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:02 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-tJnGFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:02 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)) 19:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:02 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-CnM40y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:02 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)) 19:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:02 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-agLrdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:02 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)) 19:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:02 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-lq3HlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:02 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)) 19:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:02 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-tvxxAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:03 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)) 19:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:03 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-wrlHaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:03 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-knIQpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:03 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)) 19:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:03 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-0tMKO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:03 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-uoaJPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:03 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)) 19:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:03 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-eDh_6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:03 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-1Iar5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:03 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)) 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:11:03 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)) 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:11:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:11:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11:06 INFO - Downloading blessings-1.6.tar.gz 19:11:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:11:06 INFO - Installing collected packages: blessings 19:11:06 INFO - Running setup.py install for blessings 19:11:06 INFO - Successfully installed blessings 19:11:06 INFO - Cleaning up... 19:11:06 INFO - Return code: 0 19:11:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:11:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:06 INFO - Reading from file tmpfile_stdout 19:11:06 INFO - Current package versions: 19:11:06 INFO - blessings == 1.6 19:11:06 INFO - blobuploader == 1.2.4 19:11:06 INFO - docopt == 0.6.1 19:11:06 INFO - functools32 == 3.2.3-2 19:11:06 INFO - jsonschema == 2.5.1 19:11:06 INFO - manifestparser == 1.1 19:11:06 INFO - mozInstall == 1.12 19:11:06 INFO - mozcrash == 0.17 19:11:06 INFO - mozdebug == 0.1 19:11:06 INFO - mozdevice == 0.48 19:11:06 INFO - mozfile == 1.2 19:11:06 INFO - mozhttpd == 0.7 19:11:06 INFO - mozinfo == 0.9 19:11:06 INFO - mozleak == 0.1 19:11:06 INFO - mozlog == 3.4 19:11:06 INFO - moznetwork == 0.27 19:11:06 INFO - mozprocess == 0.23 19:11:06 INFO - mozprofile == 0.28 19:11:06 INFO - mozrunner == 6.12 19:11:06 INFO - mozscreenshot == 0.1 19:11:06 INFO - mozsystemmonitor == 0.3 19:11:06 INFO - moztest == 0.7 19:11:06 INFO - mozversion == 1.4 19:11:06 INFO - psutil == 3.1.1 19:11:06 INFO - requests == 1.2.3 19:11:06 INFO - wsgiref == 0.1.2 19:11:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:06 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')]} 19:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:06 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')]} 19:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:06 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 0x107f8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4e3cc6fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107da0d30>, '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 0x107c06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d98b20>, '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.UmVrfe8Gek/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.FfnUX0OJPx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 19:11:06 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 19:11:06 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 19:11:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UmVrfe8Gek/Render', 19:11:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:06 INFO - 'HOME': '/Users/cltbld', 19:11:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:06 INFO - 'LOGNAME': 'cltbld', 19:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:06 INFO - 'MOZ_NO_REMOTE': '1', 19:11:06 INFO - 'NO_EM_RESTART': '1', 19:11:06 INFO - 'PAGER': '/bin/cat', 19:11:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:06 INFO - 'PWD': '/builds/slave/test', 19:11:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:06 INFO - 'SHELL': '/bin/bash', 19:11:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfnUX0OJPx/Listeners', 19:11:06 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 19:11:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:06 INFO - 'USER': 'cltbld', 19:11:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:06 INFO - 'XPC_FLAGS': '0x0', 19:11:06 INFO - 'XPC_SERVICE_NAME': '0', 19:11:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:07 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)) 19:11:07 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)) 19:11:07 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)) 19:11:07 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)) 19:11:07 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)) 19:11:07 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)) 19:11:07 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)) 19:11:07 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)) 19:11:07 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)) 19:11:07 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)) 19:11:07 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)) 19:11:07 INFO - Cleaning up... 19:11:07 INFO - Return code: 0 19:11:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f8c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f02570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4e3cc6fe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107da0d30>, '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 0x107c06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d98b20>, '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.UmVrfe8Gek/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.FfnUX0OJPx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 19:11: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', 'jsonschema'] in /builds/slave/test/build 19:11: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 jsonschema 19:11:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UmVrfe8Gek/Render', 19:11:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:07 INFO - 'HOME': '/Users/cltbld', 19:11:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:07 INFO - 'LOGNAME': 'cltbld', 19:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:07 INFO - 'MOZ_NO_REMOTE': '1', 19:11:07 INFO - 'NO_EM_RESTART': '1', 19:11:07 INFO - 'PAGER': '/bin/cat', 19:11:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:07 INFO - 'PWD': '/builds/slave/test', 19:11:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:07 INFO - 'SHELL': '/bin/bash', 19:11:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfnUX0OJPx/Listeners', 19:11:07 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 19:11:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:07 INFO - 'USER': 'cltbld', 19:11:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:07 INFO - 'XPC_FLAGS': '0x0', 19:11:07 INFO - 'XPC_SERVICE_NAME': '0', 19:11:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:11:07 INFO - Cleaning up... 19:11:07 INFO - Return code: 0 19:11:07 INFO - Running post-action listener: _resource_record_post_action 19:11:07 INFO - Running post-action listener: _start_resource_monitoring 19:11:07 INFO - Starting resource monitoring. 19:11:07 INFO - [mozharness: 2016-09-23 02:11:07.385144Z] Finished create-virtualenv step (success) 19:11:07 INFO - [mozharness: 2016-09-23 02:11:07.386214Z] Running install step. 19:11:07 INFO - Running pre-action listener: _resource_record_pre_action 19:11:07 INFO - Running main action method: install 19:11:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:07 INFO - Reading from file tmpfile_stdout 19:11:07 INFO - Detecting whether we're running mozinstall >=1.0... 19:11:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:11:07 INFO - Reading from file tmpfile_stdout 19:11:07 INFO - Output received: 19:11:07 INFO - Usage: mozinstall [options] installer 19:11:07 INFO - Options: 19:11:07 INFO - -h, --help show this help message and exit 19:11:07 INFO - -d DEST, --destination=DEST 19:11:07 INFO - Directory to install application into. [default: 19:11:07 INFO - "/builds/slave/test"] 19:11:07 INFO - --app=APP Application being installed. [default: firefox] 19:11:07 INFO - mkdir: /builds/slave/test/build/application 19:11:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 19:11:39 INFO - Reading from file tmpfile_stdout 19:11:39 INFO - Output received: 19:11:39 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 19:11:39 INFO - Running post-action listener: _resource_record_post_action 19:11:39 INFO - [mozharness: 2016-09-23 02:11:39.605240Z] Finished install step (success) 19:11:39 INFO - [mozharness: 2016-09-23 02:11:39.605378Z] Running run-tests step. 19:11:39 INFO - Running pre-action listener: _resource_record_pre_action 19:11:39 INFO - Running main action method: run_tests 19:11:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:11:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:11:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:11:39 INFO - 2016-09-22 19:11:39.619 screenresolution[2022:279516] starting screenresolution argv=screenresolution get 19:11:39 INFO - 2016-09-22 19:11:39.622 screenresolution[2022:279516] Display 0: 1600x1200x32@60 19:11:39 INFO - 2016-09-22 19:11:39.628 screenresolution[2023:279518] starting screenresolution argv=screenresolution list 19:11:39 INFO - Available Modes on Display 0 19:11:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:11:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:11:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:11:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:11:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:11:39 INFO - Intel Iris: 19:11:39 INFO - Chipset Model: Intel Iris 19:11:39 INFO - Type: GPU 19:11:39 INFO - Bus: Built-In 19:11:39 INFO - VRAM (Dynamic, Max): 1536 MB 19:11:39 INFO - Vendor: Intel (0x8086) 19:11:39 INFO - Device ID: 0x0a2e 19:11:39 INFO - Revision ID: 0x0009 19:11:39 INFO - Displays: 19:11:39 INFO - Display: 19:11:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:11:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:11:39 INFO - Display Serial Number: 1600x1200 60 19:11:39 INFO - Main Display: Yes 19:11:39 INFO - Mirror: Off 19:11:39 INFO - Online: Yes 19:11:39 INFO - Rotation: Supported 19:11:39 INFO - Return code: 0 19:11:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:11:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:11:39 INFO - Python 2.7.3 19:11:39 INFO - Return code: 0 19:11:39 INFO - grabbing minidump binary from tooltool 19:11: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')]} 19:11: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 0x107da0d30>, '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 0x107c06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d98b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:11: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 19:11: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 19:11: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 19:11:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:11:40 INFO - Return code: 0 19:11:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:11:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:11:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:11:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:11:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0362', '--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 19:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0362 --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 19:11:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UmVrfe8Gek/Render', 19:11:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:40 INFO - 'HOME': '/Users/cltbld', 19:11:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:40 INFO - 'LOGNAME': 'cltbld', 19:11:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:11:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:40 INFO - 'MOZ_NO_REMOTE': '1', 19:11:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:11:40 INFO - 'NO_EM_RESTART': '1', 19:11:40 INFO - 'PAGER': '/bin/cat', 19:11:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:40 INFO - 'PWD': '/builds/slave/test', 19:11:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:11:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:40 INFO - 'SHELL': '/bin/bash', 19:11:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfnUX0OJPx/Listeners', 19:11:40 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 19:11:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:40 INFO - 'USER': 'cltbld', 19:11:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:40 INFO - 'XPC_FLAGS': '0x0', 19:11:40 INFO - 'XPC_SERVICE_NAME': '0', 19:11:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0362', '--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 19:11:40 INFO - mozversion application_buildid: 20160922165659 19:11:40 INFO - mozversion application_changeset: bc17447fefc995c71a6a97a5a5a0f19783df5ad1 19:11:40 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:11:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:11:40 INFO - mozversion application_name: Firefox 19:11:40 INFO - mozversion application_remotingname: firefox-dev 19:11:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:11:40 INFO - mozversion application_vendor: Mozilla 19:11:40 INFO - mozversion application_version: 51.0a2 19:11:40 INFO - mozversion platform_buildid: 20160922165659 19:11:40 INFO - mozversion platform_changeset: bc17447fefc995c71a6a97a5a5a0f19783df5ad1 19:11:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:11:40 INFO - mozversion platform_version: 51.0a2 19:11:40 INFO - using testdate: 1474596700 19:11:40 INFO - actual date: 1474596700 19:11:40 INFO - starting webserver on 'localhost:49374' 19:11:40 INFO - SUITE-START | Running 2 tests 19:11:40 INFO - TEST-START | dromaeo_css 19:11:40 INFO - operating with platform_type : mac_ 19:11:40 INFO - Initialising browser for dromaeo_css test... 19:11:40 INFO - TEST-INFO | started process 2033 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/tmp7OhWql/profile http://localhost:49374/getInfo.html) 19:11:42 INFO - PROCESS | 2033 | __metrics Screen width/height:1600/1200 19:11:42 INFO - PROCESS | 2033 | colorDepth:24 19:11:42 INFO - PROCESS | 2033 | Browser inner width/height: 1024/689 19:11:42 INFO - PROCESS | 2033 | __metrics 19:11:42 INFO - PROCESS | 2033 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:11:42 INFO - PROCESS | 2033 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:11:43 INFO - TEST-INFO | 2033: exit 0 19:11:43 INFO - Browser initialized. 19:11:43 INFO - Running cycle 1/1 for dromaeo_css test... 19:11:43 INFO - TEST-INFO | started process 2036 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/tmp7OhWql/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:11:55 INFO - PROCESS | 2036 | RSS: Main: 218959872 19:11:55 INFO - PROCESS | 2036 | 19:12:46 INFO - PROCESS | 2036 | 1474596766916 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:14:58 INFO - PROCESS | 2036 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49374/tests/dromaeo/cssquery-ext.html) 19:15:00 INFO - PROCESS | 2036 | RSS: Main: 369446912 19:15:00 INFO - PROCESS | 2036 | 19:18:03 INFO - PROCESS | 2036 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-ext.html (next: http://localhost:49374/tests/dromaeo/cssquery-jquery.html) 19:18:03 INFO - PROCESS | 2036 | RSS: Main: 351866880 19:18:03 INFO - PROCESS | 2036 | 19:21:05 INFO - PROCESS | 2036 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49374/tests/dromaeo/cssquery-mootools.html) 19:21:06 INFO - PROCESS | 2036 | RSS: Main: 328081408 19:21:06 INFO - PROCESS | 2036 | 19:24:08 INFO - PROCESS | 2036 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49374/tests/dromaeo/cssquery-prototype.html) 19:24:09 INFO - PROCESS | 2036 | RSS: Main: 313647104 19:24:09 INFO - PROCESS | 2036 | 19:27:12 INFO - PROCESS | 2036 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49374/tests/dromaeo/cssquery-yui.html) 19:27:13 INFO - PROCESS | 2036 | RSS: Main: 310784000 19:27:13 INFO - PROCESS | 2036 | 19:30:16 INFO - PROCESS | 2036 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-yui.html (next: http://localhost:49374/tests/dromaeo/cssquery-dojo.html) 19:30:17 INFO - PROCESS | 2036 | RSS: Main: 404373504 19:30:17 INFO - PROCESS | 2036 | 19:30:17 INFO - PROCESS | 2036 | __start_tp_report 19:30:17 INFO - PROCESS | 2036 | _x_x_mozilla_page_load 19:30:17 INFO - PROCESS | 2036 | _x_x_mozilla_page_load_details 19:30:17 INFO - PROCESS | 2036 | |i|pagename|runs| 19:30:17 INFO - PROCESS | 2036 | |0;dojo.html;3313.7514686398517;3337.265801523665;3358.5633867597207;3393.558837351144;3406.4719968404906;5729.512991395731;5791.305043394798;5807.8257652270395;5816.156657284697;5838.562107841913;5710.200571919924;5792.594518383715;5804.216430781854;5809.6804675742815;5811.6803575803315;5208.036513245052;5249.002689489004;5272.789088436458;5274.314339135907;5324.813631522898;5178.844634660966;5184.611154163434;5188.403333616626;5303.920441193385;5318.680879147244;5206.24509446132;5284.313039304885;5293.391260005091;5298.284731561248;5318.601104917147;5257.474252574731;5295.073362161645;5310.973445132789;5336.066188417011;5340.465953404668;5214.5306922376785;5242.344706911636;5280.709560974145;5284.365876094855;5285.387956673213;5622.32532096151;5667.404922483162;5679.432056794288;5690.345610254791;5707.029804933171;6303.212098487689;6304.842378940517;6306.936930630681;6321.557490975633;6330.240371155491;6268.216472940882;6303.6532990685955;6304.054391841215;6306.400891915261;6322.525810564226;4794.9280760788615;5712.400197979194;5776.277965254343;5788.479036886701;5849.473547380713;6257.124002639634;6280.2777680566405;6284.214473190851;6297.118403423525;6301.117843501914;6061.878762424727;6196.039613859859;6201.751929922752;6205.131281620576;6207.81376558704;6111.834843226386;6188.257409110935;6268.905966410507;6280;6285.9057114143325;6182.1345011698395;6234.251889773165;6254.15568898202;6296.181496405529;6315.5263355247625;6288.308286088527;6310.211223597051;6312.179416675803;6313.747450102036;6323.557350985387;4836.709797412096;4941.827036053793;4972.651914366032;4974;4993.201087825931;4409.382686423904;4423.889402764957;4463.776811159429;4474.217012022883;4476.776161191928;5818.709064546756;5862.325832529228;5864.149698293723;5888.116782482662;5889.116632505073;6259.1550140730415;6261.906071408933;6281.089242059876;6286.057091436322;6289.811305660837;5666.744996475086;5696.487316141567;5746.741396637161;5778.884422311614;5896.086106653475;5446.291982042309;5470.589705772083;5491.862703432446;5510.256115424367;5528.640638358494;6337.6197428154455;6348.206474190726;6349.2698339690605;6349.936500635027;6356.237251529846;6135;6151.630902145886;6293.339199383999;6293.716782744696;6310.716017779303;6214.937850621436;6225.8132256032395;6268.843278918063;6273.059041143865;6329.968350158219;6236;6265.530085243716;6274.372562743689;6275.937240627535;6289.685515724287;6162.22972128484;6281.685915704288;6291.779787707408;6292.779752708633;6316.936830631818;6050.092486127116;6109.358517355614;6139.416755408229;6139.57023008403;6189.319174890668;5341.278927344759;6136.048912418582;6210.037444196157;6224.284207316216;6225.035119556476;6022.7289771959495;6058.757649694139;6069.0592958091565;6075.453209211192;6078.3921607838865;6025.246844144482;6045.667488288186;6091.116788065794;6120.508083830972;6138.355472675305;6064.332923378513;6081.847953801191;6083.726232319645;6106.023036314168;6133.233345831771 19:30:17 INFO - PROCESS | 2036 | |1;ext.html;453.4377372058647;505.98735031624204;535.4645354645355;535.6277387215885;551.1567302027898;30730.846345768296;41154;42390.36414453786;42593.36109958345;42628.78685606568;36323.81838090806;43495.78252108735;43859.684209473766;43873.78063109688;43917;9665.855012174805;9848.409095454295;9855.162311203556;9865.06281903218;9866.408015519057;9717.31978761487;9820.705378838646;9827.312088153833;9829.557669904836;9846.803063938716;9829.852552211687;9852.310338276324;9870.703878883645;9874.506274686273;9894.802103957916;9810.558524866363;9819.950900245452;9837.360571562825;9841.015898410173;9877.308588398851;9682.515874206261;9738.513074346325;9743.805123897553;9744.07431294026;9744.561494732754;40627;41000;41003.589964100276;41029.79485102585;41088.79455602733;3270.640229574745;3358.22760765023;3424.9315013699834;3488.494168345576;3836.635519625631;29626.407471850656;29748.405031899456;30140.698593014007;31374.901878434375;32286.677133228837;3096.721295083431;3212.421764082464;3241.1572991022267;3264.7714659973813;3268.950965735516;525578.3721081408;528029.9999999962;530208;530230;532238;64177;64696.353036469976;64750.028749568795;64769.67615161894;64823;34881.825590871886;35055.64944350575;35372.29255414877;36493.635063649555;36573.26853462916;16970.745438818427;17152.74270885913;17174.570635733955;17179.31282748676;17203.56991075208;13046;13146.2112273262;13150.473981040652;13157.342132893316;13161.407736651874;19356.191674530593;19428.854734754586;19478.46661629637;19530.771032812238;19539.971977482273;7831.960840195877;7909.446338756347;7923;7934.801629959297;7956.9602151988865;822.5928165558087;933.355984370782;936.8266870628955;984.227381505529;1076.531708706715;28640.570391444144;29199;29627.703722962924;29948.700512995027;30802.69197308043;816.6978218059237;974.7368210583103;982.3427628265524;1046.7801761629992;1082.4046774274118;13952.720945581032;14281.78577321341;14835.813134949394;15424.383024679111;15711.4500992467;729829;734072;735547;737010;740749;57945.420545794004;58413.5396615088;58422.4157758417;58435.70782146062;58489;1230.3048777440897;1269.4033804112053;1362.6184668292894;1373.3819781098346;1391.9652008699863;25101.121460748785;29128.7087129126;31272.530912035883;31375;31780;40586.79706601448;49641.25538116859;50108;50187.74530636763;50240.748796255786;538081;540060;541812;542001;689624;40059.59940400559;41593.58406415897;42119.57880421157;42217.78891105648;42297.577024229366;46352.30471542997;47137.76431117822;47185.76407117942;47575;48096.27855582239;39244.607553925234;39888;41006.38676162305;41175.7941210304;41404.58595414007;39658;39700.60299396969;40524;40969.59030409658;41047.1790564193;35873.46189807103;38694.61305387023;38798.2240355197;38867.80566097151;39278.4649381557;33625.32749345048;35050.082971788695;35172.47241291332;35314.82342588271;35601;25778.484430311662;25894.223173304832;25970.61044084378;26298.73701262963;26483 19:30:17 INFO - PROCESS | 2036 | |2;jquery.html;357.24799297478825;379.196104258971;382.3881789137379;391.15900813251517;413.3840577539467;15071.246437678126;15205.467808626687;18079.638407231865;20299.797002029976;20500.69248961267;20293;20351.592968140627;20890.89554552229;20922.686159707577;20978.16087356504;5576.498115169634;5956.434138756822;5991.281046274453;6218.595791273576;6253.874922501547;6169.321374648785;6196.318404975472;6217.968910155466;6219.595726277777;6234.688265586702;5850.707464626773;6029.487493563052;6094.299155597118;6169.352218017111;6178.19683441152;6049.062395328731;6102.206713127265;6106.725197366107;6109.9083513747555;6118.938810611881;5109.923351149736;5315.627906046579;5366.70483123428;5384.40771515133;5388.568914486832;26352;26353;26429.47141057168;26524.469510609873;26794.330141746614;2373.6202207646693;2403.591389463795;2814.0010296344913;3078.4458797416455;3080.7073328034026;15721.606959826096;15806.683866322724;16051.277692503749;16186.35254589815;16348.019118852906;1815.3555487801905;1819.8089200634008;1843.741876137342;1846.769153855768;1848.8890666559914;74942.62528687321;102399;115722;115813;115934.84065159324;8347.791305217297;9895.208383329316;10013.148882345082;10546.05085542305;10603.94698026505;12325.137240393087;12375.876241237473;12425.19236249641;12441.813372799415;12473.126881118416;8069.193080691884;8172.223638754309;8271.586420679063;8277.58612069394;8350.62422191003;8549.658013679507;8563.828723425497;8611.224989750952;8731;8759.474431534129;3862.1310205204168;3867.2458870519977;3879.650831425185;3939.7242193046213;3946.743461674982;1858.8605854560963;1894.4127320530679;1906.9427917162507;1909.6180763847285;1912.4167129025782;781.8045488627843;861.7845538615346;868.3617541107282;924.1728652855791;977.5258999385293;19882.948120226054;21172;21214.89392553058;21252.681209781866;21493.46266343354;914.9679761208325;931.4923366765129;933.6732143749633;954.7565370830532;979.1823827104305;9695.563699633534;10579.682609521727;11153.776924461465;11286.887131128584;11297.26567773092;512889;559229;585408;636655;639940;140495.2975235138;143211;145367;146534;151794;903.6385445821724;904.5115637555647;922.4280945813639;926;955.1165172215811;17901.910490447466;18577.81422185815;19008.42974710761;19033.762805417602;19120.043997799778;40170.39744403895;49195;57687;58413.06919425629;58482.415175847695;84982.57508712416;85585;87182.56408717915;88464;90690.54654726684;7556.735514256975;7850;7876.527408355517;8203.671853125808;8207.548584827891;11181.32912025281;12333.568325108577;12374.62876113718;12655.050871184882;13043.34783260852;9391.154796068387;10621.734456638645;10776;11007.669769906915;11159.832602511131;10573.62992295266;10679.932006799258;10725.30285531438;10775.946120269662;10893.945530272298;10960;10974.561017559208;10977.506012229629;11063.889361106287;11352.829707554558;7926.564038977912;7929.246721561442;7940.28537431634;8107.918920810716;8381.287590554628;8118.675252989814;9866.703998880044;10275.383476991405;10946.014858662758;11100.777984440427 19:30:17 INFO - PROCESS | 2036 | |3;mootools.html;1332.8600496947827;1488.538553048555;1504.2478760619688;1678.6223099802546;1840.5674666453372;8025.678972841087;8576.742697719063;8580.91419085809;8582.141785821415;8587.699430519933;8733.868991965126;8897.955510222457;9016.323775716815;9141.77145571361;9156.908430915706;2378.3102900158933;2405.0860672944254;2410.6866107406013;2412.0472413396697;2415.251272105644;2398.5322862041908;2430.44099857033;2440.926772196828;2441.084593277521;2459.667944827452;2413.324269204617;2439.451123497208;2443.584590619599;2446.7675570820743;2447.1801946347996;2392.712874455059;2401.1595941420537;2413.2880800163816;2414.746451622572;2427.0291883246664;2056.352249041562;2381.6546600742795;2409.7831195192343;2414.637804329347;2422.1885668300965;9028.638854445815;9069.863952040725;9130.406523575946;9136.314776391797;9157.450552966844;5255.369355677343;5309.230161626581;5473.0969390050595;5482.0406428874785;5495.340559132929;3537.6462353764673;3632.164602141522;3649.434337677664;3671.284099600579;3676.9264614707554;1071.276888100529;1085.2728671789919;1099.2799716185912;1110.2616759854686;1113.8663360396804;11917.463714132884;12120.45457954394;12128.878711212952;12130.393480325949;12133.817992730115;4330.2282670158675;4821.4696383397795;4852.126617208936;4945.208766597327;5011.824586139541;10522.421266830244;10526.842097368546;10531.894681053245;10545.10366618846;10579.100776433936;4835.879103022382;5570.832875013756;5581.469760372758;5605.495505404533;5607.299087614048;4255.787210639455;4539.773011349485;4658.813647454132;5034.974825125851;5063.240513922941;3769;3959.7822119783114;4075.49056367954;4188.036751547162;4230.809613567397;1286;1319.3732976836118;1322.735452909422;1330.2284674888542;1335.2922950836073;670.7384120193128;868.370431437203;907.5326207003399;928.6656803550717;934.4019827310527;5690.374058853523;5715.312186578457;5808.344621782856;6000.639961602318;6212.285587157445;892.2282225874571;980.3235767320526;983.9852402213972;994.3238597753452;1019.7246743379246;3904.4924159859606;3992.441058251847;4005.272460381624;4112.300908845504;4140.8136633850945;10734.946325268324;11209.495572699248;11213.887861121448;11215.158863085302;11235.55057797679;11156.051735602565;11159.386233757059;11168.162387820947;11177.993980541627;11192.776144477064;8332.791680207922;8469.153084691605;8516.020657624453;8522.318214542822;8545;5825.854353641193;5850.0932355484965;5861.1501332307425;6095.287597019284;6195.876082478235;9961.701148965543;10276.845847312446;10311;10363.896361036293;10489.423081730272;9583.04169583064;9892.703218903445;10386.948065259625;10440.58237670515;10590.41752703578;6101.450869421773;7541.170471248049;7611.695532178651;7739.5743234122665;7868.095169055632;8458.788530286793;8657.91342086571;8664.696735614223;8681.652733890574;8802.559872006246;7832.530048197126;7844.333231675371;7975.92024079775;8044.718434854752;8077.636506357346;7727;7810.3751699865015;7827.178146294557;7844.21557844211;7905.723299684483;7025.332593403618;7208.603526805866;7225.205227424874;7225.6387180641805;7245.347918687344;5063.443021267584;5172.637915345889;5193.714345711022;5206.661566998133;5475.397706252229;5214.608904332114;5354.892902142014;5452;5476.069068258326;5492.395836458067 19:30:17 INFO - PROCESS | 2036 | |4;prototype.html;264.15997129129374;286.43715099828836;311.5155932524924;315.7505570599225;320.18672571667963;4748.12159750446;5189.351331083614;5250.501202385772;5292.3913749918775;5333.599980001496;3983.66138878195;4717.820544863784;5171.974140129303;5232.398274198468;5249.1601343785005;3736.4768932349493;3838.328292548793;3910.1006768443203;4005.299072662287;4074.490688663917;3471.340445315382;4019.648505624213;4032.3749818778138;4082.7754473503946;4083.8350278534226;3912.8630497932577;4002.5597184309704;4003.9389561766156;4021.296273152201;4025.6980726445636;3549.8346008934527;3613.5663720353728;3684.5446048810704;3808.533714519902;4027.697922655798;3505.6844883960566;3514;3527.841247143859;3529.0118766745354;3529.6999755020597;4303.096349766522;4344.56554344563;5133.460986596391;5174.981757114729;5194.986977539382;4451.642249114019;4596.241620132674;4599.632029437637;4614.492405835355;4619.214733495314;4417.160739459492;4969.776360063805;5214.504622060898;5455.936092461971;5469.781208751645;3316.2538428853554;3867.91132788294;3878.631530004645;3878.747881387729;3905.9609403906165;5403.83788486346;5638.887222255532;5711.514521265697;5726.627769194989;5743.712814359307;3245.983770081182;3431.4681224410256;3895.7272990890933;3920.588837864693;3942.2312649033165;3437.8998720409227;3977.482927219443;3980.820863061111;3983.46223259862;4004.5594984551676;4597.287420449836;4616.891945933019;4617.538246175355;4618.468876079294;4631.606313463326;4943.959464929115;5430.972845135749;5468.152436372368;5481.218603953731;5516.834494965157;1339.3169483563454;1357.2738584857054;1362.6457121148574;1362.9709569275333;1363.454618152747;809.9230573095547;828.9886338666817;835.9164083591592;861.1302584389687;886.2334081019872;4070.5725898780793;5048.722320272347;5195.19474481456;5197.870053248699;5304.946950530445;5638.887222255532;5654.5193658538665;5659.660420374791;5660.971695141498;5696.234167408117;5018.071656743514;5101.642884998015;5105.273150600008;5186.662866913639;5222.2427747976335;2598.2854714953537;2767.972320276812;2879.466069858553;2927.795054346218;2959.6300462442196;5230.3985041719925;5763.538916886723;5775.451332123442;5809.2738407699035;5841.561882858802;5362.329708786402;5716.4569365911;5738.942610573924;5757.553039958001;5810.750688601886;5177;5184.9740751296;5301.628885977944;5656.490915817514;5971.462568368781;5274.393444753902;5734.254546909042;5761.683107429131;5769.711514424346;5814.982378083903;5167.793288268577;5172.35349078906;5492.402476377979;5562.694051827189;5626.662400255997;5890.970545147246;5891.764329426775;5918.496927761188;5919.319278283053;5922.378150294329;3384.729221662212;3679.5584529856587;3806.3061937437574;3848.3650197718184;3849.01850028241;4655.858305179655;5199.76601052946;5364.919526207188;5691.731201598801;5793.188953546591;4551.38556294896;4973.975130124326;5542.944570554243;5550.58370622213;5581.888362232814;4695;5136.383633963948;5570.582206334622;5576.386597474356;5621.297337832771;4806.303086052572;5450.809221677222;5465.398806131402;5467.644603100785;5484.862878427912;5243.790248390174;5333.7066461345;5428.59285553593;5429.321334833146;5524.585656075891;5416.674999500043;5425.83722488326;5445.658366902112;5454.890902182014;5462.399136095106 19:30:17 INFO - PROCESS | 2036 | |5;yui.html;674.8785218660643;731.3016069653478;772.3396495995927;789.403999980015;821.0557858462769;14825.703485930275;16136.435224767136;16143.91928040361;16145.919270403632;16177.514674559767;14480.565583032527;14642.560723178294;14658.19379934106;14672.26638668065;14729.92635036826;668.9096971908791;695.6139342664819;696.8362434827811;834.2741814621257;860.6428332242112;862.7454900804246;879.7184900831736;880.2473884828476;880.744584070622;880.7930136417968;924.36219008884;926.666400095965;928.4243768863314;928.767808047988;929.6281487405024;710.3961632612289;732.1360794262768;732.3482100930177;735.8859376796605;920.8434566123741;546.915228139635;654.8264709851893;672.237010992527;677.3395938959525;678.1286047429079;14689.853101468956;14718.852811471856;14720.705585888223;14736.55790326292;14736.705265894729;13520.18878867271;13819.585412437644;13845.307734613229;13867.861321386757;13918.930405347908;12101.82871196794;12351.32067736274;12411;12602.936985315106;12903.870961290455;4527.86416407505;4601.3558101865765;4602.332661764059;4619.676622636417;4732.574068333866;116638;118069.40965295205;118330.40834795857;122059.3897030518;125987;10483.842742358871;10775.461226938622;10887.455627218607;10888.074513666426;11012.944935275273;21360.14559417637;21376.57246855054;21393.358199254046;21403.67894481584;21440.249591264543;7709.884351734729;7901.170377110436;7942.245486678872;8068.3948703847445;8114.756557303291;4332.393464914914;4475.753833539122;4556.7721613919175;4574.268117101248;4594.379758732595;3490.5811302643338;3646.507721457622;3647.0699971507624;3652;3659.268146370683;665.710415969055;669.1267895396554;681.2914568848441;683.0676127086491;686.1765880942788;484.9345338379344;530.5278302310946;599.604261187614;618.3476432363899;627.1752645271454;7658.61706914652;8551.401401901807;8895.88801399825;9046.909530904739;9139.040400757958;507.2062222621585;510.8518529626441;554.4815597416429;599.7271241585069;613.6440864298696;4193.643540299109;4369.47566292047;4383.868483945486;4409;4469.776511174428;97581;106458;134486;138268.30865845605;176898;121252;124983;125290;130213.34893325662;131097.68902311046;108333.45833270783;110344.89655103347;110523.44738276258;111189;112415;8459.323254139532;9752.122308992224;9818.116369526777;9853.014698530089;10091.394516329045;47267.763661181474;57275;58062.7096864513;59284.62861485665;64176.82850614695;95109;98282.5085874566;98693;100825.49587252017;101027.98972010186;13030.804537931748;13208.537701180798;13350.732985340044;13480.73038539204;13559.796603050765;14621.19583422922;14864.554063378117;14997.32512036939;15126.243687815346;15247.771283430979;10633.574657013633;12772.552960646333;14067.718645626825;14566.126032438087;14611;12793.680157995752;12942.482300708243;13181.80227296572;13981.161130331806;14588.85411145875;13501.257430841006;14088.647783805487;14588.562343129723;14612.97709160391;14737.484188053366;9736.707898763048;10213.591456341961;11337.716557086138;11348.20224774996;11411.942940285246;11481.82777258325;11515.424228788359;11593.420328983686;11731.706707332385;11851 19:30:17 INFO - PROCESS | 2036 | __end_tp_report 19:30:17 INFO - PROCESS | 2036 | __start_cc_report 19:30:17 INFO - PROCESS | 2036 | _x_x_mozilla_cycle_collect,1458 19:30:17 INFO - PROCESS | 2036 | __end_cc_report 19:30:17 INFO - PROCESS | 2036 | __startTimestamp1474597817008__endTimestamp 19:30:17 INFO - PROCESS | 2036 | 19:30:17 INFO - PROCESS | 2036 | ------- Summary: start ------- 19:30:17 INFO - PROCESS | 2036 | Number of tests: 6 19:30:17 INFO - PROCESS | 2036 | 19:30:17 INFO - PROCESS | 2036 | [#0] dojo.html Cycles:165 Average:5787.11 Median:6064.33 stddev:646.27 (10.7%) stddev-sans-first:618.43 19:30:17 INFO - PROCESS | 2036 | Values: 3313.8 3337.3 3358.6 3393.6 3406.5 5729.5 5791.3 5807.8 5816.2 5838.6 5710.2 5792.6 5804.2 5809.7 5811.7 5208.0 5249.0 5272.8 5274.3 5324.8 5178.8 5184.6 5188.4 5303.9 5318.7 5206.2 5284.3 5293.4 5298.3 5318.6 5257.5 5295.1 5311.0 5336.1 5340.5 5214.5 5242.3 5280.7 5284.4 5285.4 5622.3 5667.4 5679.4 5690.3 5707.0 6303.2 6304.8 6306.9 6321.6 6330.2 6268.2 6303.7 6304.1 6306.4 6322.5 4794.9 5712.4 5776.3 5788.5 5849.5 6257.1 6280.3 6284.2 6297.1 6301.1 6061.9 6196.0 6201.8 6205.1 6207.8 6111.8 6188.3 6268.9 6280.0 6285.9 6182.1 6234.3 6254.2 6296.2 6315.5 6288.3 6310.2 6312.2 6313.7 6323.6 4836.7 4941.8 4972.7 4974.0 4993.2 4409.4 4423.9 4463.8 4474.2 4476.8 5818.7 5862.3 5864.1 5888.1 5889.1 6259.2 6261.9 6281.1 6286.1 6289.8 5666.7 5696.5 5746.7 5778.9 5896.1 5446.3 5470.6 5491.9 5510.3 5528.6 6337.6 6348.2 6349.3 6349.9 6356.2 6135.0 6151.6 6293.3 6293.7 6310.7 6214.9 6225.8 6268.8 6273.1 6330.0 6236.0 6265.5 6274.4 6275.9 6289.7 6162.2 6281.7 6291.8 6292.8 6316.9 6050.1 6109.4 6139.4 6139.6 6189.3 5341.3 6136.0 6210.0 6224.3 6225.0 6022.7 6058.8 6069.1 6075.5 6078.4 6025.2 6045.7 6091.1 6120.5 6138.4 6064.3 6081.8 6083.7 6106.0 6133.2 19:30:17 INFO - PROCESS | 2036 | 19:30:17 INFO - PROCESS | 2036 | [#1] ext.html Cycles:180 Average:73782.94 Median:41164.90 stddev:165880.38 (403.0%) stddev-sans-first:166254.35 19:30:17 INFO - PROCESS | 2036 | Values: 453.4 506.0 535.5 535.6 551.2 30730.8 41154.0 42390.4 42593.4 42628.8 36323.8 43495.8 43859.7 43873.8 43917.0 9665.9 9848.4 9855.2 9865.1 9866.4 9717.3 9820.7 9827.3 9829.6 9846.8 9829.9 9852.3 9870.7 9874.5 9894.8 9810.6 9820.0 9837.4 9841.0 9877.3 9682.5 9738.5 9743.8 9744.1 9744.6 40627.0 41000.0 41003.6 41029.8 41088.8 3270.6 3358.2 3424.9 3488.5 3836.6 29626.4 29748.4 30140.7 31374.9 32286.7 3096.7 3212.4 3241.2 3264.8 3269.0 525578.4 528030.0 530208.0 530230.0 532238.0 64177.0 64696.4 64750.0 64769.7 64823.0 34881.8 35055.6 35372.3 36493.6 36573.3 16970.7 17152.7 17174.6 17179.3 17203.6 13046.0 13146.2 13150.5 13157.3 13161.4 19356.2 19428.9 19478.5 19530.8 19540.0 7832.0 7909.4 7923.0 7934.8 7957.0 822.6 933.4 936.8 984.2 1076.5 28640.6 29199.0 29627.7 29948.7 30802.7 816.7 974.7 982.3 1046.8 1082.4 13952.7 14281.8 14835.8 15424.4 15711.5 729829.0 734072.0 735547.0 737010.0 740749.0 57945.4 58413.5 58422.4 58435.7 58489.0 1230.3 1269.4 1362.6 1373.4 1392.0 25101.1 29128.7 31272.5 31375.0 31780.0 40586.8 49641.3 50108.0 50187.7 50240.7 538081.0 540060.0 541812.0 542001.0 689624.0 40059.6 41593.6 42119.6 42217.8 42297.6 46352.3 47137.8 47185.8 47575.0 48096.3 39244.6 39888.0 41006.4 41175.8 41404.6 39658.0 39700.6 40524.0 40969.6 41047.2 35873.5 38694.6 38798.2 38867.8 39278.5 33625.3 35050.1 35172.5 35314.8 35601.0 25778.5 25894.2 25970.6 26298.7 26483.0 19:30:17 INFO - PROCESS | 2036 | 19:30:17 INFO - PROCESS | 2036 | [#2] jquery.html Cycles:180 Average:35058.92 Median:2122.26 stddev:98777.98 (4654.4%) stddev-sans-first:99020.71 19:30:17 INFO - PROCESS | 2036 | Values: 357.2 379.2 382.4 391.2 413.4 15071.2 15205.5 18079.6 20299.8 20500.7 20293.0 20351.6 20890.9 20922.7 20978.2 5576.5 5956.4 5991.3 6218.6 6253.9 6169.3 6196.3 6218.0 6219.6 6234.7 5850.7 6029.5 6094.3 6169.4 6178.2 6049.1 6102.2 6106.7 6109.9 6118.9 5109.9 5315.6 5366.7 5384.4 5388.6 26352.0 26353.0 26429.5 26524.5 26794.3 2373.6 2403.6 2814.0 3078.4 3080.7 15721.6 15806.7 16051.3 16186.4 16348.0 1815.4 1819.8 1843.7 1846.8 1848.9 74942.6 102399.0 115722.0 115813.0 115934.8 8347.8 9895.2 10013.1 10546.1 10603.9 12325.1 12375.9 12425.2 12441.8 12473.1 8069.2 8172.2 8271.6 8277.6 8350.6 8549.7 8563.8 8611.2 8731.0 8759.5 3862.1 3867.2 3879.7 3939.7 3946.7 1858.9 1894.4 1906.9 1909.6 1912.4 781.8 861.8 868.4 924.2 977.5 19882.9 21172.0 21214.9 21252.7 21493.5 915.0 931.5 933.7 954.8 979.2 9695.6 10579.7 11153.8 11286.9 11297.3 512889.0 559229.0 585408.0 636655.0 639940.0 140495.3 143211.0 145367.0 146534.0 151794.0 903.6 904.5 922.4 926.0 955.1 17901.9 18577.8 19008.4 19033.8 19120.0 40170.4 49195.0 57687.0 58413.1 58482.4 84982.6 85585.0 87182.6 88464.0 90690.5 7556.7 7850.0 7876.5 8203.7 8207.5 11181.3 12333.6 12374.6 12655.1 13043.3 9391.2 10621.7 10776.0 11007.7 11159.8 10573.6 10679.9 10725.3 10775.9 10893.9 10960.0 10974.6 10977.5 11063.9 11352.8 7926.6 7929.2 7940.3 8107.9 8381.3 8118.7 9866.7 10275.4 10946.0 11100.8 19:30:17 INFO - PROCESS | 2036 | 19:30:17 INFO - PROCESS | 2036 | [#3] mootools.html Cycles:180 Average:5882.77 Median:4978.52 stddev:3323.27 (66.8%) stddev-sans-first:3314.99 19:30:17 INFO - PROCESS | 2036 | Values: 1332.9 1488.5 1504.2 1678.6 1840.6 8025.7 8576.7 8580.9 8582.1 8587.7 8733.9 8898.0 9016.3 9141.8 9156.9 2378.3 2405.1 2410.7 2412.0 2415.3 2398.5 2430.4 2440.9 2441.1 2459.7 2413.3 2439.5 2443.6 2446.8 2447.2 2392.7 2401.2 2413.3 2414.7 2427.0 2056.4 2381.7 2409.8 2414.6 2422.2 9028.6 9069.9 9130.4 9136.3 9157.5 5255.4 5309.2 5473.1 5482.0 5495.3 3537.6 3632.2 3649.4 3671.3 3676.9 1071.3 1085.3 1099.3 1110.3 1113.9 11917.5 12120.5 12128.9 12130.4 12133.8 4330.2 4821.5 4852.1 4945.2 5011.8 10522.4 10526.8 10531.9 10545.1 10579.1 4835.9 5570.8 5581.5 5605.5 5607.3 4255.8 4539.8 4658.8 5035.0 5063.2 3769.0 3959.8 4075.5 4188.0 4230.8 1286.0 1319.4 1322.7 1330.2 1335.3 670.7 868.4 907.5 928.7 934.4 5690.4 5715.3 5808.3 6000.6 6212.3 892.2 980.3 984.0 994.3 1019.7 3904.5 3992.4 4005.3 4112.3 4140.8 10734.9 11209.5 11213.9 11215.2 11235.6 11156.1 11159.4 11168.2 11178.0 11192.8 8332.8 8469.2 8516.0 8522.3 8545.0 5825.9 5850.1 5861.2 6095.3 6195.9 9961.7 10276.8 10311.0 10363.9 10489.4 9583.0 9892.7 10386.9 10440.6 10590.4 6101.5 7541.2 7611.7 7739.6 7868.1 8458.8 8657.9 8664.7 8681.7 8802.6 7832.5 7844.3 7975.9 8044.7 8077.6 7727.0 7810.4 7827.2 7844.2 7905.7 7025.3 7208.6 7225.2 7225.6 7245.3 5063.4 5172.6 5193.7 5206.7 5475.4 5214.6 5354.9 5452.0 5476.1 5492.4 19:30:17 INFO - PROCESS | 2036 | 19:30:17 INFO - PROCESS | 2036 | [#4] prototype.html Cycles:180 Average:4479.93 Median:5169.88 stddev:1374.32 (26.6%) stddev-sans-first:1341.25 19:30:17 INFO - PROCESS | 2036 | Values: 264.2 286.4 311.5 315.8 320.2 4748.1 5189.4 5250.5 5292.4 5333.6 3983.7 4717.8 5172.0 5232.4 5249.2 3736.5 3838.3 3910.1 4005.3 4074.5 3471.3 4019.6 4032.4 4082.8 4083.8 3912.9 4002.6 4003.9 4021.3 4025.7 3549.8 3613.6 3684.5 3808.5 4027.7 3505.7 3514.0 3527.8 3529.0 3529.7 4303.1 4344.6 5133.5 5175.0 5195.0 4451.6 4596.2 4599.6 4614.5 4619.2 4417.2 4969.8 5214.5 5455.9 5469.8 3316.3 3867.9 3878.6 3878.7 3906.0 5403.8 5638.9 5711.5 5726.6 5743.7 3246.0 3431.5 3895.7 3920.6 3942.2 3437.9 3977.5 3980.8 3983.5 4004.6 4597.3 4616.9 4617.5 4618.5 4631.6 4944.0 5431.0 5468.2 5481.2 5516.8 1339.3 1357.3 1362.6 1363.0 1363.5 809.9 829.0 835.9 861.1 886.2 4070.6 5048.7 5195.2 5197.9 5304.9 5638.9 5654.5 5659.7 5661.0 5696.2 5018.1 5101.6 5105.3 5186.7 5222.2 2598.3 2768.0 2879.5 2927.8 2959.6 5230.4 5763.5 5775.5 5809.3 5841.6 5362.3 5716.5 5738.9 5757.6 5810.8 5177.0 5185.0 5301.6 5656.5 5971.5 5274.4 5734.3 5761.7 5769.7 5815.0 5167.8 5172.4 5492.4 5562.7 5626.7 5891.0 5891.8 5918.5 5919.3 5922.4 3384.7 3679.6 3806.3 3848.4 3849.0 4655.9 5199.8 5364.9 5691.7 5793.2 4551.4 4974.0 5542.9 5550.6 5581.9 4695.0 5136.4 5570.6 5576.4 5621.3 4806.3 5450.8 5465.4 5467.6 5484.9 5243.8 5333.7 5428.6 5429.3 5524.6 5416.7 5425.8 5445.7 5454.9 5462.4 19:30:17 INFO - PROCESS | 2036 | 19:30:17 INFO - PROCESS | 2036 | [#5] yui.html Cycles:180 Average:24708.78 Median:12465.42 stddev:39130.39 (313.9%) stddev-sans-first:39198.55 19:30:17 INFO - PROCESS | 2036 | Values: 674.9 731.3 772.3 789.4 821.1 14825.7 16136.4 16143.9 16145.9 16177.5 14480.6 14642.6 14658.2 14672.3 14729.9 668.9 695.6 696.8 834.3 860.6 862.7 879.7 880.2 880.7 880.8 924.4 926.7 928.4 928.8 929.6 710.4 732.1 732.3 735.9 920.8 546.9 654.8 672.2 677.3 678.1 14689.9 14718.9 14720.7 14736.6 14736.7 13520.2 13819.6 13845.3 13867.9 13918.9 12101.8 12351.3 12411.0 12602.9 12903.9 4527.9 4601.4 4602.3 4619.7 4732.6 116638.0 118069.4 118330.4 122059.4 125987.0 10483.8 10775.5 10887.5 10888.1 11012.9 21360.1 21376.6 21393.4 21403.7 21440.2 7709.9 7901.2 7942.2 8068.4 8114.8 4332.4 4475.8 4556.8 4574.3 4594.4 3490.6 3646.5 3647.1 3652.0 3659.3 665.7 669.1 681.3 683.1 686.2 484.9 530.5 599.6 618.3 627.2 7658.6 8551.4 8895.9 9046.9 9139.0 507.2 510.9 554.5 599.7 613.6 4193.6 4369.5 4383.9 4409.0 4469.8 97581.0 106458.0 134486.0 138268.3 176898.0 121252.0 124983.0 125290.0 130213.3 131097.7 108333.5 110344.9 110523.4 111189.0 112415.0 8459.3 9752.1 9818.1 9853.0 10091.4 47267.8 57275.0 58062.7 59284.6 64176.8 95109.0 98282.5 98693.0 100825.5 101028.0 13030.8 13208.5 13350.7 13480.7 13559.8 14621.2 14864.6 14997.3 15126.2 15247.8 10633.6 12772.6 14067.7 14566.1 14611.0 12793.7 12942.5 13181.8 13981.2 14588.9 13501.3 14088.6 14588.6 14613.0 14737.5 9736.7 10213.6 11337.7 11348.2 11411.9 11481.8 11515.4 11593.4 11731.7 11851.0 19:30:17 INFO - PROCESS | 2036 | -------- Summary: end -------- 19:30:17 INFO - PROCESS | 2036 | 19:30:17 INFO - TEST-INFO | 2036: exit 0 19:30:17 INFO - TEST-OK | dromaeo_css | took 1117428ms 19:30:17 INFO - TEST-START | kraken 19:30:17 INFO - operating with platform_type : mac_ 19:30:17 INFO - Initialising browser for kraken test... 19:30:17 INFO - TEST-INFO | started process 2041 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/tmpB05jaf/profile http://localhost:49374/getInfo.html) 19:30:20 INFO - PROCESS | 2041 | __metrics Screen width/height:1600/1200 19:30:20 INFO - PROCESS | 2041 | colorDepth:24 19:30:20 INFO - PROCESS | 2041 | Browser inner width/height: 1024/689 19:30:20 INFO - PROCESS | 2041 | __metrics 19:30:20 INFO - PROCESS | 2041 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:30:20 INFO - PROCESS | 2041 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:30:20 INFO - TEST-INFO | 2041: exit 0 19:30:20 INFO - Browser initialized. 19:30:20 INFO - Running cycle 1/1 for kraken test... 19:30:20 INFO - TEST-INFO | started process 2042 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/tmpB05jaf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:30:32 INFO - PROCESS | 2042 | RSS: Main: 219189248 19:30:32 INFO - PROCESS | 2042 | 19:30:36 INFO - PROCESS | 2042 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-beat-detection) 19:30:36 INFO - PROCESS | 2042 | RSS: Main: 270606336 19:30:36 INFO - PROCESS | 2042 | 19:30:39 INFO - PROCESS | 2042 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-dft) 19:30:40 INFO - PROCESS | 2042 | RSS: Main: 282161152 19:30:40 INFO - PROCESS | 2042 | 19:30:43 INFO - PROCESS | 2042 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-fft) 19:30:43 INFO - PROCESS | 2042 | RSS: Main: 377470976 19:30:43 INFO - PROCESS | 2042 | 19:30:45 INFO - PROCESS | 2042 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-oscillator) 19:30:46 INFO - PROCESS | 2042 | RSS: Main: 279379968 19:30:46 INFO - PROCESS | 2042 | 19:30:48 INFO - PROCESS | 2042 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49374/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:30:49 INFO - PROCESS | 2042 | RSS: Main: 281608192 19:30:49 INFO - PROCESS | 2042 | 19:30:51 INFO - PROCESS | 2042 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49374/tests/kraken/driver.html?testName=imaging-darkroom) 19:30:52 INFO - PROCESS | 2042 | RSS: Main: 318189568 19:30:52 INFO - PROCESS | 2042 | 19:30:55 INFO - PROCESS | 2042 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49374/tests/kraken/driver.html?testName=imaging-desaturate) 19:30:55 INFO - PROCESS | 2042 | RSS: Main: 318717952 19:30:55 INFO - PROCESS | 2042 | 19:30:58 INFO - PROCESS | 2042 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49374/tests/kraken/driver.html?testName=json-parse-financial) 19:30:59 INFO - PROCESS | 2042 | RSS: Main: 317820928 19:30:59 INFO - PROCESS | 2042 | 19:31:00 INFO - PROCESS | 2042 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49374/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:31:01 INFO - PROCESS | 2042 | RSS: Main: 289505280 19:31:01 INFO - PROCESS | 2042 | 19:31:03 INFO - PROCESS | 2042 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:31:04 INFO - PROCESS | 2042 | RSS: Main: 295321600 19:31:04 INFO - PROCESS | 2042 | 19:31:06 INFO - PROCESS | 2042 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:31:06 INFO - PROCESS | 2042 | RSS: Main: 296927232 19:31:06 INFO - PROCESS | 2042 | 19:31:09 INFO - PROCESS | 2042 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:31:10 INFO - PROCESS | 2042 | RSS: Main: 311234560 19:31:10 INFO - PROCESS | 2042 | 19:31:13 INFO - PROCESS | 2042 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:31:13 INFO - PROCESS | 2042 | RSS: Main: 307453952 19:31:13 INFO - PROCESS | 2042 | 19:31:15 INFO - PROCESS | 2042 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49374/tests/kraken/driver.html?testName=ai-astar) 19:31:15 INFO - PROCESS | 2042 | RSS: Main: 350822400 19:31:15 INFO - PROCESS | 2042 | 19:31:15 INFO - PROCESS | 2042 | __start_tp_report 19:31:15 INFO - PROCESS | 2042 | _x_x_mozilla_page_load 19:31:15 INFO - PROCESS | 2042 | _x_x_mozilla_page_load_details 19:31:15 INFO - PROCESS | 2042 | |i|pagename|runs| 19:31:15 INFO - PROCESS | 2042 | |0;ai-astar;113;113;114;109;106;113;112;159;163;114 19:31:15 INFO - PROCESS | 2042 | |1;audio-beat-detection;147;109;109;144;111;108;110;110;140;109 19:31:15 INFO - PROCESS | 2042 | |2;audio-dft;182;182;184;184;182;182;184;184;219;186 19:31:15 INFO - PROCESS | 2042 | |3;audio-fft;82;57;75;104;51;50;61;63;107;80 19:31:15 INFO - PROCESS | 2042 | |4;audio-oscillator;88;71;94;70;69;69;91;68;68;90 19:31:15 INFO - PROCESS | 2042 | |5;imaging-gaussian-blur;87;83;90;122;86;83;86;83;85;83 19:31:15 INFO - PROCESS | 2042 | |6;imaging-darkroom;91;91;93;93;93;92;92;92;93;92 19:31:15 INFO - PROCESS | 2042 | |7;imaging-desaturate;86;84;83;83;84;86;85;87;98;135 19:31:15 INFO - PROCESS | 2042 | |8;json-parse-financial;56;51;52;53;54;57;57;56;56;56 19:31:15 INFO - PROCESS | 2042 | |9;json-stringify-tinderbox;69;70;64;76;72;68;69;70;70;69 19:31:15 INFO - PROCESS | 2042 | |10;stanford-crypto-aes;81;79;81;80;84;85;82;86;85;99 19:31:15 INFO - PROCESS | 2042 | |11;stanford-crypto-ccm;136;132;136;135;134;133;141;133;179;142 19:31:15 INFO - PROCESS | 2042 | |12;stanford-crypto-pbkdf2;163;161;160;160;162;161;164;160;166;159 19:31:15 INFO - PROCESS | 2042 | |13;stanford-crypto-sha256-iterative;66;66;67;66;68;80;82;82;83;71 19:31:15 INFO - PROCESS | 2042 | __end_tp_report 19:31:15 INFO - PROCESS | 2042 | __start_cc_report 19:31:15 INFO - PROCESS | 2042 | _x_x_mozilla_cycle_collect,1978 19:31:15 INFO - PROCESS | 2042 | __end_cc_report 19:31:15 INFO - PROCESS | 2042 | __startTimestamp1474597875791__endTimestamp 19:31:15 INFO - PROCESS | 2042 | 19:31:15 INFO - PROCESS | 2042 | ------- Summary: start ------- 19:31:15 INFO - PROCESS | 2042 | Number of tests: 14 19:31:15 INFO - PROCESS | 2042 | 19:31:15 INFO - PROCESS | 2042 | [#0] ai-astar Cycles:10 Average:121.60 Median:113.50 stddev:20.93 (18.4%) stddev-sans-first:21.97 19:31:15 INFO - PROCESS | 2042 | Values: 113.0 113.0 114.0 109.0 106.0 113.0 112.0 159.0 163.0 114.0 19:31:15 INFO - PROCESS | 2042 | 19:31:15 INFO - PROCESS | 2042 | [#1] audio-beat-detection Cycles:10 Average:119.70 Median:110.50 stddev:16.64 (15.1%) stddev-sans-first:14.42 19:31:15 INFO - PROCESS | 2042 | Values: 147.0 109.0 109.0 144.0 111.0 108.0 110.0 110.0 140.0 109.0 19:31:15 INFO - PROCESS | 2042 | 19:31:15 INFO - PROCESS | 2042 | [#2] audio-dft Cycles:10 Average:186.90 Median:184.00 stddev:11.36 (6.2%) stddev-sans-first:11.91 19:31:15 INFO - PROCESS | 2042 | Values: 182.0 182.0 184.0 184.0 182.0 182.0 184.0 184.0 219.0 186.0 19:31:15 INFO - PROCESS | 2042 | 19:31:15 INFO - PROCESS | 2042 | [#3] audio-fft Cycles:10 Average:73.00 Median:62.00 stddev:20.45 (33.0%) stddev-sans-first:21.43 19:31:15 INFO - PROCESS | 2042 | Values: 82.0 57.0 75.0 104.0 51.0 50.0 61.0 63.0 107.0 80.0 19:31:15 INFO - PROCESS | 2042 | 19:31:15 INFO - PROCESS | 2042 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:79.50 stddev:11.27 (14.2%) stddev-sans-first:11.34 19:31:15 INFO - PROCESS | 2042 | Values: 88.0 71.0 94.0 70.0 69.0 69.0 91.0 68.0 68.0 90.0 19:31:15 INFO - PROCESS | 2042 | 19:31:15 INFO - PROCESS | 2042 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:85.50 stddev:11.89 (13.9%) stddev-sans-first:12.59 19:31:15 INFO - PROCESS | 2042 | Values: 87.0 83.0 90.0 122.0 86.0 83.0 86.0 83.0 85.0 83.0 19:31:15 INFO - PROCESS | 2042 | 19:31:15 INFO - PROCESS | 2042 | [#6] imaging-darkroom Cycles:10 Average:92.20 Median:92.50 stddev:0.79 (0.9%) stddev-sans-first:0.71 19:31:15 INFO - PROCESS | 2042 | Values: 91.0 91.0 93.0 93.0 93.0 92.0 92.0 92.0 93.0 92.0 19:31:15 INFO - PROCESS | 2042 | 19:31:15 INFO - PROCESS | 2042 | [#7] imaging-desaturate Cycles:10 Average:91.10 Median:85.50 stddev:16.03 (18.7%) stddev-sans-first:16.90 19:31:15 INFO - PROCESS | 2042 | Values: 86.0 84.0 83.0 83.0 84.0 86.0 85.0 87.0 98.0 135.0 19:31:15 INFO - PROCESS | 2042 | 19:31:15 INFO - PROCESS | 2042 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:56.00 stddev:2.15 (3.8%) stddev-sans-first:2.24 19:31:15 INFO - PROCESS | 2042 | Values: 56.0 51.0 52.0 53.0 54.0 57.0 57.0 56.0 56.0 56.0 19:31:15 INFO - PROCESS | 2042 | 19:31:15 INFO - PROCESS | 2042 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:3.02 (4.3%) stddev-sans-first:3.19 19:31:15 INFO - PROCESS | 2042 | Values: 69.0 70.0 64.0 76.0 72.0 68.0 69.0 70.0 70.0 69.0 19:31:15 INFO - PROCESS | 2042 | 19:31:15 INFO - PROCESS | 2042 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.50 stddev:5.71 (6.8%) stddev-sans-first:5.94 19:31:15 INFO - PROCESS | 2042 | Values: 81.0 79.0 81.0 80.0 84.0 85.0 82.0 86.0 85.0 99.0 19:31:15 INFO - PROCESS | 2042 | 19:31:15 INFO - PROCESS | 2042 | [#11] stanford-crypto-ccm Cycles:10 Average:140.10 Median:136.00 stddev:14.07 (10.3%) stddev-sans-first:14.84 19:31:15 INFO - PROCESS | 2042 | Values: 136.0 132.0 136.0 135.0 134.0 133.0 141.0 133.0 179.0 142.0 19:31:15 INFO - PROCESS | 2042 | 19:31:15 INFO - PROCESS | 2042 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:161.50 stddev:2.17 (1.3%) stddev-sans-first:2.24 19:31:15 INFO - PROCESS | 2042 | Values: 163.0 161.0 160.0 160.0 162.0 161.0 164.0 160.0 166.0 159.0 19:31:15 INFO - PROCESS | 2042 | 19:31:15 INFO - PROCESS | 2042 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:75.50 stddev:7.62 (10.1%) stddev-sans-first:7.64 19:31:15 INFO - PROCESS | 2042 | Values: 66.0 66.0 67.0 66.0 68.0 80.0 82.0 82.0 83.0 71.0 19:31:15 INFO - PROCESS | 2042 | -------- Summary: end -------- 19:31:15 INFO - PROCESS | 2042 | 19:31:16 INFO - TEST-INFO | 2042: exit 0 19:31:16 INFO - TEST-OK | kraken | took 59023ms 19:31:16 INFO - SUITE-END | took 1176s 19:31:16 INFO - Completed test suite (00:19:36) 19:31:16 INFO - javascript benchmark 19:31:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3313.7514686398517, 3337.265801523665, 3358.5633867597207, 3393.558837351144, 3406.4719968404906, 5729.512991395731, 5791.305043394798, 5807.8257652270395, 5816.156657284697, 5838.562107841913, 5710.200571919924, 5792.594518383715, 5804.216430781854, 5809.6804675742815, 5811.6803575803315, 5208.036513245052, 5249.002689489004, 5272.789088436458, 5274.314339135907, 5324.813631522898, 5178.844634660966, 5184.611154163434, 5188.403333616626, 5303.920441193385, 5318.680879147244, 5206.24509446132, 5284.313039304885, 5293.391260005091, 5298.284731561248, 5318.601104917147, 5257.474252574731, 5295.073362161645, 5310.973445132789, 5336.066188417011, 5340.465953404668, 5214.5306922376785, 5242.344706911636, 5280.709560974145, 5284.365876094855, 5285.387956673213, 5622.32532096151, 5667.404922483162, 5679.432056794288, 5690.345610254791, 5707.029804933171, 6303.212098487689, 6304.842378940517, 6306.936930630681, 6321.557490975633, 6330.240371155491, 6268.216472940882, 6303.6532990685955, 6304.054391841215, 6306.400891915261, 6322.525810564226, 4794.9280760788615, 5712.400197979194, 5776.277965254343, 5788.479036886701, 5849.473547380713, 6257.124002639634, 6280.2777680566405, 6284.214473190851, 6297.118403423525, 6301.117843501914, 6061.878762424727, 6196.039613859859, 6201.751929922752, 6205.131281620576, 6207.81376558704, 6111.834843226386, 6188.257409110935, 6268.905966410507, 6280.0, 6285.9057114143325, 6182.1345011698395, 6234.251889773165, 6254.15568898202, 6296.181496405529, 6315.5263355247625, 6288.308286088527, 6310.211223597051, 6312.179416675803, 6313.747450102036, 6323.557350985387, 4836.709797412096, 4941.827036053793, 4972.651914366032, 4974.0, 4993.201087825931, 4409.382686423904, 4423.889402764957, 4463.776811159429, 4474.217012022883, 4476.776161191928, 5818.709064546756, 5862.325832529228, 5864.149698293723, 5888.116782482662, 5889.116632505073, 6259.1550140730415, 6261.906071408933, 6281.089242059876, 6286.057091436322, 6289.811305660837, 5666.744996475086, 5696.487316141567, 5746.741396637161, 5778.884422311614, 5896.086106653475, 5446.291982042309, 5470.589705772083, 5491.862703432446, 5510.256115424367, 5528.640638358494, 6337.6197428154455, 6348.206474190726, 6349.2698339690605, 6349.936500635027, 6356.237251529846, 6135.0, 6151.630902145886, 6293.339199383999, 6293.716782744696, 6310.716017779303, 6214.937850621436, 6225.8132256032395, 6268.843278918063, 6273.059041143865, 6329.968350158219, 6236.0, 6265.530085243716, 6274.372562743689, 6275.937240627535, 6289.685515724287, 6162.22972128484, 6281.685915704288, 6291.779787707408, 6292.779752708633, 6316.936830631818, 6050.092486127116, 6109.358517355614, 6139.416755408229, 6139.57023008403, 6189.319174890668, 5341.278927344759, 6136.048912418582, 6210.037444196157, 6224.284207316216, 6225.035119556476, 6022.7289771959495, 6058.757649694139, 6069.0592958091565, 6075.453209211192, 6078.3921607838865, 6025.246844144482, 6045.667488288186, 6091.116788065794, 6120.508083830972, 6138.355472675305, 6064.332923378513, 6081.847953801191, 6083.726232319645, 6106.023036314168, 6133.233345831771], "value": 5745.064139283187, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.4377372058647, 505.98735031624204, 535.4645354645355, 535.6277387215885, 551.1567302027898, 30730.846345768296, 41154.0, 42390.36414453786, 42593.36109958345, 42628.78685606568, 36323.81838090806, 43495.78252108735, 43859.684209473766, 43873.78063109688, 43917.0, 9665.855012174805, 9848.409095454295, 9855.162311203556, 9865.06281903218, 9866.408015519057, 9717.31978761487, 9820.705378838646, 9827.312088153833, 9829.557669904836, 9846.803063938716, 9829.852552211687, 9852.310338276324, 9870.703878883645, 9874.506274686273, 9894.802103957916, 9810.558524866363, 9819.950900245452, 9837.360571562825, 9841.015898410173, 9877.308588398851, 9682.515874206261, 9738.513074346325, 9743.805123897553, 9744.07431294026, 9744.561494732754, 40627.0, 41000.0, 41003.589964100276, 41029.79485102585, 41088.79455602733, 3270.640229574745, 3358.22760765023, 3424.9315013699834, 3488.494168345576, 3836.635519625631, 29626.407471850656, 29748.405031899456, 30140.698593014007, 31374.901878434375, 32286.677133228837, 3096.721295083431, 3212.421764082464, 3241.1572991022267, 3264.7714659973813, 3268.950965735516, 525578.3721081408, 528029.9999999962, 530208.0, 530230.0, 532238.0, 64177.0, 64696.353036469976, 64750.028749568795, 64769.67615161894, 64823.0, 34881.825590871886, 35055.64944350575, 35372.29255414877, 36493.635063649555, 36573.26853462916, 16970.745438818427, 17152.74270885913, 17174.570635733955, 17179.31282748676, 17203.56991075208, 13046.0, 13146.2112273262, 13150.473981040652, 13157.342132893316, 13161.407736651874, 19356.191674530593, 19428.854734754586, 19478.46661629637, 19530.771032812238, 19539.971977482273, 7831.960840195877, 7909.446338756347, 7923.0, 7934.801629959297, 7956.9602151988865, 822.5928165558087, 933.355984370782, 936.8266870628955, 984.227381505529, 1076.531708706715, 28640.570391444144, 29199.0, 29627.703722962924, 29948.700512995027, 30802.69197308043, 816.6978218059237, 974.7368210583103, 982.3427628265524, 1046.7801761629992, 1082.4046774274118, 13952.720945581032, 14281.78577321341, 14835.813134949394, 15424.383024679111, 15711.4500992467, 729829.0, 734072.0, 735547.0, 737010.0, 740749.0, 57945.420545794004, 58413.5396615088, 58422.4157758417, 58435.70782146062, 58489.0, 1230.3048777440897, 1269.4033804112053, 1362.6184668292894, 1373.3819781098346, 1391.9652008699863, 25101.121460748785, 29128.7087129126, 31272.530912035883, 31375.0, 31780.0, 40586.79706601448, 49641.25538116859, 50108.0, 50187.74530636763, 50240.748796255786, 538081.0, 540060.0, 541812.0, 542001.0, 689624.0, 40059.59940400559, 41593.58406415897, 42119.57880421157, 42217.78891105648, 42297.577024229366, 46352.30471542997, 47137.76431117822, 47185.76407117942, 47575.0, 48096.27855582239, 39244.607553925234, 39888.0, 41006.38676162305, 41175.7941210304, 41404.58595414007, 39658.0, 39700.60299396969, 40524.0, 40969.59030409658, 41047.1790564193, 35873.46189807103, 38694.61305387023, 38798.2240355197, 38867.80566097151, 39278.4649381557, 33625.32749345048, 35050.082971788695, 35172.47241291332, 35314.82342588271, 35601.0, 25778.484430311662, 25894.223173304832, 25970.61044084378, 26298.73701262963, 26483.0], "value": 20216.859268397857, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.24799297478825, 379.196104258971, 382.3881789137379, 391.15900813251517, 413.3840577539467, 15071.246437678126, 15205.467808626687, 18079.638407231865, 20299.797002029976, 20500.69248961267, 20293.0, 20351.592968140627, 20890.89554552229, 20922.686159707577, 20978.16087356504, 5576.498115169634, 5956.434138756822, 5991.281046274453, 6218.595791273576, 6253.874922501547, 6169.321374648785, 6196.318404975472, 6217.968910155466, 6219.595726277777, 6234.688265586702, 5850.707464626773, 6029.487493563052, 6094.299155597118, 6169.352218017111, 6178.19683441152, 6049.062395328731, 6102.206713127265, 6106.725197366107, 6109.9083513747555, 6118.938810611881, 5109.923351149736, 5315.627906046579, 5366.70483123428, 5384.40771515133, 5388.568914486832, 26352.0, 26353.0, 26429.47141057168, 26524.469510609873, 26794.330141746614, 2373.6202207646693, 2403.591389463795, 2814.0010296344913, 3078.4458797416455, 3080.7073328034026, 15721.606959826096, 15806.683866322724, 16051.277692503749, 16186.35254589815, 16348.019118852906, 1815.3555487801905, 1819.8089200634008, 1843.741876137342, 1846.769153855768, 1848.8890666559914, 74942.62528687321, 102399.0, 115722.0, 115813.0, 115934.84065159324, 8347.791305217297, 9895.208383329316, 10013.148882345082, 10546.05085542305, 10603.94698026505, 12325.137240393087, 12375.876241237473, 12425.19236249641, 12441.813372799415, 12473.126881118416, 8069.193080691884, 8172.223638754309, 8271.586420679063, 8277.58612069394, 8350.62422191003, 8549.658013679507, 8563.828723425497, 8611.224989750952, 8731.0, 8759.474431534129, 3862.1310205204168, 3867.2458870519977, 3879.650831425185, 3939.7242193046213, 3946.743461674982, 1858.8605854560963, 1894.4127320530679, 1906.9427917162507, 1909.6180763847285, 1912.4167129025782, 781.8045488627843, 861.7845538615346, 868.3617541107282, 924.1728652855791, 977.5258999385293, 19882.948120226054, 21172.0, 21214.89392553058, 21252.681209781866, 21493.46266343354, 914.9679761208325, 931.4923366765129, 933.6732143749633, 954.7565370830532, 979.1823827104305, 9695.563699633534, 10579.682609521727, 11153.776924461465, 11286.887131128584, 11297.26567773092, 512889.0, 559229.0, 585408.0, 636655.0, 639940.0, 140495.2975235138, 143211.0, 145367.0, 146534.0, 151794.0, 903.6385445821724, 904.5115637555647, 922.4280945813639, 926.0, 955.1165172215811, 17901.910490447466, 18577.81422185815, 19008.42974710761, 19033.762805417602, 19120.043997799778, 40170.39744403895, 49195.0, 57687.0, 58413.06919425629, 58482.415175847695, 84982.57508712416, 85585.0, 87182.56408717915, 88464.0, 90690.54654726684, 7556.735514256975, 7850.0, 7876.527408355517, 8203.671853125808, 8207.548584827891, 11181.32912025281, 12333.568325108577, 12374.62876113718, 12655.050871184882, 13043.34783260852, 9391.154796068387, 10621.734456638645, 10776.0, 11007.669769906915, 11159.832602511131, 10573.62992295266, 10679.932006799258, 10725.30285531438, 10775.946120269662, 10893.945530272298, 10960.0, 10974.561017559208, 10977.506012229629, 11063.889361106287, 11352.829707554558, 7926.564038977912, 7929.246721561442, 7940.28537431634, 8107.918920810716, 8381.287590554628, 8118.675252989814, 9866.703998880044, 10275.383476991405, 10946.014858662758, 11100.777984440427], "value": 9554.5612119768, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.8600496947827, 1488.538553048555, 1504.2478760619688, 1678.6223099802546, 1840.5674666453372, 8025.678972841087, 8576.742697719063, 8580.91419085809, 8582.141785821415, 8587.699430519933, 8733.868991965126, 8897.955510222457, 9016.323775716815, 9141.77145571361, 9156.908430915706, 2378.3102900158933, 2405.0860672944254, 2410.6866107406013, 2412.0472413396697, 2415.251272105644, 2398.5322862041908, 2430.44099857033, 2440.926772196828, 2441.084593277521, 2459.667944827452, 2413.324269204617, 2439.451123497208, 2443.584590619599, 2446.7675570820743, 2447.1801946347996, 2392.712874455059, 2401.1595941420537, 2413.2880800163816, 2414.746451622572, 2427.0291883246664, 2056.352249041562, 2381.6546600742795, 2409.7831195192343, 2414.637804329347, 2422.1885668300965, 9028.638854445815, 9069.863952040725, 9130.406523575946, 9136.314776391797, 9157.450552966844, 5255.369355677343, 5309.230161626581, 5473.0969390050595, 5482.0406428874785, 5495.340559132929, 3537.6462353764673, 3632.164602141522, 3649.434337677664, 3671.284099600579, 3676.9264614707554, 1071.276888100529, 1085.2728671789919, 1099.2799716185912, 1110.2616759854686, 1113.8663360396804, 11917.463714132884, 12120.45457954394, 12128.878711212952, 12130.393480325949, 12133.817992730115, 4330.2282670158675, 4821.4696383397795, 4852.126617208936, 4945.208766597327, 5011.824586139541, 10522.421266830244, 10526.842097368546, 10531.894681053245, 10545.10366618846, 10579.100776433936, 4835.879103022382, 5570.832875013756, 5581.469760372758, 5605.495505404533, 5607.299087614048, 4255.787210639455, 4539.773011349485, 4658.813647454132, 5034.974825125851, 5063.240513922941, 3769.0, 3959.7822119783114, 4075.49056367954, 4188.036751547162, 4230.809613567397, 1286.0, 1319.3732976836118, 1322.735452909422, 1330.2284674888542, 1335.2922950836073, 670.7384120193128, 868.370431437203, 907.5326207003399, 928.6656803550717, 934.4019827310527, 5690.374058853523, 5715.312186578457, 5808.344621782856, 6000.639961602318, 6212.285587157445, 892.2282225874571, 980.3235767320526, 983.9852402213972, 994.3238597753452, 1019.7246743379246, 3904.4924159859606, 3992.441058251847, 4005.272460381624, 4112.300908845504, 4140.8136633850945, 10734.946325268324, 11209.495572699248, 11213.887861121448, 11215.158863085302, 11235.55057797679, 11156.051735602565, 11159.386233757059, 11168.162387820947, 11177.993980541627, 11192.776144477064, 8332.791680207922, 8469.153084691605, 8516.020657624453, 8522.318214542822, 8545.0, 5825.854353641193, 5850.0932355484965, 5861.1501332307425, 6095.287597019284, 6195.876082478235, 9961.701148965543, 10276.845847312446, 10311.0, 10363.896361036293, 10489.423081730272, 9583.04169583064, 9892.703218903445, 10386.948065259625, 10440.58237670515, 10590.41752703578, 6101.450869421773, 7541.170471248049, 7611.695532178651, 7739.5743234122665, 7868.095169055632, 8458.788530286793, 8657.91342086571, 8664.696735614223, 8681.652733890574, 8802.559872006246, 7832.530048197126, 7844.333231675371, 7975.92024079775, 8044.718434854752, 8077.636506357346, 7727.0, 7810.3751699865015, 7827.178146294557, 7844.21557844211, 7905.723299684483, 7025.332593403618, 7208.603526805866, 7225.205227424874, 7225.6387180641805, 7245.347918687344, 5063.443021267584, 5172.637915345889, 5193.714345711022, 5206.661566998133, 5475.397706252229, 5214.608904332114, 5354.892902142014, 5452.0, 5476.069068258326, 5492.395836458067], "value": 4707.20827036597, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [264.15997129129374, 286.43715099828836, 311.5155932524924, 315.7505570599225, 320.18672571667963, 4748.12159750446, 5189.351331083614, 5250.501202385772, 5292.3913749918775, 5333.599980001496, 3983.66138878195, 4717.820544863784, 5171.974140129303, 5232.398274198468, 5249.1601343785005, 3736.4768932349493, 3838.328292548793, 3910.1006768443203, 4005.299072662287, 4074.490688663917, 3471.340445315382, 4019.648505624213, 4032.3749818778138, 4082.7754473503946, 4083.8350278534226, 3912.8630497932577, 4002.5597184309704, 4003.9389561766156, 4021.296273152201, 4025.6980726445636, 3549.8346008934527, 3613.5663720353728, 3684.5446048810704, 3808.533714519902, 4027.697922655798, 3505.6844883960566, 3514.0, 3527.841247143859, 3529.0118766745354, 3529.6999755020597, 4303.096349766522, 4344.56554344563, 5133.460986596391, 5174.981757114729, 5194.986977539382, 4451.642249114019, 4596.241620132674, 4599.632029437637, 4614.492405835355, 4619.214733495314, 4417.160739459492, 4969.776360063805, 5214.504622060898, 5455.936092461971, 5469.781208751645, 3316.2538428853554, 3867.91132788294, 3878.631530004645, 3878.747881387729, 3905.9609403906165, 5403.83788486346, 5638.887222255532, 5711.514521265697, 5726.627769194989, 5743.712814359307, 3245.983770081182, 3431.4681224410256, 3895.7272990890933, 3920.588837864693, 3942.2312649033165, 3437.8998720409227, 3977.482927219443, 3980.820863061111, 3983.46223259862, 4004.5594984551676, 4597.287420449836, 4616.891945933019, 4617.538246175355, 4618.468876079294, 4631.606313463326, 4943.959464929115, 5430.972845135749, 5468.152436372368, 5481.218603953731, 5516.834494965157, 1339.3169483563454, 1357.2738584857054, 1362.6457121148574, 1362.9709569275333, 1363.454618152747, 809.9230573095547, 828.9886338666817, 835.9164083591592, 861.1302584389687, 886.2334081019872, 4070.5725898780793, 5048.722320272347, 5195.19474481456, 5197.870053248699, 5304.946950530445, 5638.887222255532, 5654.5193658538665, 5659.660420374791, 5660.971695141498, 5696.234167408117, 5018.071656743514, 5101.642884998015, 5105.273150600008, 5186.662866913639, 5222.2427747976335, 2598.2854714953537, 2767.972320276812, 2879.466069858553, 2927.795054346218, 2959.6300462442196, 5230.3985041719925, 5763.538916886723, 5775.451332123442, 5809.2738407699035, 5841.561882858802, 5362.329708786402, 5716.4569365911, 5738.942610573924, 5757.553039958001, 5810.750688601886, 5177.0, 5184.9740751296, 5301.628885977944, 5656.490915817514, 5971.462568368781, 5274.393444753902, 5734.254546909042, 5761.683107429131, 5769.711514424346, 5814.982378083903, 5167.793288268577, 5172.35349078906, 5492.402476377979, 5562.694051827189, 5626.662400255997, 5890.970545147246, 5891.764329426775, 5918.496927761188, 5919.319278283053, 5922.378150294329, 3384.729221662212, 3679.5584529856587, 3806.3061937437574, 3848.3650197718184, 3849.01850028241, 4655.858305179655, 5199.76601052946, 5364.919526207188, 5691.731201598801, 5793.188953546591, 4551.38556294896, 4973.975130124326, 5542.944570554243, 5550.58370622213, 5581.888362232814, 4695.0, 5136.383633963948, 5570.582206334622, 5576.386597474356, 5621.297337832771, 4806.303086052572, 5450.809221677222, 5465.398806131402, 5467.644603100785, 5484.862878427912, 5243.790248390174, 5333.7066461345, 5428.59285553593, 5429.321334833146, 5524.585656075891, 5416.674999500043, 5425.83722488326, 5445.658366902112, 5454.890902182014, 5462.399136095106], "value": 4039.2071025282, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.8785218660643, 731.3016069653478, 772.3396495995927, 789.403999980015, 821.0557858462769, 14825.703485930275, 16136.435224767136, 16143.91928040361, 16145.919270403632, 16177.514674559767, 14480.565583032527, 14642.560723178294, 14658.19379934106, 14672.26638668065, 14729.92635036826, 668.9096971908791, 695.6139342664819, 696.8362434827811, 834.2741814621257, 860.6428332242112, 862.7454900804246, 879.7184900831736, 880.2473884828476, 880.744584070622, 880.7930136417968, 924.36219008884, 926.666400095965, 928.4243768863314, 928.767808047988, 929.6281487405024, 710.3961632612289, 732.1360794262768, 732.3482100930177, 735.8859376796605, 920.8434566123741, 546.915228139635, 654.8264709851893, 672.237010992527, 677.3395938959525, 678.1286047429079, 14689.853101468956, 14718.852811471856, 14720.705585888223, 14736.55790326292, 14736.705265894729, 13520.18878867271, 13819.585412437644, 13845.307734613229, 13867.861321386757, 13918.930405347908, 12101.82871196794, 12351.32067736274, 12411.0, 12602.936985315106, 12903.870961290455, 4527.86416407505, 4601.3558101865765, 4602.332661764059, 4619.676622636417, 4732.574068333866, 116638.0, 118069.40965295205, 118330.40834795857, 122059.3897030518, 125987.0, 10483.842742358871, 10775.461226938622, 10887.455627218607, 10888.074513666426, 11012.944935275273, 21360.14559417637, 21376.57246855054, 21393.358199254046, 21403.67894481584, 21440.249591264543, 7709.884351734729, 7901.170377110436, 7942.245486678872, 8068.3948703847445, 8114.756557303291, 4332.393464914914, 4475.753833539122, 4556.7721613919175, 4574.268117101248, 4594.379758732595, 3490.5811302643338, 3646.507721457622, 3647.0699971507624, 3652.0, 3659.268146370683, 665.710415969055, 669.1267895396554, 681.2914568848441, 683.0676127086491, 686.1765880942788, 484.9345338379344, 530.5278302310946, 599.604261187614, 618.3476432363899, 627.1752645271454, 7658.61706914652, 8551.401401901807, 8895.88801399825, 9046.909530904739, 9139.040400757958, 507.2062222621585, 510.8518529626441, 554.4815597416429, 599.7271241585069, 613.6440864298696, 4193.643540299109, 4369.47566292047, 4383.868483945486, 4409.0, 4469.776511174428, 97581.0, 106458.0, 134486.0, 138268.30865845605, 176898.0, 121252.0, 124983.0, 125290.0, 130213.34893325662, 131097.68902311046, 108333.45833270783, 110344.89655103347, 110523.44738276258, 111189.0, 112415.0, 8459.323254139532, 9752.122308992224, 9818.116369526777, 9853.014698530089, 10091.394516329045, 47267.763661181474, 57275.0, 58062.7096864513, 59284.62861485665, 64176.82850614695, 95109.0, 98282.5085874566, 98693.0, 100825.49587252017, 101027.98972010186, 13030.804537931748, 13208.537701180798, 13350.732985340044, 13480.73038539204, 13559.796603050765, 14621.19583422922, 14864.554063378117, 14997.32512036939, 15126.243687815346, 15247.771283430979, 10633.574657013633, 12772.552960646333, 14067.718645626825, 14566.126032438087, 14611.0, 12793.680157995752, 12942.482300708243, 13181.80227296572, 13981.161130331806, 14588.85411145875, 13501.257430841006, 14088.647783805487, 14588.562343129723, 14612.97709160391, 14737.484188053366, 9736.707898763048, 10213.591456341961, 11337.716557086138, 11348.20224774996, 11411.942940285246, 11481.82777258325, 11515.424228788359, 11593.420328983686, 11731.706707332385, 11851.0], "value": 7779.459005733294, "unit": "score"}], "name": "dromaeo_css", "value": 7399.670325771927, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 109.0, 106.0, 113.0, 112.0, 159.0, 163.0, 114.0], "value": 121.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 109.0, 109.0, 144.0, 111.0, 108.0, 110.0, 110.0, 140.0, 109.0], "value": 119.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 184.0, 184.0, 182.0, 182.0, 184.0, 184.0, 219.0, 186.0], "value": 186.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 57.0, 75.0, 104.0, 51.0, 50.0, 61.0, 63.0, 107.0, 80.0], "value": 73.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 94.0, 70.0, 69.0, 69.0, 91.0, 68.0, 68.0, 90.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 90.0, 122.0, 86.0, 83.0, 86.0, 83.0, 85.0, 83.0], "value": 88.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 93.0, 93.0, 93.0, 92.0, 92.0, 92.0, 93.0, 92.0], "value": 92.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 83.0, 83.0, 84.0, 86.0, 85.0, 87.0, 98.0, 135.0], "value": 91.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 51.0, 52.0, 53.0, 54.0, 57.0, 57.0, 56.0, 56.0, 56.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 64.0, 76.0, 72.0, 68.0, 69.0, 70.0, 70.0, 69.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 81.0, 80.0, 84.0, 85.0, 82.0, 86.0, 85.0, 99.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 136.0, 135.0, 134.0, 133.0, 141.0, 133.0, 179.0, 142.0], "value": 140.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 160.0, 162.0, 161.0, 164.0, 160.0, 166.0, 159.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 68.0, 80.0, 82.0, 82.0, 83.0, 71.0], "value": 73.1, "unit": "score"}], "name": "kraken", "value": 1434.5999999999997, "alertThreshold": 2.0}]} 19:31:17 INFO - Return code: 0 19:31:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:31:17 INFO - # TBPL SUCCESS # 19:31:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:31:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:31:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:31:17 INFO - 2016-09-22 19:31:17.124 screenresolution[2046:281856] starting screenresolution argv=screenresolution get 19:31:17 INFO - 2016-09-22 19:31:17.127 screenresolution[2046:281856] Display 0: 1600x1200x32@60 19:31:17 INFO - 2016-09-22 19:31:17.133 screenresolution[2047:281860] starting screenresolution argv=screenresolution list 19:31:17 INFO - Available Modes on Display 0 19:31:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:31:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:31:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:31:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:31:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:31:17 INFO - Intel Iris: 19:31:17 INFO - Chipset Model: Intel Iris 19:31:17 INFO - Type: GPU 19:31:17 INFO - Bus: Built-In 19:31:17 INFO - VRAM (Dynamic, Max): 1536 MB 19:31:17 INFO - Vendor: Intel (0x8086) 19:31:17 INFO - Device ID: 0x0a2e 19:31:17 INFO - Revision ID: 0x0009 19:31:17 INFO - Displays: 19:31:17 INFO - Display: 19:31:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:31:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:31:17 INFO - Display Serial Number: 1600x1200 60 19:31:17 INFO - Main Display: Yes 19:31:17 INFO - Mirror: Off 19:31:17 INFO - Online: Yes 19:31:17 INFO - Rotation: Supported 19:31:17 INFO - Return code: 0 19:31:17 INFO - Running post-action listener: _resource_record_post_action 19:31:17 INFO - [mozharness: 2016-09-23 02:31:17.373718Z] Finished run-tests step (success) 19:31:17 INFO - Running post-run listener: _resource_record_post_run 19:31:17 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 8699392; Write bytes: 665950208; Read time: 52; Write time: 1937 19:31:17 INFO - TinderboxPrint: CPU usage
53.4% 19:31:17 INFO - TinderboxPrint: I/O read bytes / time
8,699,392 / 52 19:31:17 INFO - TinderboxPrint: I/O write bytes / time
665,950,208 / 1,937 19:31:17 INFO - TinderboxPrint: CPU idle
2,252.1 (46.6%) 19:31:17 INFO - TinderboxPrint: CPU system
966.4 (20.0%) 19:31:17 INFO - TinderboxPrint: CPU user
1,619.2 (33.5%) 19:31:17 INFO - TinderboxPrint: Swap in / out
380,309,504 / 0 19:31:17 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 361957888; Write bytes: 355923968; Read time: 27768; Write time: 777 19:31:17 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 7704064; Write bytes: 299634688; Read time: 47; Write time: 1125 19:31:17 INFO - Running post-run listener: _upload_blobber_files 19:31:17 INFO - Blob upload gear active. 19:31:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:31:17 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 19:31:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:31:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:31:18 INFO - (blobuploader) - INFO - Open directory for files ... 19:31:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:31:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:31:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:19 INFO - (blobuploader) - INFO - Done attempting. 19:31:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:31:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:31:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:20 INFO - (blobuploader) - INFO - Done attempting. 19:31:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:31:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:31:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:23 INFO - (blobuploader) - INFO - Done attempting. 19:31:23 INFO - (blobuploader) - INFO - Iteration through files over. 19:31:23 INFO - Return code: 0 19:31:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:31:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:31:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ad11c005afaf3a4085b00f6fd72643599cd9a06648e5fd1c8a0f7ab0ce0614cd4cbbcf0db58e43cca298e8c0919467801cd0264f05fbb891a95afc893b6e776", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c7bdbee468e807cc255d319dcb967ff8d38ca284ce7d3097073544d2c0b06fb62469317aac53b06f87cc7c502c53ec3d00d607a9862331523c6bdab33e0b916e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0eb55d38f9491e5dcf39730d85ff5b7582fcaa218dc8ec14bde3e08ac3445d3a7d75066a8a1e65b2571086b562f53375af3f729f51b48093d874a9fbb1f5bafc"} 19:31:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:31:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:31:23 INFO - Contents: 19:31:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ad11c005afaf3a4085b00f6fd72643599cd9a06648e5fd1c8a0f7ab0ce0614cd4cbbcf0db58e43cca298e8c0919467801cd0264f05fbb891a95afc893b6e776", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c7bdbee468e807cc255d319dcb967ff8d38ca284ce7d3097073544d2c0b06fb62469317aac53b06f87cc7c502c53ec3d00d607a9862331523c6bdab33e0b916e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0eb55d38f9491e5dcf39730d85ff5b7582fcaa218dc8ec14bde3e08ac3445d3a7d75066a8a1e65b2571086b562f53375af3f729f51b48093d874a9fbb1f5bafc"} 19:31:23 INFO - Running post-run listener: copy_logs_to_upload_dir 19:31:23 INFO - Copying logs to upload dir... 19:31:23 INFO - mkdir: /builds/slave/test/build/upload/logs 19:31:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.230318 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-09-22 19:31:23.222343) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 19:31:23.226023) ========= 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.UmVrfe8Gek/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.FfnUX0OJPx/Listeners TMPDIR=/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ad11c005afaf3a4085b00f6fd72643599cd9a06648e5fd1c8a0f7ab0ce0614cd4cbbcf0db58e43cca298e8c0919467801cd0264f05fbb891a95afc893b6e776", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c7bdbee468e807cc255d319dcb967ff8d38ca284ce7d3097073544d2c0b06fb62469317aac53b06f87cc7c502c53ec3d00d607a9862331523c6bdab33e0b916e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0eb55d38f9491e5dcf39730d85ff5b7582fcaa218dc8ec14bde3e08ac3445d3a7d75066a8a1e65b2571086b562f53375af3f729f51b48093d874a9fbb1f5bafc"} build_url:https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011010 build_url: 'https://queue.taskcluster.net/v1/task/TamY6IDjRSWwV3EcS2xtHg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3ad11c005afaf3a4085b00f6fd72643599cd9a06648e5fd1c8a0f7ab0ce0614cd4cbbcf0db58e43cca298e8c0919467801cd0264f05fbb891a95afc893b6e776", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c7bdbee468e807cc255d319dcb967ff8d38ca284ce7d3097073544d2c0b06fb62469317aac53b06f87cc7c502c53ec3d00d607a9862331523c6bdab33e0b916e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0eb55d38f9491e5dcf39730d85ff5b7582fcaa218dc8ec14bde3e08ac3445d3a7d75066a8a1e65b2571086b562f53375af3f729f51b48093d874a9fbb1f5bafc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 19:31:23.259198) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 19:31:23.259535) ========= 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.UmVrfe8Gek/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.FfnUX0OJPx/Listeners TMPDIR=/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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.005138 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 19:31:23.311960) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 19:31:23.313203) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 19:31:23.314285) ========= ========= Total master_lag: 0.19 =========