builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0181 starttime: 1473286614.12 results: success (0) buildid: 20160907142316 builduid: a41597a434454603a3f719ed4e020bd0 revision: ab70808cd4b6c6ad9a57a9f71cfa495fcea0aecd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-07 15:16:54.122997) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-07 15:16:54.123431) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-07 15:16:54.123703) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-07 15:16:54.148776) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 15:16:54.149088) ========= 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.pV4jRG9jKB/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.4cXZIbxrMa/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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-07 15:16:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.47M=0.001s 2016-09-07 15:16:54 (9.47 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086187 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 15:16:54.258291) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 15:16:54.258601) ========= 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.pV4jRG9jKB/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.4cXZIbxrMa/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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.030775 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 15:16:54.310877) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 15:16:54.311182) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ab70808cd4b6c6ad9a57a9f71cfa495fcea0aecd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ab70808cd4b6c6ad9a57a9f71cfa495fcea0aecd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pV4jRG9jKB/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.4cXZIbxrMa/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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-07 15:16:54,353 truncating revision to first 12 chars 2016-09-07 15:16:54,353 Setting DEBUG logging. 2016-09-07 15:16:54,353 attempt 1/10 2016-09-07 15:16:54,353 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ab70808cd4b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-07 15:16:55,006 unpacking tar archive at: mozilla-central-ab70808cd4b6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.925145 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 15:16:55.258580) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-07 15:16:55.258912) ========= script_repo_revision: ab70808cd4b6c6ad9a57a9f71cfa495fcea0aecd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-07 15:16:55.259333) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-07 15:16:55.259598) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-07 15:16:55.278807) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-07 15:16:55.279212) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pV4jRG9jKB/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.4cXZIbxrMa/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 15:16:55 INFO - MultiFileLogger online at 20160907 15:16:55 in /builds/slave/test 15:16:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:16:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:16:55 INFO - {'append_to_log': False, 15:16:55 INFO - 'base_work_dir': '/builds/slave/test', 15:16:55 INFO - 'blob_upload_branch': 'Firefox', 15:16:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:16:55 INFO - 'branch': 'Firefox', 15:16:55 INFO - 'buildbot_json_path': 'buildprops.json', 15:16:55 INFO - 'config_files': ('talos/mac_config.py',), 15:16:55 INFO - 'default_actions': ('clobber', 15:16:55 INFO - 'read-buildbot-config', 15:16:55 INFO - 'download-and-extract', 15:16:55 INFO - 'populate-webroot', 15:16:55 INFO - 'create-virtualenv', 15:16:55 INFO - 'install', 15:16:55 INFO - 'run-tests'), 15:16:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:16:55 INFO - 'download_minidump_stackwalk': True, 15:16:55 INFO - 'download_symbols': 'ondemand', 15:16:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:16:55 INFO - 'tooltool.py': '/tools/tooltool.py', 15:16:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:16:55 INFO - '/tools/misc-python/virtualenv.py')}, 15:16:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:16:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:16:55 INFO - 'installer_path': 'installer.exe', 15:16:55 INFO - 'log_level': 'info', 15:16:55 INFO - 'log_name': 'talos', 15:16:55 INFO - 'log_to_console': True, 15:16:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:16:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:16:55 INFO - 'opt_config_files': (), 15:16:55 INFO - 'pip_index': False, 15:16:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:16:55 INFO - 'cmd': ('bash', 15:16:55 INFO - '-c', 15:16:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:16:55 INFO - 'enabled': True, 15:16:55 INFO - 'halt_on_failure': False, 15:16:55 INFO - 'name': 'check_screen_resolution'},), 15:16:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:16:55 INFO - 'cmd': ('bash', 15:16:55 INFO - '-c', 15:16:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:16:55 INFO - 'enabled': True, 15:16:55 INFO - 'halt_on_failure': False, 15:16:55 INFO - 'name': 'check_screen_resolution'},), 15:16:55 INFO - 'run_cmd_checks_enabled': True, 15:16:55 INFO - 'sps_profile': False, 15:16:55 INFO - 'sps_profile_interval': 0, 15:16:55 INFO - 'suite': 'dromaeojs', 15:16:55 INFO - 'system_bits': '32', 15:16:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:16:55 INFO - 'title': 't-yosemite-r7-0181', 15:16:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:16:55 INFO - 'use_talos_json': True, 15:16:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:16:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:16:55 INFO - 'work_dir': 'build'} 15:16:55 INFO - [mozharness: 2016-09-07 22:16:55.448397Z] Running clobber step. 15:16:55 INFO - Running pre-action listener: _resource_record_pre_action 15:16:55 INFO - Running main action method: clobber 15:16:55 INFO - rmtree: /builds/slave/test/build 15:16:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:16:57 INFO - Running post-action listener: _resource_record_post_action 15:16:57 INFO - [mozharness: 2016-09-07 22:16:57.551307Z] Finished clobber step (success) 15:16:57 INFO - [mozharness: 2016-09-07 22:16:57.551430Z] Running read-buildbot-config step. 15:16:57 INFO - Running pre-action listener: _resource_record_pre_action 15:16:57 INFO - Running main action method: read_buildbot_config 15:16:57 INFO - Using buildbot properties: 15:16:57 INFO - { 15:16:57 INFO - "project": "", 15:16:57 INFO - "product": "firefox", 15:16:57 INFO - "script_repo_revision": "production", 15:16:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 15:16:57 INFO - "repository": "", 15:16:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 15:16:57 INFO - "buildid": "20160907142316", 15:16:57 INFO - "pgo_build": "False", 15:16:57 INFO - "basedir": "/builds/slave/test", 15:16:57 INFO - "buildnumber": 37, 15:16:57 INFO - "slavename": "t-yosemite-r7-0181", 15:16:57 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 15:16:57 INFO - "platform": "yosemite_r7", 15:16:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:16:57 INFO - "branch": "mozilla-central", 15:16:57 INFO - "repo_path": "mozilla-central", 15:16:57 INFO - "revision": "ab70808cd4b6c6ad9a57a9f71cfa495fcea0aecd", 15:16:57 INFO - "stage_platform": "macosx64", 15:16:57 INFO - "builduid": "a41597a434454603a3f719ed4e020bd0", 15:16:57 INFO - "slavebuilddir": "test" 15:16:57 INFO - } 15:16:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/HJWCn7LmQhiNh140AjPWrg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 15:16:57 INFO - Running post-action listener: _resource_record_post_action 15:16:57 INFO - [mozharness: 2016-09-07 22:16:57.554374Z] Finished read-buildbot-config step (success) 15:16:57 INFO - [mozharness: 2016-09-07 22:16:57.554471Z] Running download-and-extract step. 15:16:57 INFO - Running pre-action listener: _resource_record_pre_action 15:16:57 INFO - Running main action method: download_and_extract 15:16:57 INFO - mkdir: /builds/slave/test/build/tests 15:16: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')]} 15:16:57 INFO - trying https://queue.taskcluster.net/v1/task/HJWCn7LmQhiNh140AjPWrg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 15:16:57 INFO - Downloading https://queue.taskcluster.net/v1/task/HJWCn7LmQhiNh140AjPWrg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 15:16:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HJWCn7LmQhiNh140AjPWrg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 15:16:58 INFO - Downloaded 1199 bytes. 15:16:58 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 15:16:58 INFO - Using the following test package requirements: 15:16:58 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 15:16:58 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:16:58 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 15:16:58 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:16:58 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 15:16:58 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:16:58 INFO - u'jsshell-mac.zip'], 15:16:58 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:16:58 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 15:16:58 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 15:16:58 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:16:58 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 15:16:58 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:16:58 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 15:16:58 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:16:58 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 15:16:58 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 15:16:58 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 15:16:58 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:16:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HJWCn7LmQhiNh140AjPWrg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 15:16:59 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 15:17:06 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:17:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HJWCn7LmQhiNh140AjPWrg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 15:17:06 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 15:17:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HJWCn7LmQhiNh140AjPWrg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 15:17:14 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 15:17:14 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')]} 15:17:14 INFO - trying https://queue.taskcluster.net/v1/task/HJWCn7LmQhiNh140AjPWrg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:17:14 INFO - Downloading https://queue.taskcluster.net/v1/task/HJWCn7LmQhiNh140AjPWrg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 15:17:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HJWCn7LmQhiNh140AjPWrg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 15:17:17 INFO - Downloaded 111563761 bytes. 15:17:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HJWCn7LmQhiNh140AjPWrg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:17:17 INFO - mkdir: /builds/slave/test/properties 15:17:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:17:17 INFO - Writing to file /builds/slave/test/properties/build_url 15:17:17 INFO - Contents: 15:17:17 INFO - build_url:https://queue.taskcluster.net/v1/task/HJWCn7LmQhiNh140AjPWrg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 15:17:18 INFO - Running post-action listener: _resource_record_post_action 15:17:18 INFO - Running post-action listener: set_extra_try_arguments 15:17:18 INFO - [mozharness: 2016-09-07 22:17:18.423182Z] Finished download-and-extract step (success) 15:17:18 INFO - [mozharness: 2016-09-07 22:17:18.423296Z] Running populate-webroot step. 15:17:18 INFO - Running pre-action listener: _resource_record_pre_action 15:17:18 INFO - Running main action method: populate_webroot 15:17:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:17:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:17:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:17:18 INFO - '--tppagecycles', 15:17:18 INFO - '7'], 15:17:18 INFO - 'tests': ['tsvgm']}}, 15:17:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:17:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:17:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:17:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:17:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:17:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:17:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:18 INFO - 'talos_options': ['--disable-e10s'], 15:17:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:17:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:17:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:18 INFO - 'talos_options': ['--disable-e10s'], 15:17:18 INFO - 'tests': ['damp', 'tps']}, 15:17:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:18 INFO - 'tests': ['damp', 'tps']}, 15:17:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:17:18 INFO - 'tests': ['dromaeo_dom']}, 15:17:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:17:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:17:18 INFO - 'tests': ['basic_compositor_video']}, 15:17:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:17:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:17:18 INFO - 'tests': ['a11yr', 15:17:18 INFO - 'ts_paint', 15:17:18 INFO - 'tpaint', 15:17:18 INFO - 'sessionrestore', 15:17:18 INFO - 'sessionrestore_no_auto_restore', 15:17:18 INFO - 'tabpaint']}, 15:17:18 INFO - 'other-e10s': {'tests': ['a11yr', 15:17:18 INFO - 'ts_paint', 15:17:18 INFO - 'tpaint', 15:17:18 INFO - 'sessionrestore', 15:17:18 INFO - 'sessionrestore_no_auto_restore', 15:17:18 INFO - 'tabpaint']}, 15:17:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:17:18 INFO - 'ts_paint', 15:17:18 INFO - 'tpaint', 15:17:18 INFO - 'sessionrestore', 15:17:18 INFO - 'sessionrestore_no_auto_restore', 15:17:18 INFO - 'tabpaint']}, 15:17:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:17:18 INFO - 'ts_paint', 15:17:18 INFO - 'tpaint', 15:17:18 INFO - 'sessionrestore', 15:17:18 INFO - 'sessionrestore_no_auto_restore', 15:17:18 INFO - 'tabpaint']}, 15:17:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:17:18 INFO - 'tests': ['a11yr', 15:17:18 INFO - 'ts_paint', 15:17:18 INFO - 'tpaint', 15:17:18 INFO - 'sessionrestore', 15:17:18 INFO - 'sessionrestore_no_auto_restore', 15:17:18 INFO - 'tabpaint']}, 15:17:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:17:18 INFO - 'tests': ['a11yr', 15:17:18 INFO - 'ts_paint', 15:17:18 INFO - 'tpaint', 15:17:18 INFO - 'sessionrestore', 15:17:18 INFO - 'sessionrestore_no_auto_restore', 15:17:18 INFO - 'tabpaint']}, 15:17:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:17:18 INFO - 'tests': ['tsvgx', 15:17:18 INFO - 'tsvgr_opacity', 15:17:18 INFO - 'tart', 15:17:18 INFO - 'tscrollx', 15:17:18 INFO - 'cart']}, 15:17:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:17:18 INFO - 'tsvgr_opacity', 15:17:18 INFO - 'tart', 15:17:18 INFO - 'tscrollx', 15:17:18 INFO - 'cart']}, 15:17:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:18 INFO - 'talos_options': ['--disable-e10s'], 15:17:18 INFO - 'tests': ['tp5o']}, 15:17:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:18 INFO - 'tests': ['tp5o']}, 15:17:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:18 INFO - 'talos_options': ['--disable-e10s', 15:17:18 INFO - '--xperf_path', 15:17:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:17:18 INFO - 'tests': ['tp5n']}, 15:17:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:18 INFO - 'talos_options': ['--xperf_path', 15:17:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:17:18 INFO - 'tests': ['tp5n']}}, 15:17:18 INFO - 'talos.zip': {'path': '', 15:17:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:17:18 INFO - Running post-action listener: _resource_record_post_action 15:17:18 INFO - [mozharness: 2016-09-07 22:17:18.442087Z] Finished populate-webroot step (success) 15:17:18 INFO - [mozharness: 2016-09-07 22:17:18.442199Z] Running create-virtualenv step. 15:17:18 INFO - Running pre-action listener: _resource_record_pre_action 15:17:18 INFO - Running main action method: create_virtualenv 15:17:18 INFO - Creating virtualenv /builds/slave/test/build/venv 15:17:18 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 15:17:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:17:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:17:18 INFO - Using real prefix '/tools/python27' 15:17:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:17:19 INFO - Installing distribute.............................................................................................................................................................................................done. 15:17:22 INFO - Installing pip.................done. 15:17:22 INFO - Return code: 0 15:17:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:17:22 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')]} 15:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:22 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')]} 15:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:22 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 0x106ad8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b6d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a956f0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a3cd30>, '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 0x1067a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a34b20>, '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.pV4jRG9jKB/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.4cXZIbxrMa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 15:17:22 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 15:17:22 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 15:17:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pV4jRG9jKB/Render', 15:17:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:22 INFO - 'HOME': '/Users/cltbld', 15:17:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:22 INFO - 'LOGNAME': 'cltbld', 15:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:22 INFO - 'MOZ_NO_REMOTE': '1', 15:17:22 INFO - 'NO_EM_RESTART': '1', 15:17:22 INFO - 'PAGER': '/bin/cat', 15:17:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:22 INFO - 'PWD': '/builds/slave/test', 15:17:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:22 INFO - 'SHELL': '/bin/bash', 15:17:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4cXZIbxrMa/Listeners', 15:17:22 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 15:17:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:22 INFO - 'USER': 'cltbld', 15:17:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:22 INFO - 'XPC_FLAGS': '0x0', 15:17:22 INFO - 'XPC_SERVICE_NAME': '0', 15:17:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:22 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 15:17:22 INFO - Cleaning up... 15:17:22 INFO - Return code: 0 15:17:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:17:22 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')]} 15:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:22 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')]} 15:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:22 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 0x106ad8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b6d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a956f0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a3cd30>, '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 0x1067a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a34b20>, '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.pV4jRG9jKB/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.4cXZIbxrMa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 15:17:22 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 15:17:22 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 15:17:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pV4jRG9jKB/Render', 15:17:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:22 INFO - 'HOME': '/Users/cltbld', 15:17:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:22 INFO - 'LOGNAME': 'cltbld', 15:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:22 INFO - 'MOZ_NO_REMOTE': '1', 15:17:22 INFO - 'NO_EM_RESTART': '1', 15:17:22 INFO - 'PAGER': '/bin/cat', 15:17:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:22 INFO - 'PWD': '/builds/slave/test', 15:17:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:22 INFO - 'SHELL': '/bin/bash', 15:17:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4cXZIbxrMa/Listeners', 15:17:22 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 15:17:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:22 INFO - 'USER': 'cltbld', 15:17:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:22 INFO - 'XPC_FLAGS': '0x0', 15:17:22 INFO - 'XPC_SERVICE_NAME': '0', 15:17:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:22 INFO - Downloading/unpacking psutil>=3.1.1 15:17:22 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 15:17:22 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 15:17:22 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 15:17:22 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 15:17:22 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 15:17:22 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 15:17:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:17:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:17:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:17:26 INFO - Installing collected packages: psutil 15:17:26 INFO - Running setup.py install for psutil 15:17:26 INFO - building 'psutil._psutil_osx' extension 15:17:26 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 15:17:26 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 15:17:26 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 15:17:26 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 15:17:27 INFO - building 'psutil._psutil_posix' extension 15:17:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:17:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:17:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:17:27 INFO - ^ 15:17:27 INFO - 1 warning generated. 15:17:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:17:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:17:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:17:27 INFO - Successfully installed psutil 15:17:27 INFO - Cleaning up... 15:17:27 INFO - Return code: 0 15:17:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:17:27 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')]} 15:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:27 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')]} 15:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:27 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 0x106ad8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b6d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a956f0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a3cd30>, '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 0x1067a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a34b20>, '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.pV4jRG9jKB/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.4cXZIbxrMa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 15:17:27 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 15:17:27 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 15:17:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pV4jRG9jKB/Render', 15:17:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:27 INFO - 'HOME': '/Users/cltbld', 15:17:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:27 INFO - 'LOGNAME': 'cltbld', 15:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:27 INFO - 'MOZ_NO_REMOTE': '1', 15:17:27 INFO - 'NO_EM_RESTART': '1', 15:17:27 INFO - 'PAGER': '/bin/cat', 15:17:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:27 INFO - 'PWD': '/builds/slave/test', 15:17:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:27 INFO - 'SHELL': '/bin/bash', 15:17:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4cXZIbxrMa/Listeners', 15:17:27 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 15:17:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:27 INFO - 'USER': 'cltbld', 15:17:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:27 INFO - 'XPC_FLAGS': '0x0', 15:17:27 INFO - 'XPC_SERVICE_NAME': '0', 15:17:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:17:27 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 15:17:27 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 15:17:27 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 15:17:27 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 15:17:27 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 15:17:27 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 15:17:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:17:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:17:30 INFO - Installing collected packages: mozsystemmonitor 15:17:30 INFO - Running setup.py install for mozsystemmonitor 15:17:30 INFO - Successfully installed mozsystemmonitor 15:17:30 INFO - Cleaning up... 15:17:30 INFO - Return code: 0 15:17:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106ad8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b6d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a956f0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a3cd30>, '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 0x1067a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a34b20>, '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.pV4jRG9jKB/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.4cXZIbxrMa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 15:17:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:17:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pV4jRG9jKB/Render', 15:17:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:30 INFO - 'HOME': '/Users/cltbld', 15:17:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:30 INFO - 'LOGNAME': 'cltbld', 15:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:30 INFO - 'MOZ_NO_REMOTE': '1', 15:17:30 INFO - 'NO_EM_RESTART': '1', 15:17:30 INFO - 'PAGER': '/bin/cat', 15:17:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:30 INFO - 'PWD': '/builds/slave/test', 15:17:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:30 INFO - 'SHELL': '/bin/bash', 15:17:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4cXZIbxrMa/Listeners', 15:17:30 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 15:17:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:30 INFO - 'USER': 'cltbld', 15:17:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:30 INFO - 'XPC_FLAGS': '0x0', 15:17:30 INFO - 'XPC_SERVICE_NAME': '0', 15:17:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:30 INFO - Downloading/unpacking jsonschema==2.5.1 15:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:17:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:33 INFO - Downloading functools32-3.2.3-2.tar.gz 15:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:17:33 INFO - warning: no files found matching '*.txt' 15:17:33 INFO - no previously-included directories found matching 'build' 15:17:33 INFO - no previously-included directories found matching 'dist' 15:17:33 INFO - no previously-included directories found matching '.git*' 15:17:33 INFO - Installing collected packages: jsonschema, functools32 15:17:33 INFO - Running setup.py install for functools32 15:17:33 INFO - warning: no files found matching '*.txt' 15:17:33 INFO - no previously-included directories found matching 'build' 15:17:33 INFO - no previously-included directories found matching 'dist' 15:17:33 INFO - no previously-included directories found matching '.git*' 15:17:33 INFO - Successfully installed jsonschema functools32 15:17:33 INFO - Cleaning up... 15:17:33 INFO - Return code: 0 15:17:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:17: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')]} 15:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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')]} 15:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106ad8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b6d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a956f0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a3cd30>, '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 0x1067a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a34b20>, '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.pV4jRG9jKB/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.4cXZIbxrMa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 15:17:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:17:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pV4jRG9jKB/Render', 15:17:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:33 INFO - 'HOME': '/Users/cltbld', 15:17:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:33 INFO - 'LOGNAME': 'cltbld', 15:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:33 INFO - 'MOZ_NO_REMOTE': '1', 15:17:33 INFO - 'NO_EM_RESTART': '1', 15:17:33 INFO - 'PAGER': '/bin/cat', 15:17:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:33 INFO - 'PWD': '/builds/slave/test', 15:17:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:33 INFO - 'SHELL': '/bin/bash', 15:17:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4cXZIbxrMa/Listeners', 15:17:33 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 15:17:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:33 INFO - 'USER': 'cltbld', 15:17:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:33 INFO - 'XPC_FLAGS': '0x0', 15:17:33 INFO - 'XPC_SERVICE_NAME': '0', 15:17:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:17:34 INFO - Cleaning up... 15:17:34 INFO - Return code: 0 15:17:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106ad8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b6d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a956f0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a3cd30>, '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 0x1067a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a34b20>, '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.pV4jRG9jKB/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.4cXZIbxrMa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 15:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:17:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pV4jRG9jKB/Render', 15:17:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:34 INFO - 'HOME': '/Users/cltbld', 15:17:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:34 INFO - 'LOGNAME': 'cltbld', 15:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:34 INFO - 'MOZ_NO_REMOTE': '1', 15:17:34 INFO - 'NO_EM_RESTART': '1', 15:17:34 INFO - 'PAGER': '/bin/cat', 15:17:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:34 INFO - 'PWD': '/builds/slave/test', 15:17:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:34 INFO - 'SHELL': '/bin/bash', 15:17:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4cXZIbxrMa/Listeners', 15:17:34 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 15:17:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:34 INFO - 'USER': 'cltbld', 15:17:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:34 INFO - 'XPC_FLAGS': '0x0', 15:17:34 INFO - 'XPC_SERVICE_NAME': '0', 15:17:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:34 INFO - Downloading/unpacking blobuploader==1.2.4 15:17:34 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 15:17:34 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 15:17:34 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 15:17:34 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 15:17:34 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 15:17:34 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 15:17:36 INFO - Downloading blobuploader-1.2.4.tar.gz 15:17:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:17:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:17:37 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 15:17:37 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 15:17:37 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 15:17:37 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 15:17:37 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 15:17:37 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 15:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:17:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:17:37 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 15:17:37 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 15:17:37 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 15:17:37 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 15:17:37 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 15:17:37 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 15:17:38 INFO - Downloading docopt-0.6.1.tar.gz 15:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:17:38 INFO - Installing collected packages: blobuploader, requests, docopt 15:17:38 INFO - Running setup.py install for blobuploader 15:17:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:17:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:17:38 INFO - Running setup.py install for requests 15:17:38 INFO - Running setup.py install for docopt 15:17:38 INFO - Successfully installed blobuploader requests docopt 15:17:38 INFO - Cleaning up... 15:17:39 INFO - Return code: 0 15:17:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17: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')]} 15:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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')]} 15:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:39 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 0x106ad8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b6d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a956f0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a3cd30>, '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 0x1067a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a34b20>, '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.pV4jRG9jKB/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.4cXZIbxrMa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 15:17:39 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 15:17:39 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 15:17:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pV4jRG9jKB/Render', 15:17:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:39 INFO - 'HOME': '/Users/cltbld', 15:17:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:39 INFO - 'LOGNAME': 'cltbld', 15:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:39 INFO - 'MOZ_NO_REMOTE': '1', 15:17:39 INFO - 'NO_EM_RESTART': '1', 15:17:39 INFO - 'PAGER': '/bin/cat', 15:17:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:39 INFO - 'PWD': '/builds/slave/test', 15:17:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:39 INFO - 'SHELL': '/bin/bash', 15:17:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4cXZIbxrMa/Listeners', 15:17:39 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 15:17:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:39 INFO - 'USER': 'cltbld', 15:17:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:39 INFO - 'XPC_FLAGS': '0x0', 15:17:39 INFO - 'XPC_SERVICE_NAME': '0', 15:17:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:39 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-XaVP43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:39 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-kiNO97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:39 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-kJGguj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:39 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-ctEr4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:39 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-b8TQzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:39 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-VWqGH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:39 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-lVhLek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:40 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-jy8ukB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:40 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-xAVD86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:40 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Fj46to-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:40 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-AAlM7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:40 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-ZwAkt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:40 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-aAhJ9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:40 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-3ufzF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:40 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-QiPq0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:40 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-TMW_5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:41 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-C73wHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:17:41 INFO - Running setup.py install for manifestparser 15:17:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:17:41 INFO - Running setup.py install for mozcrash 15:17:41 INFO - Running setup.py install for mozdebug 15:17:41 INFO - Running setup.py install for mozdevice 15:17:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:17:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:17:41 INFO - Running setup.py install for mozfile 15:17:41 INFO - Running setup.py install for mozhttpd 15:17:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:17:42 INFO - Running setup.py install for mozinfo 15:17:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:17:42 INFO - Running setup.py install for mozInstall 15:17:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:17:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:17:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:17:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:17:42 INFO - Running setup.py install for mozleak 15:17:42 INFO - Running setup.py install for mozlog 15:17:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:17:42 INFO - Running setup.py install for moznetwork 15:17:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:17:42 INFO - Running setup.py install for mozprocess 15:17:42 INFO - Running setup.py install for mozprofile 15:17:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:17:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:17:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:17:43 INFO - Running setup.py install for mozrunner 15:17:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:17:43 INFO - Running setup.py install for mozscreenshot 15:17:43 INFO - Running setup.py install for moztest 15:17:43 INFO - Running setup.py install for mozversion 15:17:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:17:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:17:43 INFO - Cleaning up... 15:17:43 INFO - Return code: 0 15:17:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:43 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')]} 15:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:43 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')]} 15:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:43 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 0x106ad8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b6d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a956f0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a3cd30>, '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 0x1067a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a34b20>, '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.pV4jRG9jKB/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.4cXZIbxrMa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 15:17:43 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 15:17:43 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 15:17:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pV4jRG9jKB/Render', 15:17:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:43 INFO - 'HOME': '/Users/cltbld', 15:17:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:43 INFO - 'LOGNAME': 'cltbld', 15:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:43 INFO - 'MOZ_NO_REMOTE': '1', 15:17:43 INFO - 'NO_EM_RESTART': '1', 15:17:43 INFO - 'PAGER': '/bin/cat', 15:17:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:43 INFO - 'PWD': '/builds/slave/test', 15:17:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:43 INFO - 'SHELL': '/bin/bash', 15:17:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4cXZIbxrMa/Listeners', 15:17:43 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 15:17:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:43 INFO - 'USER': 'cltbld', 15:17:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:43 INFO - 'XPC_FLAGS': '0x0', 15:17:43 INFO - 'XPC_SERVICE_NAME': '0', 15:17:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:44 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-hQQsoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17:44 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)) 15:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:44 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-bHD7HR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17:44 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)) 15:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:44 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-EhUjDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:44 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)) 15:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:44 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-6857at-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17:44 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)) 15:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:44 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-HyNT6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17:44 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)) 15:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:44 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-eyS2lG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17:44 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)) 15:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:44 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Jw1M1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17:44 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)) 15:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:44 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-seCDM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17:44 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)) 15:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:44 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-QN7BYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17:44 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)) 15:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-FhJ3YI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 15:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Y8FHju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17:45 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)) 15:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-R6ev4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17:45 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)) 15:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-4LAaCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17:45 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)) 15:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-dxxUoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17:45 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)) 15:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-xsjq7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:45 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)) 15:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-c0VdmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:45 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)) 15:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:45 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-aniBEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:45 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)) 15:17:45 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)) 15:17:45 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)) 15:17:45 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)) 15:17:45 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)) 15:17:45 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)) 15:17:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:17: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 15:17: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 15:17: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 15:17: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 15:17: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 15:17: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 15:17:48 INFO - Downloading blessings-1.6.tar.gz 15:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:17:48 INFO - Installing collected packages: blessings 15:17:48 INFO - Running setup.py install for blessings 15:17:48 INFO - Successfully installed blessings 15:17:48 INFO - Cleaning up... 15:17:48 INFO - Return code: 0 15:17:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:17:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:17:48 INFO - Reading from file tmpfile_stdout 15:17:48 INFO - Current package versions: 15:17:48 INFO - blessings == 1.6 15:17:48 INFO - blobuploader == 1.2.4 15:17:48 INFO - docopt == 0.6.1 15:17:48 INFO - functools32 == 3.2.3-2 15:17:48 INFO - jsonschema == 2.5.1 15:17:48 INFO - manifestparser == 1.1 15:17:48 INFO - mozInstall == 1.12 15:17:48 INFO - mozcrash == 0.17 15:17:48 INFO - mozdebug == 0.1 15:17:48 INFO - mozdevice == 0.48 15:17:48 INFO - mozfile == 1.2 15:17:48 INFO - mozhttpd == 0.7 15:17:48 INFO - mozinfo == 0.9 15:17:48 INFO - mozleak == 0.1 15:17:48 INFO - mozlog == 3.3 15:17:48 INFO - moznetwork == 0.27 15:17:48 INFO - mozprocess == 0.23 15:17:48 INFO - mozprofile == 0.28 15:17:48 INFO - mozrunner == 6.12 15:17:48 INFO - mozscreenshot == 0.1 15:17:48 INFO - mozsystemmonitor == 0.3 15:17:48 INFO - moztest == 0.7 15:17:48 INFO - mozversion == 1.4 15:17:48 INFO - psutil == 3.1.1 15:17:48 INFO - requests == 1.2.3 15:17:48 INFO - wsgiref == 0.1.2 15:17:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17: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')]} 15:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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')]} 15:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:48 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 0x106ad8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b6d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a956f0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a3cd30>, '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 0x1067a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a34b20>, '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.pV4jRG9jKB/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.4cXZIbxrMa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 15:17:48 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 15:17:48 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 15:17:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pV4jRG9jKB/Render', 15:17:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:48 INFO - 'HOME': '/Users/cltbld', 15:17:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:48 INFO - 'LOGNAME': 'cltbld', 15:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:48 INFO - 'MOZ_NO_REMOTE': '1', 15:17:48 INFO - 'NO_EM_RESTART': '1', 15:17:48 INFO - 'PAGER': '/bin/cat', 15:17:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:48 INFO - 'PWD': '/builds/slave/test', 15:17:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:48 INFO - 'SHELL': '/bin/bash', 15:17:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4cXZIbxrMa/Listeners', 15:17:48 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 15:17:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:48 INFO - 'USER': 'cltbld', 15:17:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:48 INFO - 'XPC_FLAGS': '0x0', 15:17:48 INFO - 'XPC_SERVICE_NAME': '0', 15:17:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:49 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)) 15:17:49 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)) 15:17:49 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)) 15:17:49 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)) 15:17:49 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)) 15:17:49 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)) 15:17:49 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)) 15:17:49 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)) 15:17:49 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)) 15:17:49 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)) 15:17:49 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)) 15:17:49 INFO - Cleaning up... 15:17:49 INFO - Return code: 0 15:17:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:17:49 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')]} 15:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:49 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')]} 15:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:49 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 0x106ad8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b6d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8a956f0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a3cd30>, '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 0x1067a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a34b20>, '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.pV4jRG9jKB/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.4cXZIbxrMa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 15:17:49 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 15:17:49 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 15:17:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pV4jRG9jKB/Render', 15:17:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:49 INFO - 'HOME': '/Users/cltbld', 15:17:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:49 INFO - 'LOGNAME': 'cltbld', 15:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:49 INFO - 'MOZ_NO_REMOTE': '1', 15:17:49 INFO - 'NO_EM_RESTART': '1', 15:17:49 INFO - 'PAGER': '/bin/cat', 15:17:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:49 INFO - 'PWD': '/builds/slave/test', 15:17:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:49 INFO - 'SHELL': '/bin/bash', 15:17:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4cXZIbxrMa/Listeners', 15:17:49 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 15:17:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:49 INFO - 'USER': 'cltbld', 15:17:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:49 INFO - 'XPC_FLAGS': '0x0', 15:17:49 INFO - 'XPC_SERVICE_NAME': '0', 15:17:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:17:49 INFO - Cleaning up... 15:17:49 INFO - Return code: 0 15:17:49 INFO - Running post-action listener: _resource_record_post_action 15:17:49 INFO - Running post-action listener: _start_resource_monitoring 15:17:49 INFO - Starting resource monitoring. 15:17:49 INFO - [mozharness: 2016-09-07 22:17:49.503987Z] Finished create-virtualenv step (success) 15:17:49 INFO - [mozharness: 2016-09-07 22:17:49.505018Z] Running install step. 15:17:49 INFO - Running pre-action listener: _resource_record_pre_action 15:17:49 INFO - Running main action method: install 15:17:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:17:49 INFO - Reading from file tmpfile_stdout 15:17:49 INFO - Detecting whether we're running mozinstall >=1.0... 15:17:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:17:49 INFO - Reading from file tmpfile_stdout 15:17:49 INFO - Output received: 15:17:49 INFO - Usage: mozinstall [options] installer 15:17:49 INFO - Options: 15:17:49 INFO - -h, --help show this help message and exit 15:17:49 INFO - -d DEST, --destination=DEST 15:17:49 INFO - Directory to install application into. [default: 15:17:49 INFO - "/builds/slave/test"] 15:17:49 INFO - --app=APP Application being installed. [default: firefox] 15:17:49 INFO - mkdir: /builds/slave/test/build/application 15:17:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:18:24 INFO - Reading from file tmpfile_stdout 15:18:24 INFO - Output received: 15:18:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:18:24 INFO - Running post-action listener: _resource_record_post_action 15:18:24 INFO - [mozharness: 2016-09-07 22:18:24.551711Z] Finished install step (success) 15:18:24 INFO - [mozharness: 2016-09-07 22:18:24.551840Z] Running run-tests step. 15:18:24 INFO - Running pre-action listener: _resource_record_pre_action 15:18:24 INFO - Running main action method: run_tests 15:18:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:18:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:18:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:18:24 INFO - 2016-09-07 15:18:24.564 screenresolution[1652:7524] starting screenresolution argv=screenresolution get 15:18:24 INFO - 2016-09-07 15:18:24.567 screenresolution[1652:7524] Display 0: 1600x1200x32@60 15:18:24 INFO - 2016-09-07 15:18:24.573 screenresolution[1653:7526] starting screenresolution argv=screenresolution list 15:18:24 INFO - Available Modes on Display 0 15:18:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:18:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:18:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:18:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:18:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:18:24 INFO - Intel Iris: 15:18:24 INFO - Chipset Model: Intel Iris 15:18:24 INFO - Type: GPU 15:18:24 INFO - Bus: Built-In 15:18:24 INFO - VRAM (Dynamic, Max): 1536 MB 15:18:24 INFO - Vendor: Intel (0x8086) 15:18:24 INFO - Device ID: 0x0a2e 15:18:24 INFO - Revision ID: 0x0009 15:18:24 INFO - Displays: 15:18:24 INFO - Display: 15:18:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:18:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:18:24 INFO - Display Serial Number: 1600x1200 60 15:18:24 INFO - Main Display: Yes 15:18:24 INFO - Mirror: Off 15:18:24 INFO - Online: Yes 15:18:24 INFO - Rotation: Supported 15:18:24 INFO - Return code: 0 15:18:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:18:24 INFO - Python 2.7.3 15:18:24 INFO - Return code: 0 15:18:24 INFO - grabbing minidump binary from tooltool 15:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:24 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 0x106a3cd30>, '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 0x1067a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a34b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:18:24 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 15:18:24 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 15:18:24 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 15:18:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:18:24 INFO - Return code: 0 15:18:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:18:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:18:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:18:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:18:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:18:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HJWCn7LmQhiNh140AjPWrg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0181', '--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 15:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HJWCn7LmQhiNh140AjPWrg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0181 --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 15:18:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pV4jRG9jKB/Render', 15:18:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:18:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:18:24 INFO - 'HOME': '/Users/cltbld', 15:18:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:18:24 INFO - 'LOGNAME': 'cltbld', 15:18:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:18:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:24 INFO - 'MOZ_NO_REMOTE': '1', 15:18:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:18:24 INFO - 'NO_EM_RESTART': '1', 15:18:24 INFO - 'PAGER': '/bin/cat', 15:18:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:24 INFO - 'PWD': '/builds/slave/test', 15:18:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:18:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:18:24 INFO - 'SHELL': '/bin/bash', 15:18:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4cXZIbxrMa/Listeners', 15:18:24 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 15:18:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:18:24 INFO - 'USER': 'cltbld', 15:18:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:18:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:24 INFO - 'XPC_FLAGS': '0x0', 15:18:24 INFO - 'XPC_SERVICE_NAME': '0', 15:18:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:18:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HJWCn7LmQhiNh140AjPWrg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0181', '--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 15:18:25 INFO - mozversion application_buildid: 20160907142316 15:18:25 INFO - mozversion application_changeset: ab70808cd4b6c6ad9a57a9f71cfa495fcea0aecd 15:18:25 INFO - mozversion application_display_name: Nightly 15:18:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:18:25 INFO - mozversion application_name: Firefox 15:18:25 INFO - mozversion application_remotingname: firefox 15:18:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:18:25 INFO - mozversion application_vendor: Mozilla 15:18:25 INFO - mozversion application_version: 51.0a1 15:18:25 INFO - mozversion platform_buildid: 20160907142316 15:18:25 INFO - mozversion platform_changeset: ab70808cd4b6c6ad9a57a9f71cfa495fcea0aecd 15:18:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:18:25 INFO - mozversion platform_version: 51.0a1 15:18:25 INFO - using testdate: 1473286705 15:18:25 INFO - actual date: 1473286705 15:18:25 INFO - starting webserver on 'localhost:49282' 15:18:25 INFO - SUITE-START | Running 2 tests 15:18:25 INFO - TEST-START | dromaeo_css 15:18:25 INFO - operating with platform_type : mac_ 15:18:25 INFO - Initialising browser for dromaeo_css test... 15:18:25 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpSUsvS2/profile http://localhost:49282/getInfo.html) 15:18:27 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 15:18:27 INFO - PROCESS | 1663 | colorDepth:24 15:18:27 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 15:18:27 INFO - PROCESS | 1663 | __metrics 15:18:27 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:18:27 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:18:28 INFO - TEST-INFO | 1663: exit 0 15:18:28 INFO - Browser initialized. 15:18:28 INFO - Running cycle 1/1 for dromaeo_css test... 15:18:28 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpSUsvS2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:18:40 INFO - PROCESS | 1665 | RSS: Main: 232497152 15:18:40 INFO - PROCESS | 1665 | 15:19:31 INFO - PROCESS | 1665 | 1473286771200 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] 15:21:44 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49282/tests/dromaeo/cssquery-ext.html) 15:21:45 INFO - PROCESS | 1665 | RSS: Main: 355332096 15:21:45 INFO - PROCESS | 1665 | 15:24:48 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-ext.html (next: http://localhost:49282/tests/dromaeo/cssquery-jquery.html) 15:24:49 INFO - PROCESS | 1665 | RSS: Main: 369676288 15:24:49 INFO - PROCESS | 1665 | 15:27:51 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49282/tests/dromaeo/cssquery-mootools.html) 15:27:52 INFO - PROCESS | 1665 | RSS: Main: 363032576 15:27:52 INFO - PROCESS | 1665 | 15:30:54 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49282/tests/dromaeo/cssquery-prototype.html) 15:30:55 INFO - PROCESS | 1665 | RSS: Main: 335597568 15:30:55 INFO - PROCESS | 1665 | 15:33:58 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49282/tests/dromaeo/cssquery-yui.html) 15:33:59 INFO - PROCESS | 1665 | RSS: Main: 326164480 15:33:59 INFO - PROCESS | 1665 | 15:37:02 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-yui.html (next: http://localhost:49282/tests/dromaeo/cssquery-dojo.html) 15:37:02 INFO - PROCESS | 1665 | RSS: Main: 423489536 15:37:02 INFO - PROCESS | 1665 | 15:37:02 INFO - PROCESS | 1665 | __start_tp_report 15:37:02 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 15:37:02 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 15:37:02 INFO - PROCESS | 1665 | |i|pagename|runs| 15:37:02 INFO - PROCESS | 1665 | |0;dojo.html;3316.204111013357;3318.170457385653;3353.798772073674;3386.2380964283057;3418.8290585470736;5538.9169162462595;5650;5670.206171136044;5728.22668939693;5744.281964754406;5680.431956804317;5733.397993210715;5733.426657334265;5751.338596061454;5760.8271751847515;5194.37667479902;5212.270282160501;5235.869103272411;5251.789928402859;5283.603729720267;5259.579233661317;5274.92087618686;5279.1817268323275;5283.313169287987;5287.709175995319;4509.346144809001;4910.75446227689;5191.402988656297;5251.107311756991;5286.286351342577;5313.017091838023;5329.094054010828;5329.22726204702;5345.224942383333;5388.1648344506275;5083.186690129599;5111.1566591512355;5164.096283150434;5233.162693968947;5248.317718696583;4778.450478195017;5705.515031222351;5734.369219385864;5735.254416925773;5811.099279611667;6281.026440901667;6300.87398252037;6304.369563043705;6307;6311.084892690534;5219.739013049332;6237.563370564062;6248.218972628421;6266.386211159089;6279.0895320178315;5828.941710582924;5829.679367634736;5833.212516310328;5835.94164058354;5884.999999999957;6296.307406185316;6296.992481202986;6301.558890877594;6307.747690092345;6314.431701146918;5997.670128142907;6043.898523920885;6093.6554992613665;6184.196054512884;6208.4722798562625;6209.782657606962;6276.403741644628;6287.182666253358;6295.905561416583;6315.179026726496;6179.567430279837;6258.405451482102;6276.968615156987;6278.121063051177;6294.118823364733;6093.111789665656;6119.380693981147;6127.00628053041;6276.184096067574;6295.055741638791;4892.0705066037335;4903.04390643821;4909.607231421478;4912.778924948386;4916.557509824133;4368.60682538573;4402.3836662867225;4405.3612226227015;4416;4456.955430445719;5673.5461163107675;5674.375818659944;5679.602427830012;5697.145428185805;5715.942840571624;6223.315435302113;6310.5898116622275;6337.081123237197;6337.302896681362;6349.714262858182;5535.806246781424;5561.721913904288;5607.186957891083;5646.096624540136;5652.717364131777;5412.512873841373;5421.5933804964;5425.972870135624;5464.863378415572;5469.753861076181;6263.217097862767;6295.496360291166;6302.212223472066;6304.71628776697;6316.747330106836;6122.459144589048;6195.659238741912;6242.937570624235;6303.432691057827;6307.211598550181;6265.216847894013;6275.905861412174;6295.276043255084;6295.590786599039;6300.873982520232;6192.566520343533;6194.442500175006;6195.473384762166;6199.597026193283;6202.2867370253;6115.6662951758;6120.081455037822;6202.038684003986;6290.0879372491645;6303.49572034227;5973.074173503114;6055.1522786809;6123.601965872204;6129.387061293835;6146.477549408351;4994.475580064186;5231.398389185292;6094.481969032682;6098.603590766586;6136.048912418582;5797.594168408171;5904.202932604044;5908.202392676933;5998.760049597967;6008;6138.419052470285;6153.661548614869;6153.907691384722;6167.198264225622;6186.690665466619;5941.197938278277;5959.612625179349;5980.820575382745;6011;6056 15:37:02 INFO - PROCESS | 1665 | |1;ext.html;500.91734863747496;506.7238355096472;507.13786562843154;522.3966318901668;534.17203334831;29719;39525;40702;40824.97937551559;42839;41881.37177942333;42323;42333.36499952503;42339.36490952638;42452.363214551806;9602.903970960271;9811.362261453018;9816.312858099936;9828.705138845846;9851.359661621971;9579.233661307113;9682.612695492171;9697.612095516206;9698.127168554829;9705.61177552897;9666.4200147991;9731.56207970643;9754.268429867789;9755.317127801056;9771.169450596708;9688.370255933378;9735.17251033663;9736.707898763048;9748.610055597768;9760.511974401252;9582.377145485521;9653.951730241373;9658.130768230892;9681.51592420376;9688.273379496495;40052.599474005176;40243.597564024276;40337.19325613471;40340.39489407661;40556.79721601403;2926.561015847619;3341.899743007714;3449.137715571107;3783.3000894834267;4137.1518838638;27562.44875102507;29205.123846284645;29651.366240414467;30935.38129237425;30950.53574196389;3148.795328303676;3196.6643502432144;3278.1804548862783;3331.5502407174963;3344.180675734436;502170;505063;505591;506138;508513;55593;55769.163462548095;55782.72108639512;56062.67404596557;56135;58932.41067589355;58979.41020589825;59044.704776475846;59087;59181;15402.768958465633;15612;15612.921935390477;15620.062796232263;15629.140397278032;11501.447304613937;12152.088593355533;12173.634790956285;12174.330411827257;12201.938990305169;14010.649733756534;14532.0554163979;15178;15197.468088616846;15359.385624575116;4697.989932164601;4898.775306173457;5106.310648062538;5317.4741997550855;5329.9467005330225;829.3655353654459;936.3352020065694;940.520334629344;988.6885631026204;1038.444432228769;28697.713022869502;28706.569401458994;29444.705552944197;29454.969076082234;29542.556861647092;924.0666926404245;1006.5118417567473;1018.3482571154467;1034.281174583657;1063.5692544519482;13325.333733313295;13712;14851.925740371229;14913.478028268959;15318.770218446733;679540;685970;690932.5453372701;691164;692171;56835.43164568384;57160.142597861064;57161;57192;57244.427555724746;1187.0058302052635;1260.533602567056;1280.187081203424;1343.9664008399868;1382.0601990646458;29341.55987660144;30546;30616.31012705642;31063.534046989764;31388.68611313949;47309.29036064393;47725;47775.5222447785;47834.76082619565;47991;552027;552885;553874;554294;659735;21143.57712845765;23603.763962360157;25005;25061.498770024133;25168;39891.80054099711;41249.79375103225;44194;44777.77611111924;45751.738550067166;37007.6299237015;37105;37637.24725505529;37699.43450848185;38092.619073808906;36185.81907090553;36828;37496.62503374931;37608.43587346137;37916.24167516689;35537.75617853363;35976.57376380894;36509.45235821412;36701.44947825732;36788.63211367959;31334.793861806622;32621.021369358958;32975.50536741903;33054.50418243776;33339.1665208362;23696.593261810627;24464.716075448014;24587.75412245926;24779.752202477743;25181 15:37:02 INFO - PROCESS | 1665 | |2;jquery.html;347.8191340502937;362.673593765611;373.328009582751;375.4987092231871;401.53622565936337;14612;15323.84676153238;19786.802131978675;20515.97420128995;20517.794822051776;19970.201191952303;20299.898500507476;20334.98325083747;20389;20414.69377959328;4112.938305925413;5793.855153621172;6064.636121832682;6065.2721673399255;6066.120412540179;5046.318746969149;6602.986089242779;6686.866262674744;6755.9662201688925;6759.256481787;6184.536159788011;6641.1034510341215;6692.096566963471;6695.765648202314;6708.195016598015;6407.359264073602;6679.866402671943;6694.765683201064;6708.66456677169;6718.6304753238555;5650.576206784508;5777.19119323295;5787.594868359217;5810.941890581083;5817.7091145442555;23636.645450318087;24989.87545560436;25215.28350451051;25737.97048118073;26148.86925565379;2370.134900761227;2466.4450498637843;2801.2856721535877;2918.9562156567667;3056.327607926275;15339.693206135926;15370;15843.920780396023;15884.823035392852;16125.193740313054;1544.8799620275322;1595.664910368824;1876.193236908129;1880.8683392162554;1920.9039548022683;89860;106150;106501.99999999923;114816.85183148229;116921.8307816928;10314.535845886952;10334.17326613869;10366.170706343626;10432.843507347396;10749;13471.461141554424;13476.326183690971;13496.190228586316;13497.662558436117;13507.662308442172;8253.463524870864;8394.118617545191;8407.159284071666;8442.366822488339;8578.871316930252;8430.704925327584;8445.788855278544;8634.050254472004;8640.179182977607;8643.3949623527;6464.573775898782;6574.441172500391;6579.901301480481;6586.901196482057;6588;1575.9606009849845;1778.6175972166047;1858.1916866163263;1864.7762268527863;1866.216189200539;867.9175478329548;872.8385248728879;912.4251721415466;937.1425145991342;970.6311601591491;21842;22546.661800073012;22710.432239193822;22768.772312276666;22841.7715822843;930.3208657679932;948.9667861624948;955.2071780422233;994.4878387630376;1001.5242759689235;11428.142889283337;11675.241109327866;11751.529938802352;11806.291622502677;11811.527538898348;520040;536599;540939;550294;555740;93943.53028234815;100777.49611252043;108063;108343.45828270809;110501.89498105076;875.6147295190096;995.6714284286168;1025.7640742629237;1058.9841152382721;1062.102523367753;18676.43970680882;19781;20010.89994550076;20032.799672003093;20055.59888802245;49056.77358065934;50583.22958696428;52208.73895630497;53776;54609.45390546044;71620;73429.8985515207;75175.87236191353;75287.87068194091;75428;6413.583117097373;6996.790096297119;7597.544147351176;7880.17258187882;8060.596970151586;13264.602061938158;13269.40287687037;13471.595852124452;13543.25512096844;13647.38586763618;11306.547738090714;11450.885491145315;11704.590339338083;11739.882601173878;11806.704832379259;11385.373804440504;11436.94281528587;11529.365884876412;11567.421628918688;11947.10396720232;11426.714332141762;11591.420428978348;11723;11776.175667703179;11950.641480755592;7880.566568838769;7923.84152316962;7959.482633628795;8000.5599692017495;8034.919650803417;11274.718132046437;11341.825161403029;11604.593839215588;11741.530338786695;11827.586034488751 15:37:02 INFO - PROCESS | 1665 | |3;mootools.html;1493.2608358862365;1531.1655147944368;1708.957276068098;1803.720423334382;1891.6595012897674;7919.920800791991;8207.138250483702;8394.62224199911;8819.823603527933;8822.426542274756;8404.91595084049;8713.346499012583;8733.03936566977;8809.38334316598;8818.514981676006;2341.098677009351;2376.691030166076;2382.5354055959097;2388.450656349041;2389.665446837444;2089.5298557824444;2175.760666326703;2339.543788961153;2373.52529494101;2396.101461951768;2290.599145149592;2375.58427275227;2378.4529558201625;2382.940426489334;2384.213209640823;2072.4611600983853;2346.894389752465;2366.1363602285214;2380.678608387863;2386.2364043506086;2342.4143964009;2363.291012696184;2368.348704106367;2377.298696884406;2383.249276477904;8629;8830.86753698695;8836.823263534758;8837.65802062454;8843.380963332569;5213.7393130343335;5361.865953351158;5363.195520671891;5368.8389348319615;5390.78436862525;3524.823758812049;3671.118931456458;3723.7765734056043;3728.6830619397383;3744.9063773405883;967.3035414501547;1050.5548705302097;1094.584058057933;1115.5147510832815;1119.7928383249125;10195.694129176136;11596.884031159665;11645.592404265895;11670.416479176092;11687.883121168765;4421.712588681726;4715;4791.281307803857;4796.304535842283;4801.95198048022;9841.901580984098;9846.803063938825;9861.457619830835;9869.358491698016;9872.160866326443;5334.813281535127;5335.866603334947;5337.51962323385;5347.545458635982;5361.839144825662;4654.232051711429;4821.059893320768;4885.291632713237;4887.804487820447;4889.339939108175;3810.9047273817823;3824.2160357126722;3879.398693202502;3927.290169782898;3946.980265098656;1058.8305871060747;1088.357868857378;1176.847009888709;1196.9281843089443;1236.6351926181799;832.887560179368;865.7662431143556;872.7774417523618;902.6795487601806;952.9571169297399;5372.758225879845;5633.436656334334;5771.509421699203;5860.882782344329;5907.084401917709;925.5279807298192;939.6147579492375;955.8231727130503;958.8945216026232;996.8704068471052;3783.3379158647676;3810.0855794609647;3860.4981352424006;3874.1984976985837;3959.6436320731273;10357.896421035693;10586.20603454744;10699.732506687395;10703.983121603434;10712.517936692868;10624.043836054792;10632.734181645366;10636.095931845724;10639.361638301727;10649.307794993456;7261.491695581259;8027.879581806161;8071.515709057476;8123;8177.509349438934;5681.147827825694;5770.307563092456;5869.239228231428;5876.500497457593;5933.2880054393745;9441.622335106793;9704.854427183456;9921.851172232278;9989.800203996025;10014.298999070286;9812.950935245279;10044.849327259952;10213.693589192337;10218.948905255425;10232.334898231591;7193.892091618525;7365.8158546036775;7398.260173982559;7458.7250888477365;7515.962420187864;8188.05837328691;8245.299149572353;8256.504609723435;8270.958645206736;8273.503589784632;7228.710851566088;7347.595882226529;7370.152432470334;7444.330010299099;7571.242875712384;7130.2869713028285;7211;7215.062041934515;7239.8914016290855;7272.23641517633;6781.525293229427;6911.308869113049;6917.100776898971;6919.619420931897;6927.792166234819;4852.393450818648;4958.727270000185;4971.875703107451;4976.850694479172;5028.421731500778;4842.225243960949;4954.405471343462;5050.444451110301;5081.4918508148885;5126.820561280338 15:37:02 INFO - PROCESS | 1665 | |4;prototype.html;296.79372835879064;297.166448113043;304.7501049139705;310.9984450077752;311.5747005337715;5029.346184995946;5229.372475302965;5242.528172464482;5257.684538927667;5321.946780532194;5026.597872170227;5079.415867175276;5137;5143.202803565444;5269.1832765921245;3502.7898326100517;3996.3006473867104;4007.158496715693;4018.4976877890263;4023.6579890709327;3416.367971925202;3667.174885650734;3759.762941050071;3843.673287770529;4054.351303791394;3778.5465744110747;3817.244067728834;3982.980085099585;4026.255142798577;4064.9431147901464;3375.443051896434;3815.8855234343014;3975.7813320267373;3977.6420122189143;3993.6605388542152;3192.350349210173;3299.9175020624675;3474.0793689672255;3509.5613048368955;3566.4828599853136;4388.8933312010095;4818.542238487338;5061.810474538481;5104.489551044903;5161.664491808058;4522.163399771053;4538.591526762574;4596.3105534170145;4600.838970636045;4615.561521655471;4954.157793175169;5266.4470230626;5384.04272859448;5442.71406009477;5493.807716729895;3026.7275945165043;3164.699353561431;3729.4778730977414;3729.4778730977687;3839.9424008639894;4745.383100196952;5459.672419654794;5663.830085097454;5706.942930570683;5712.228849105318;3195.2331440454122;3203.583534140547;3763.8870833875026;3778.6977041836585;3804.029972357031;3372.274960883422;3439.8476510368805;3847.2305538892333;3860.5560360558334;3868.3037053330672;4178.770167640809;4415.880377418857;4489.753063581469;4500.459944806644;4536.274196128604;5508.3114610673665;5576.888462230732;5583.3858275589655;5615.803446879339;5662.716864156776;1240.6526172671665;1265.8797414245632;1284.1717092475487;1309.2733532889147;1311.1084462565357;728.1880703016099;857.5455008845322;868.9304855611535;873.6854732296368;891.2558014058334;4453.287474004209;4501.167284052461;5021.493551934405;5021.824236151717;5033.672811267256;5531.363893152258;5557.72211389437;5569.777208911679;5570.38192049736;5577.972110139423;4077.2864748668862;4691.296305554194;4699.95300047002;4771.729302274445;4794.640401969867;2133.5626196629655;2421.9152329668727;2427.381017840439;2438.317271164077;2446.9877650611634;4061.817218225187;4083.5916408358926;4092.693048021351;4611.608013318838;4820.975895120572;4185.811638476276;4457.013800753503;4547.681662283675;4720.433547974265;4776.14029474691;4263.531011588785;4386.342048692658;4690.554397332248;4801.45522872878;4949.010197960422;4220.345846393814;4248.63886569645;4636.930446043245;4663.743494107856;4811.591014763784;3872.5865059253733;4536.138133754708;4587.4036375271;4593;4627.375304333872;4270.142488017722;4351.717138386121;4355.390245365588;4805.342156955845;4837.467878533429;2936.3540021195304;3032.7877048606388;3045.375697981864;3203.5194720791137;3250.6749325067303;4029.899252518593;4250.128723611714;4611.331356953156;4623;4634.4670362907345;4580.65645076614;4906.411230652345;5119.080344870674;5463.371712252982;5514.834554963358;4229.492460904711;5119.385673719029;5429.945700542944;5456.42707515721;5518.530924871431;5173.508516690908;5269.051570717308;5334.813281535127;5393.9730301348245;5397.244385785914;5110.97444512775;5414.485623865727;5434.429384914685;5475.616706830484;5488.91766623493;5308.814191503279;5333.43998880112;5338.733063346895;5339.2647389599315;5433.5924805640525 15:37:02 INFO - PROCESS | 1665 | |5;yui.html;688.7107414885747;732.4653003307585;747.506645613895;797.876329168979;809.6963638635511;15176.089434633916;16237.431689890827;16266.942648727825;16272.186390680477;16367.754483682755;14632.707345853076;14781.852181478182;14789.038712483682;14811.333489992949;14811.407543698266;680.4964326398455;700.9614471204081;702.115334678304;703.8381172330367;842.9915700843005;675.2403546010738;675.3887731602907;832.9791755206107;859.0121360435487;861.4228466927174;883.1609970527992;892.2371372476537;895.2971917045121;895.6193617712479;895.9417637853551;891.5987805487491;892.1791951404723;892.6340200517822;892.7544925145572;896.708569714842;658.4929604204783;659.2550418027646;659.4658326755343;660.4947215380238;663.0154220981838;11904.821427678591;14580.416783328654;14723.337449814677;14826.62933426673;15467.381304747796;14166.92916535421;14686.853131468655;14749.926250368679;14864.108153510824;14899.255037248095;11895.88104118965;11905.702357441134;11925.582604608797;11965.581204657796;12235.265884046985;3850.6726928211137;3872.7289089763726;3905.902352441183;3923.0780766519847;4021.7586944783407;105938.47030764873;121313;124626.37686811599;125801.27484064492;127707.3614631921;11272.705568708652;11273.969528464073;11320.26418282809;11354.637443506832;11654;23084.19205327839;23347.299581012598;23404.829758512005;23413.297601071994;23790;8113.797155071171;8168.469049511763;8171.428000040059;8210.178982101861;8308.70919517814;4496.437945256843;4611.838585649486;4672.439307283148;4777.355057067321;4783.880402989953;3311.403947289511;3342.298117395374;3394.660533946635;3424.007037959014;3433.210361616842;665.7337065173872;671.8219671786981;681.9283975182634;690.5442408010689;692.1901375390805;544.9239045587635;559.6977632078632;560.3220103674518;582.8222392170429;675.2167485716545;8672.60973256205;8810.603522841488;9200.171984521425;9394.389364691273;9408.623655053721;558.6648011193333;611.9541034422436;657.2934095846888;666.1107421592228;675.0684056002685;4529.773511324421;4565.429321334833;4565.771711414416;4585.79363928624;4593.701409408378;160126.19936900475;162477;166246;168598.47102293474;171694;138388.30805845905;140646;142272;142720;145126;119007;119732.20401693981;123348;123806;126187.73812261944;8822.338324625807;8846.778830529289;8896.929813661283;8901.465912045298;9052.592633331384;58511.70744146252;59624.99999999827;65791.35521611998;68186.65906670435;70107.64946175237;64705;65539.01691474728;66396;85452;96371.51814240884;13191.208527488381;13260.0045872016;13305.66735831612;13316.201027938354;13827.308634568433;14300;14812.925935370255;14818.777718334019;15283.46507872219;15350.616234594225;13832.585022449342;13922.303884805922;14115.153090814583;14367.425302988182;14724.411023559365;13634.590962271148;13940.512082077079;14036.719265614835;14593.781093283822;14667.413303468169;13490.76026292943;13659;13793.931030345186;13800.723985520433;13827.51603693866;9605.47169905634;10404.583816647551;11142.331460112095;11425.428728563706;11999.940000299943;10789.244752867538;11370.830046629484;11560.768784624428;11571.594994175164;11798.292102473879 15:37:02 INFO - PROCESS | 1665 | __end_tp_report 15:37:02 INFO - PROCESS | 1665 | __start_cc_report 15:37:02 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1136 15:37:02 INFO - PROCESS | 1665 | __end_cc_report 15:37:02 INFO - PROCESS | 1665 | __startTimestamp1473287822777__endTimestamp 15:37:02 INFO - PROCESS | 1665 | 15:37:02 INFO - PROCESS | 1665 | ------- Summary: start ------- 15:37:02 INFO - PROCESS | 1665 | Number of tests: 6 15:37:02 INFO - PROCESS | 1665 | 15:37:02 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5731.10 Median:5959.61 stddev:655.20 (11.0%) stddev-sans-first:629.22 15:37:02 INFO - PROCESS | 1665 | Values: 3316.2 3318.2 3353.8 3386.2 3418.8 5538.9 5650.0 5670.2 5728.2 5744.3 5680.4 5733.4 5733.4 5751.3 5760.8 5194.4 5212.3 5235.9 5251.8 5283.6 5259.6 5274.9 5279.2 5283.3 5287.7 4509.3 4910.8 5191.4 5251.1 5286.3 5313.0 5329.1 5329.2 5345.2 5388.2 5083.2 5111.2 5164.1 5233.2 5248.3 4778.5 5705.5 5734.4 5735.3 5811.1 6281.0 6300.9 6304.4 6307.0 6311.1 5219.7 6237.6 6248.2 6266.4 6279.1 5828.9 5829.7 5833.2 5835.9 5885.0 6296.3 6297.0 6301.6 6307.7 6314.4 5997.7 6043.9 6093.7 6184.2 6208.5 6209.8 6276.4 6287.2 6295.9 6315.2 6179.6 6258.4 6277.0 6278.1 6294.1 6093.1 6119.4 6127.0 6276.2 6295.1 4892.1 4903.0 4909.6 4912.8 4916.6 4368.6 4402.4 4405.4 4416.0 4457.0 5673.5 5674.4 5679.6 5697.1 5715.9 6223.3 6310.6 6337.1 6337.3 6349.7 5535.8 5561.7 5607.2 5646.1 5652.7 5412.5 5421.6 5426.0 5464.9 5469.8 6263.2 6295.5 6302.2 6304.7 6316.7 6122.5 6195.7 6242.9 6303.4 6307.2 6265.2 6275.9 6295.3 6295.6 6300.9 6192.6 6194.4 6195.5 6199.6 6202.3 6115.7 6120.1 6202.0 6290.1 6303.5 5973.1 6055.2 6123.6 6129.4 6146.5 4994.5 5231.4 6094.5 6098.6 6136.0 5797.6 5904.2 5908.2 5998.8 6008.0 6138.4 6153.7 6153.9 6167.2 6186.7 5941.2 5959.6 5980.8 6011.0 6056.0 15:37:02 INFO - PROCESS | 1665 | 15:37:02 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:70971.51 Median:40448.60 stddev:159324.57 (393.9%) stddev-sans-first:159683.66 15:37:02 INFO - PROCESS | 1665 | Values: 500.9 506.7 507.1 522.4 534.2 29719.0 39525.0 40702.0 40825.0 42839.0 41881.4 42323.0 42333.4 42339.4 42452.4 9602.9 9811.4 9816.3 9828.7 9851.4 9579.2 9682.6 9697.6 9698.1 9705.6 9666.4 9731.6 9754.3 9755.3 9771.2 9688.4 9735.2 9736.7 9748.6 9760.5 9582.4 9654.0 9658.1 9681.5 9688.3 40052.6 40243.6 40337.2 40340.4 40556.8 2926.6 3341.9 3449.1 3783.3 4137.2 27562.4 29205.1 29651.4 30935.4 30950.5 3148.8 3196.7 3278.2 3331.6 3344.2 502170.0 505063.0 505591.0 506138.0 508513.0 55593.0 55769.2 55782.7 56062.7 56135.0 58932.4 58979.4 59044.7 59087.0 59181.0 15402.8 15612.0 15612.9 15620.1 15629.1 11501.4 12152.1 12173.6 12174.3 12201.9 14010.6 14532.1 15178.0 15197.5 15359.4 4698.0 4898.8 5106.3 5317.5 5329.9 829.4 936.3 940.5 988.7 1038.4 28697.7 28706.6 29444.7 29455.0 29542.6 924.1 1006.5 1018.3 1034.3 1063.6 13325.3 13712.0 14851.9 14913.5 15318.8 679540.0 685970.0 690932.5 691164.0 692171.0 56835.4 57160.1 57161.0 57192.0 57244.4 1187.0 1260.5 1280.2 1344.0 1382.1 29341.6 30546.0 30616.3 31063.5 31388.7 47309.3 47725.0 47775.5 47834.8 47991.0 552027.0 552885.0 553874.0 554294.0 659735.0 21143.6 23603.8 25005.0 25061.5 25168.0 39891.8 41249.8 44194.0 44777.8 45751.7 37007.6 37105.0 37637.2 37699.4 38092.6 36185.8 36828.0 37496.6 37608.4 37916.2 35537.8 35976.6 36509.5 36701.4 36788.6 31334.8 32621.0 32975.5 33054.5 33339.2 23696.6 24464.7 24587.8 24779.8 25181.0 15:37:02 INFO - PROCESS | 1665 | 15:37:02 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:32626.82 Median:25102.58 stddev:89855.21 (358.0%) stddev-sans-first:90074.59 15:37:02 INFO - PROCESS | 1665 | Values: 347.8 362.7 373.3 375.5 401.5 14612.0 15323.8 19786.8 20516.0 20517.8 19970.2 20299.9 20335.0 20389.0 20414.7 4112.9 5793.9 6064.6 6065.3 6066.1 5046.3 6603.0 6686.9 6756.0 6759.3 6184.5 6641.1 6692.1 6695.8 6708.2 6407.4 6679.9 6694.8 6708.7 6718.6 5650.6 5777.2 5787.6 5810.9 5817.7 23636.6 24989.9 25215.3 25738.0 26148.9 2370.1 2466.4 2801.3 2919.0 3056.3 15339.7 15370.0 15843.9 15884.8 16125.2 1544.9 1595.7 1876.2 1880.9 1920.9 89860.0 106150.0 106502.0 114816.9 116921.8 10314.5 10334.2 10366.2 10432.8 10749.0 13471.5 13476.3 13496.2 13497.7 13507.7 8253.5 8394.1 8407.2 8442.4 8578.9 8430.7 8445.8 8634.1 8640.2 8643.4 6464.6 6574.4 6579.9 6586.9 6588.0 1576.0 1778.6 1858.2 1864.8 1866.2 867.9 872.8 912.4 937.1 970.6 21842.0 22546.7 22710.4 22768.8 22841.8 930.3 949.0 955.2 994.5 1001.5 11428.1 11675.2 11751.5 11806.3 11811.5 520040.0 536599.0 540939.0 550294.0 555740.0 93943.5 100777.5 108063.0 108343.5 110501.9 875.6 995.7 1025.8 1059.0 1062.1 18676.4 19781.0 20010.9 20032.8 20055.6 49056.8 50583.2 52208.7 53776.0 54609.5 71620.0 73429.9 75175.9 75287.9 75428.0 6413.6 6996.8 7597.5 7880.2 8060.6 13264.6 13269.4 13471.6 13543.3 13647.4 11306.5 11450.9 11704.6 11739.9 11806.7 11385.4 11436.9 11529.4 11567.4 11947.1 11426.7 11591.4 11723.0 11776.2 11950.6 7880.6 7923.8 7959.5 8000.6 8034.9 11274.7 11341.8 11604.6 11741.5 11827.6 15:37:02 INFO - PROCESS | 1665 | 15:37:02 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5665.12 Median:5039.43 stddev:3154.41 (62.6%) stddev-sans-first:3147.68 15:37:02 INFO - PROCESS | 1665 | Values: 1493.3 1531.2 1709.0 1803.7 1891.7 7919.9 8207.1 8394.6 8819.8 8822.4 8404.9 8713.3 8733.0 8809.4 8818.5 2341.1 2376.7 2382.5 2388.5 2389.7 2089.5 2175.8 2339.5 2373.5 2396.1 2290.6 2375.6 2378.5 2382.9 2384.2 2072.5 2346.9 2366.1 2380.7 2386.2 2342.4 2363.3 2368.3 2377.3 2383.2 8629.0 8830.9 8836.8 8837.7 8843.4 5213.7 5361.9 5363.2 5368.8 5390.8 3524.8 3671.1 3723.8 3728.7 3744.9 967.3 1050.6 1094.6 1115.5 1119.8 10195.7 11596.9 11645.6 11670.4 11687.9 4421.7 4715.0 4791.3 4796.3 4802.0 9841.9 9846.8 9861.5 9869.4 9872.2 5334.8 5335.9 5337.5 5347.5 5361.8 4654.2 4821.1 4885.3 4887.8 4889.3 3810.9 3824.2 3879.4 3927.3 3947.0 1058.8 1088.4 1176.8 1196.9 1236.6 832.9 865.8 872.8 902.7 953.0 5372.8 5633.4 5771.5 5860.9 5907.1 925.5 939.6 955.8 958.9 996.9 3783.3 3810.1 3860.5 3874.2 3959.6 10357.9 10586.2 10699.7 10704.0 10712.5 10624.0 10632.7 10636.1 10639.4 10649.3 7261.5 8027.9 8071.5 8123.0 8177.5 5681.1 5770.3 5869.2 5876.5 5933.3 9441.6 9704.9 9921.9 9989.8 10014.3 9813.0 10044.8 10213.7 10218.9 10232.3 7193.9 7365.8 7398.3 7458.7 7516.0 8188.1 8245.3 8256.5 8271.0 8273.5 7228.7 7347.6 7370.2 7444.3 7571.2 7130.3 7211.0 7215.1 7239.9 7272.2 6781.5 6911.3 6917.1 6919.6 6927.8 4852.4 4958.7 4971.9 4976.9 5028.4 4842.2 4954.4 5050.4 5081.5 5126.8 15:37:02 INFO - PROCESS | 1665 | 15:37:02 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:4187.61 Median:4590.20 stddev:1290.39 (28.1%) stddev-sans-first:1260.53 15:37:02 INFO - PROCESS | 1665 | Values: 296.8 297.2 304.8 311.0 311.6 5029.3 5229.4 5242.5 5257.7 5321.9 5026.6 5079.4 5137.0 5143.2 5269.2 3502.8 3996.3 4007.2 4018.5 4023.7 3416.4 3667.2 3759.8 3843.7 4054.4 3778.5 3817.2 3983.0 4026.3 4064.9 3375.4 3815.9 3975.8 3977.6 3993.7 3192.4 3299.9 3474.1 3509.6 3566.5 4388.9 4818.5 5061.8 5104.5 5161.7 4522.2 4538.6 4596.3 4600.8 4615.6 4954.2 5266.4 5384.0 5442.7 5493.8 3026.7 3164.7 3729.5 3729.5 3839.9 4745.4 5459.7 5663.8 5706.9 5712.2 3195.2 3203.6 3763.9 3778.7 3804.0 3372.3 3439.8 3847.2 3860.6 3868.3 4178.8 4415.9 4489.8 4500.5 4536.3 5508.3 5576.9 5583.4 5615.8 5662.7 1240.7 1265.9 1284.2 1309.3 1311.1 728.2 857.5 868.9 873.7 891.3 4453.3 4501.2 5021.5 5021.8 5033.7 5531.4 5557.7 5569.8 5570.4 5578.0 4077.3 4691.3 4700.0 4771.7 4794.6 2133.6 2421.9 2427.4 2438.3 2447.0 4061.8 4083.6 4092.7 4611.6 4821.0 4185.8 4457.0 4547.7 4720.4 4776.1 4263.5 4386.3 4690.6 4801.5 4949.0 4220.3 4248.6 4636.9 4663.7 4811.6 3872.6 4536.1 4587.4 4593.0 4627.4 4270.1 4351.7 4355.4 4805.3 4837.5 2936.4 3032.8 3045.4 3203.5 3250.7 4029.9 4250.1 4611.3 4623.0 4634.5 4580.7 4906.4 5119.1 5463.4 5514.8 4229.5 5119.4 5429.9 5456.4 5518.5 5173.5 5269.1 5334.8 5394.0 5397.2 5111.0 5414.5 5434.4 5475.6 5488.9 5308.8 5333.4 5338.7 5339.3 5433.6 15:37:02 INFO - PROCESS | 1665 | 15:37:02 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:26108.46 Median:3368.48 stddev:42984.78 (1276.1%) stddev-sans-first:43062.99 15:37:02 INFO - PROCESS | 1665 | Values: 688.7 732.5 747.5 797.9 809.7 15176.1 16237.4 16266.9 16272.2 16367.8 14632.7 14781.9 14789.0 14811.3 14811.4 680.5 701.0 702.1 703.8 843.0 675.2 675.4 833.0 859.0 861.4 883.2 892.2 895.3 895.6 895.9 891.6 892.2 892.6 892.8 896.7 658.5 659.3 659.5 660.5 663.0 11904.8 14580.4 14723.3 14826.6 15467.4 14166.9 14686.9 14749.9 14864.1 14899.3 11895.9 11905.7 11925.6 11965.6 12235.3 3850.7 3872.7 3905.9 3923.1 4021.8 105938.5 121313.0 124626.4 125801.3 127707.4 11272.7 11274.0 11320.3 11354.6 11654.0 23084.2 23347.3 23404.8 23413.3 23790.0 8113.8 8168.5 8171.4 8210.2 8308.7 4496.4 4611.8 4672.4 4777.4 4783.9 3311.4 3342.3 3394.7 3424.0 3433.2 665.7 671.8 681.9 690.5 692.2 544.9 559.7 560.3 582.8 675.2 8672.6 8810.6 9200.2 9394.4 9408.6 558.7 612.0 657.3 666.1 675.1 4529.8 4565.4 4565.8 4585.8 4593.7 160126.2 162477.0 166246.0 168598.5 171694.0 138388.3 140646.0 142272.0 142720.0 145126.0 119007.0 119732.2 123348.0 123806.0 126187.7 8822.3 8846.8 8896.9 8901.5 9052.6 58511.7 59625.0 65791.4 68186.7 70107.6 64705.0 65539.0 66396.0 85452.0 96371.5 13191.2 13260.0 13305.7 13316.2 13827.3 14300.0 14812.9 14818.8 15283.5 15350.6 13832.6 13922.3 14115.2 14367.4 14724.4 13634.6 13940.5 14036.7 14593.8 14667.4 13490.8 13659.0 13793.9 13800.7 13827.5 9605.5 10404.6 11142.3 11425.4 11999.9 10789.2 11370.8 11560.8 11571.6 11798.3 15:37:02 INFO - PROCESS | 1665 | -------- Summary: end -------- 15:37:02 INFO - PROCESS | 1665 | 15:37:03 INFO - TEST-INFO | 1665: exit 0 15:37:03 INFO - TEST-OK | dromaeo_css | took 1118194ms 15:37:03 INFO - TEST-START | kraken 15:37:03 INFO - operating with platform_type : mac_ 15:37:03 INFO - Initialising browser for kraken test... 15:37:03 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpmKBhxM/profile http://localhost:49282/getInfo.html) 15:37:05 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 15:37:05 INFO - PROCESS | 1676 | colorDepth:24 15:37:05 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 15:37:05 INFO - PROCESS | 1676 | __metrics 15:37:05 INFO - PROCESS | 1676 | 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" 15:37:05 INFO - PROCESS | 1676 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:37:06 INFO - TEST-INFO | 1676: exit 0 15:37:06 INFO - Browser initialized. 15:37:06 INFO - Running cycle 1/1 for kraken test... 15:37:06 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpmKBhxM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:37:18 INFO - PROCESS | 1677 | RSS: Main: 232382464 15:37:18 INFO - PROCESS | 1677 | 15:37:21 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection) 15:37:21 INFO - PROCESS | 1677 | RSS: Main: 291360768 15:37:21 INFO - PROCESS | 1677 | 15:37:24 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-dft) 15:37:25 INFO - PROCESS | 1677 | RSS: Main: 288374784 15:37:25 INFO - PROCESS | 1677 | 15:37:28 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-fft) 15:37:29 INFO - PROCESS | 1677 | RSS: Main: 377917440 15:37:29 INFO - PROCESS | 1677 | 15:37:31 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator) 15:37:31 INFO - PROCESS | 1677 | RSS: Main: 279838720 15:37:31 INFO - PROCESS | 1677 | 15:37:34 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:37:34 INFO - PROCESS | 1677 | RSS: Main: 283738112 15:37:34 INFO - PROCESS | 1677 | 15:37:37 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom) 15:37:38 INFO - PROCESS | 1677 | RSS: Main: 322781184 15:37:38 INFO - PROCESS | 1677 | 15:37:40 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate) 15:37:41 INFO - PROCESS | 1677 | RSS: Main: 321687552 15:37:41 INFO - PROCESS | 1677 | 15:37:44 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial) 15:37:45 INFO - PROCESS | 1677 | RSS: Main: 321327104 15:37:45 INFO - PROCESS | 1677 | 15:37:46 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:37:47 INFO - PROCESS | 1677 | RSS: Main: 297455616 15:37:47 INFO - PROCESS | 1677 | 15:37:49 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:37:49 INFO - PROCESS | 1677 | RSS: Main: 303435776 15:37:49 INFO - PROCESS | 1677 | 15:37:51 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:37:52 INFO - PROCESS | 1677 | RSS: Main: 307900416 15:37:52 INFO - PROCESS | 1677 | 15:37:55 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:37:56 INFO - PROCESS | 1677 | RSS: Main: 313876480 15:37:56 INFO - PROCESS | 1677 | 15:37:59 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:37:59 INFO - PROCESS | 1677 | RSS: Main: 316444672 15:37:59 INFO - PROCESS | 1677 | 15:38:01 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49282/tests/kraken/driver.html?testName=ai-astar) 15:38:01 INFO - PROCESS | 1677 | RSS: Main: 359923712 15:38:01 INFO - PROCESS | 1677 | 15:38:01 INFO - PROCESS | 1677 | __start_tp_report 15:38:01 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 15:38:01 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 15:38:01 INFO - PROCESS | 1677 | |i|pagename|runs| 15:38:01 INFO - PROCESS | 1677 | |0;ai-astar;112;114;116;111;114;113;113;115;114;124 15:38:01 INFO - PROCESS | 1677 | |1;audio-beat-detection;147;113;141;160;108;128;140;135;197;109 15:38:01 INFO - PROCESS | 1677 | |2;audio-dft;183;184;185;183;184;183;182;184;183;182 15:38:01 INFO - PROCESS | 1677 | |3;audio-fft;77;74;78;154;58;58;58;67;138;58 15:38:01 INFO - PROCESS | 1677 | |4;audio-oscillator;82;83;133;69;75;92;116;68;70;114 15:38:01 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;90;87;89;87;89;86;88;87;89;129 15:38:01 INFO - PROCESS | 1677 | |6;imaging-darkroom;96;99;96;96;96;96;96;95;97;97 15:38:01 INFO - PROCESS | 1677 | |7;imaging-desaturate;86;86;84;84;84;84;85;85;84;93 15:38:01 INFO - PROCESS | 1677 | |8;json-parse-financial;54;53;56;54;54;55;55;54;53;55 15:38:01 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;67;67;71;70;75;78;71;69;69;71 15:38:01 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;88;86;86;86;84;85;83;75;90;95 15:38:01 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;158;161;131;152;140;145;145;149;238;137 15:38:01 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;169;170;168;170;166;168;168;167;170;168 15:38:01 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;65;68;69;68;66;67;67;67;65;80 15:38:01 INFO - PROCESS | 1677 | __end_tp_report 15:38:01 INFO - PROCESS | 1677 | __start_cc_report 15:38:01 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,2104 15:38:01 INFO - PROCESS | 1677 | __end_cc_report 15:38:01 INFO - PROCESS | 1677 | __startTimestamp1473287881858__endTimestamp 15:38:01 INFO - PROCESS | 1677 | 15:38:01 INFO - PROCESS | 1677 | ------- Summary: start ------- 15:38:01 INFO - PROCESS | 1677 | Number of tests: 14 15:38:01 INFO - PROCESS | 1677 | 15:38:01 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:114.60 Median:114.00 stddev:3.60 (3.2%) stddev-sans-first:3.69 15:38:01 INFO - PROCESS | 1677 | Values: 112.0 114.0 116.0 111.0 114.0 113.0 113.0 115.0 114.0 124.0 15:38:01 INFO - PROCESS | 1677 | 15:38:01 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:140.50 stddev:26.94 (19.2%) stddev-sans-first:28.37 15:38:01 INFO - PROCESS | 1677 | Values: 147.0 113.0 141.0 160.0 108.0 128.0 140.0 135.0 197.0 109.0 15:38:01 INFO - PROCESS | 1677 | 15:38:01 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.50 stddev:0.95 (0.5%) stddev-sans-first:1.00 15:38:01 INFO - PROCESS | 1677 | Values: 183.0 184.0 185.0 183.0 184.0 183.0 182.0 184.0 183.0 182.0 15:38:01 INFO - PROCESS | 1677 | 15:38:01 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:82.00 Median:62.50 stddev:34.89 (55.8%) stddev-sans-first:36.96 15:38:01 INFO - PROCESS | 1677 | Values: 77.0 74.0 78.0 154.0 58.0 58.0 58.0 67.0 138.0 58.0 15:38:01 INFO - PROCESS | 1677 | 15:38:01 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:72.50 stddev:23.02 (31.7%) stddev-sans-first:24.22 15:38:01 INFO - PROCESS | 1677 | Values: 82.0 83.0 133.0 69.0 75.0 92.0 116.0 68.0 70.0 114.0 15:38:01 INFO - PROCESS | 1677 | 15:38:01 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:92.10 Median:88.50 stddev:13.03 (14.7%) stddev-sans-first:13.79 15:38:01 INFO - PROCESS | 1677 | Values: 90.0 87.0 89.0 87.0 89.0 86.0 88.0 87.0 89.0 129.0 15:38:01 INFO - PROCESS | 1677 | 15:38:01 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:96.40 Median:96.00 stddev:1.07 (1.1%) stddev-sans-first:1.13 15:38:01 INFO - PROCESS | 1677 | Values: 96.0 99.0 96.0 96.0 96.0 96.0 96.0 95.0 97.0 97.0 15:38:01 INFO - PROCESS | 1677 | 15:38:01 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.00 stddev:2.76 (3.2%) stddev-sans-first:2.92 15:38:01 INFO - PROCESS | 1677 | Values: 86.0 86.0 84.0 84.0 84.0 84.0 85.0 85.0 84.0 93.0 15:38:01 INFO - PROCESS | 1677 | 15:38:01 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:0.95 (1.7%) stddev-sans-first:1.00 15:38:01 INFO - PROCESS | 1677 | Values: 54.0 53.0 56.0 54.0 54.0 55.0 55.0 54.0 53.0 55.0 15:38:01 INFO - PROCESS | 1677 | 15:38:01 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:71.00 stddev:3.43 (4.8%) stddev-sans-first:3.35 15:38:01 INFO - PROCESS | 1677 | Values: 67.0 67.0 71.0 70.0 75.0 78.0 71.0 69.0 69.0 71.0 15:38:01 INFO - PROCESS | 1677 | 15:38:01 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.00 stddev:5.12 (5.9%) stddev-sans-first:5.36 15:38:01 INFO - PROCESS | 1677 | Values: 88.0 86.0 86.0 86.0 84.0 85.0 83.0 75.0 90.0 95.0 15:38:01 INFO - PROCESS | 1677 | 15:38:01 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:155.60 Median:150.50 stddev:30.37 (20.2%) stddev-sans-first:32.20 15:38:01 INFO - PROCESS | 1677 | Values: 158.0 161.0 131.0 152.0 140.0 145.0 145.0 149.0 238.0 137.0 15:38:01 INFO - PROCESS | 1677 | 15:38:01 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:168.50 stddev:1.35 (0.8%) stddev-sans-first:1.41 15:38:01 INFO - PROCESS | 1677 | Values: 169.0 170.0 168.0 170.0 166.0 168.0 168.0 167.0 170.0 168.0 15:38:01 INFO - PROCESS | 1677 | 15:38:01 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:67.50 stddev:4.34 (6.4%) stddev-sans-first:4.45 15:38:01 INFO - PROCESS | 1677 | Values: 65.0 68.0 69.0 68.0 66.0 67.0 67.0 67.0 65.0 80.0 15:38:01 INFO - PROCESS | 1677 | -------- Summary: end -------- 15:38:01 INFO - PROCESS | 1677 | 15:38:02 INFO - TEST-INFO | 1677: exit 0 15:38:02 INFO - TEST-OK | kraken | took 59443ms 15:38:02 INFO - SUITE-END | took 1177s 15:38:02 INFO - Completed test suite (00:19:37) 15:38:02 INFO - javascript benchmark 15:38:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3316.204111013357, 3318.170457385653, 3353.798772073674, 3386.2380964283057, 3418.8290585470736, 5538.9169162462595, 5650.0, 5670.206171136044, 5728.22668939693, 5744.281964754406, 5680.431956804317, 5733.397993210715, 5733.426657334265, 5751.338596061454, 5760.8271751847515, 5194.37667479902, 5212.270282160501, 5235.869103272411, 5251.789928402859, 5283.603729720267, 5259.579233661317, 5274.92087618686, 5279.1817268323275, 5283.313169287987, 5287.709175995319, 4509.346144809001, 4910.75446227689, 5191.402988656297, 5251.107311756991, 5286.286351342577, 5313.017091838023, 5329.094054010828, 5329.22726204702, 5345.224942383333, 5388.1648344506275, 5083.186690129599, 5111.1566591512355, 5164.096283150434, 5233.162693968947, 5248.317718696583, 4778.450478195017, 5705.515031222351, 5734.369219385864, 5735.254416925773, 5811.099279611667, 6281.026440901667, 6300.87398252037, 6304.369563043705, 6307.0, 6311.084892690534, 5219.739013049332, 6237.563370564062, 6248.218972628421, 6266.386211159089, 6279.0895320178315, 5828.941710582924, 5829.679367634736, 5833.212516310328, 5835.94164058354, 5884.999999999957, 6296.307406185316, 6296.992481202986, 6301.558890877594, 6307.747690092345, 6314.431701146918, 5997.670128142907, 6043.898523920885, 6093.6554992613665, 6184.196054512884, 6208.4722798562625, 6209.782657606962, 6276.403741644628, 6287.182666253358, 6295.905561416583, 6315.179026726496, 6179.567430279837, 6258.405451482102, 6276.968615156987, 6278.121063051177, 6294.118823364733, 6093.111789665656, 6119.380693981147, 6127.00628053041, 6276.184096067574, 6295.055741638791, 4892.0705066037335, 4903.04390643821, 4909.607231421478, 4912.778924948386, 4916.557509824133, 4368.60682538573, 4402.3836662867225, 4405.3612226227015, 4416.0, 4456.955430445719, 5673.5461163107675, 5674.375818659944, 5679.602427830012, 5697.145428185805, 5715.942840571624, 6223.315435302113, 6310.5898116622275, 6337.081123237197, 6337.302896681362, 6349.714262858182, 5535.806246781424, 5561.721913904288, 5607.186957891083, 5646.096624540136, 5652.717364131777, 5412.512873841373, 5421.5933804964, 5425.972870135624, 5464.863378415572, 5469.753861076181, 6263.217097862767, 6295.496360291166, 6302.212223472066, 6304.71628776697, 6316.747330106836, 6122.459144589048, 6195.659238741912, 6242.937570624235, 6303.432691057827, 6307.211598550181, 6265.216847894013, 6275.905861412174, 6295.276043255084, 6295.590786599039, 6300.873982520232, 6192.566520343533, 6194.442500175006, 6195.473384762166, 6199.597026193283, 6202.2867370253, 6115.6662951758, 6120.081455037822, 6202.038684003986, 6290.0879372491645, 6303.49572034227, 5973.074173503114, 6055.1522786809, 6123.601965872204, 6129.387061293835, 6146.477549408351, 4994.475580064186, 5231.398389185292, 6094.481969032682, 6098.603590766586, 6136.048912418582, 5797.594168408171, 5904.202932604044, 5908.202392676933, 5998.760049597967, 6008.0, 6138.419052470285, 6153.661548614869, 6153.907691384722, 6167.198264225622, 6186.690665466619, 5941.197938278277, 5959.612625179349, 5980.820575382745, 6011.0, 6056.0], "value": 5689.108983112971, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.91734863747496, 506.7238355096472, 507.13786562843154, 522.3966318901668, 534.17203334831, 29719.0, 39525.0, 40702.0, 40824.97937551559, 42839.0, 41881.37177942333, 42323.0, 42333.36499952503, 42339.36490952638, 42452.363214551806, 9602.903970960271, 9811.362261453018, 9816.312858099936, 9828.705138845846, 9851.359661621971, 9579.233661307113, 9682.612695492171, 9697.612095516206, 9698.127168554829, 9705.61177552897, 9666.4200147991, 9731.56207970643, 9754.268429867789, 9755.317127801056, 9771.169450596708, 9688.370255933378, 9735.17251033663, 9736.707898763048, 9748.610055597768, 9760.511974401252, 9582.377145485521, 9653.951730241373, 9658.130768230892, 9681.51592420376, 9688.273379496495, 40052.599474005176, 40243.597564024276, 40337.19325613471, 40340.39489407661, 40556.79721601403, 2926.561015847619, 3341.899743007714, 3449.137715571107, 3783.3000894834267, 4137.1518838638, 27562.44875102507, 29205.123846284645, 29651.366240414467, 30935.38129237425, 30950.53574196389, 3148.795328303676, 3196.6643502432144, 3278.1804548862783, 3331.5502407174963, 3344.180675734436, 502170.0, 505063.0, 505591.0, 506138.0, 508513.0, 55593.0, 55769.163462548095, 55782.72108639512, 56062.67404596557, 56135.0, 58932.41067589355, 58979.41020589825, 59044.704776475846, 59087.0, 59181.0, 15402.768958465633, 15612.0, 15612.921935390477, 15620.062796232263, 15629.140397278032, 11501.447304613937, 12152.088593355533, 12173.634790956285, 12174.330411827257, 12201.938990305169, 14010.649733756534, 14532.0554163979, 15178.0, 15197.468088616846, 15359.385624575116, 4697.989932164601, 4898.775306173457, 5106.310648062538, 5317.4741997550855, 5329.9467005330225, 829.3655353654459, 936.3352020065694, 940.520334629344, 988.6885631026204, 1038.444432228769, 28697.713022869502, 28706.569401458994, 29444.705552944197, 29454.969076082234, 29542.556861647092, 924.0666926404245, 1006.5118417567473, 1018.3482571154467, 1034.281174583657, 1063.5692544519482, 13325.333733313295, 13712.0, 14851.925740371229, 14913.478028268959, 15318.770218446733, 679540.0, 685970.0, 690932.5453372701, 691164.0, 692171.0, 56835.43164568384, 57160.142597861064, 57161.0, 57192.0, 57244.427555724746, 1187.0058302052635, 1260.533602567056, 1280.187081203424, 1343.9664008399868, 1382.0601990646458, 29341.55987660144, 30546.0, 30616.31012705642, 31063.534046989764, 31388.68611313949, 47309.29036064393, 47725.0, 47775.5222447785, 47834.76082619565, 47991.0, 552027.0, 552885.0, 553874.0, 554294.0, 659735.0, 21143.57712845765, 23603.763962360157, 25005.0, 25061.498770024133, 25168.0, 39891.80054099711, 41249.79375103225, 44194.0, 44777.77611111924, 45751.738550067166, 37007.6299237015, 37105.0, 37637.24725505529, 37699.43450848185, 38092.619073808906, 36185.81907090553, 36828.0, 37496.62503374931, 37608.43587346137, 37916.24167516689, 35537.75617853363, 35976.57376380894, 36509.45235821412, 36701.44947825732, 36788.63211367959, 31334.793861806622, 32621.021369358958, 32975.50536741903, 33054.50418243776, 33339.1665208362, 23696.593261810627, 24464.716075448014, 24587.75412245926, 24779.752202477743, 25181.0], "value": 19240.83595727798, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.8191340502937, 362.673593765611, 373.328009582751, 375.4987092231871, 401.53622565936337, 14612.0, 15323.84676153238, 19786.802131978675, 20515.97420128995, 20517.794822051776, 19970.201191952303, 20299.898500507476, 20334.98325083747, 20389.0, 20414.69377959328, 4112.938305925413, 5793.855153621172, 6064.636121832682, 6065.2721673399255, 6066.120412540179, 5046.318746969149, 6602.986089242779, 6686.866262674744, 6755.9662201688925, 6759.256481787, 6184.536159788011, 6641.1034510341215, 6692.096566963471, 6695.765648202314, 6708.195016598015, 6407.359264073602, 6679.866402671943, 6694.765683201064, 6708.66456677169, 6718.6304753238555, 5650.576206784508, 5777.19119323295, 5787.594868359217, 5810.941890581083, 5817.7091145442555, 23636.645450318087, 24989.87545560436, 25215.28350451051, 25737.97048118073, 26148.86925565379, 2370.134900761227, 2466.4450498637843, 2801.2856721535877, 2918.9562156567667, 3056.327607926275, 15339.693206135926, 15370.0, 15843.920780396023, 15884.823035392852, 16125.193740313054, 1544.8799620275322, 1595.664910368824, 1876.193236908129, 1880.8683392162554, 1920.9039548022683, 89860.0, 106150.0, 106501.99999999923, 114816.85183148229, 116921.8307816928, 10314.535845886952, 10334.17326613869, 10366.170706343626, 10432.843507347396, 10749.0, 13471.461141554424, 13476.326183690971, 13496.190228586316, 13497.662558436117, 13507.662308442172, 8253.463524870864, 8394.118617545191, 8407.159284071666, 8442.366822488339, 8578.871316930252, 8430.704925327584, 8445.788855278544, 8634.050254472004, 8640.179182977607, 8643.3949623527, 6464.573775898782, 6574.441172500391, 6579.901301480481, 6586.901196482057, 6588.0, 1575.9606009849845, 1778.6175972166047, 1858.1916866163263, 1864.7762268527863, 1866.216189200539, 867.9175478329548, 872.8385248728879, 912.4251721415466, 937.1425145991342, 970.6311601591491, 21842.0, 22546.661800073012, 22710.432239193822, 22768.772312276666, 22841.7715822843, 930.3208657679932, 948.9667861624948, 955.2071780422233, 994.4878387630376, 1001.5242759689235, 11428.142889283337, 11675.241109327866, 11751.529938802352, 11806.291622502677, 11811.527538898348, 520040.0, 536599.0, 540939.0, 550294.0, 555740.0, 93943.53028234815, 100777.49611252043, 108063.0, 108343.45828270809, 110501.89498105076, 875.6147295190096, 995.6714284286168, 1025.7640742629237, 1058.9841152382721, 1062.102523367753, 18676.43970680882, 19781.0, 20010.89994550076, 20032.799672003093, 20055.59888802245, 49056.77358065934, 50583.22958696428, 52208.73895630497, 53776.0, 54609.45390546044, 71620.0, 73429.8985515207, 75175.87236191353, 75287.87068194091, 75428.0, 6413.583117097373, 6996.790096297119, 7597.544147351176, 7880.17258187882, 8060.596970151586, 13264.602061938158, 13269.40287687037, 13471.595852124452, 13543.25512096844, 13647.38586763618, 11306.547738090714, 11450.885491145315, 11704.590339338083, 11739.882601173878, 11806.704832379259, 11385.373804440504, 11436.94281528587, 11529.365884876412, 11567.421628918688, 11947.10396720232, 11426.714332141762, 11591.420428978348, 11723.0, 11776.175667703179, 11950.641480755592, 7880.566568838769, 7923.84152316962, 7959.482633628795, 8000.5599692017495, 8034.919650803417, 11274.718132046437, 11341.825161403029, 11604.593839215588, 11741.530338786695, 11827.586034488751], "value": 9769.158840149903, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1493.2608358862365, 1531.1655147944368, 1708.957276068098, 1803.720423334382, 1891.6595012897674, 7919.920800791991, 8207.138250483702, 8394.62224199911, 8819.823603527933, 8822.426542274756, 8404.91595084049, 8713.346499012583, 8733.03936566977, 8809.38334316598, 8818.514981676006, 2341.098677009351, 2376.691030166076, 2382.5354055959097, 2388.450656349041, 2389.665446837444, 2089.5298557824444, 2175.760666326703, 2339.543788961153, 2373.52529494101, 2396.101461951768, 2290.599145149592, 2375.58427275227, 2378.4529558201625, 2382.940426489334, 2384.213209640823, 2072.4611600983853, 2346.894389752465, 2366.1363602285214, 2380.678608387863, 2386.2364043506086, 2342.4143964009, 2363.291012696184, 2368.348704106367, 2377.298696884406, 2383.249276477904, 8629.0, 8830.86753698695, 8836.823263534758, 8837.65802062454, 8843.380963332569, 5213.7393130343335, 5361.865953351158, 5363.195520671891, 5368.8389348319615, 5390.78436862525, 3524.823758812049, 3671.118931456458, 3723.7765734056043, 3728.6830619397383, 3744.9063773405883, 967.3035414501547, 1050.5548705302097, 1094.584058057933, 1115.5147510832815, 1119.7928383249125, 10195.694129176136, 11596.884031159665, 11645.592404265895, 11670.416479176092, 11687.883121168765, 4421.712588681726, 4715.0, 4791.281307803857, 4796.304535842283, 4801.95198048022, 9841.901580984098, 9846.803063938825, 9861.457619830835, 9869.358491698016, 9872.160866326443, 5334.813281535127, 5335.866603334947, 5337.51962323385, 5347.545458635982, 5361.839144825662, 4654.232051711429, 4821.059893320768, 4885.291632713237, 4887.804487820447, 4889.339939108175, 3810.9047273817823, 3824.2160357126722, 3879.398693202502, 3927.290169782898, 3946.980265098656, 1058.8305871060747, 1088.357868857378, 1176.847009888709, 1196.9281843089443, 1236.6351926181799, 832.887560179368, 865.7662431143556, 872.7774417523618, 902.6795487601806, 952.9571169297399, 5372.758225879845, 5633.436656334334, 5771.509421699203, 5860.882782344329, 5907.084401917709, 925.5279807298192, 939.6147579492375, 955.8231727130503, 958.8945216026232, 996.8704068471052, 3783.3379158647676, 3810.0855794609647, 3860.4981352424006, 3874.1984976985837, 3959.6436320731273, 10357.896421035693, 10586.20603454744, 10699.732506687395, 10703.983121603434, 10712.517936692868, 10624.043836054792, 10632.734181645366, 10636.095931845724, 10639.361638301727, 10649.307794993456, 7261.491695581259, 8027.879581806161, 8071.515709057476, 8123.0, 8177.509349438934, 5681.147827825694, 5770.307563092456, 5869.239228231428, 5876.500497457593, 5933.2880054393745, 9441.622335106793, 9704.854427183456, 9921.851172232278, 9989.800203996025, 10014.298999070286, 9812.950935245279, 10044.849327259952, 10213.693589192337, 10218.948905255425, 10232.334898231591, 7193.892091618525, 7365.8158546036775, 7398.260173982559, 7458.7250888477365, 7515.962420187864, 8188.05837328691, 8245.299149572353, 8256.504609723435, 8270.958645206736, 8273.503589784632, 7228.710851566088, 7347.595882226529, 7370.152432470334, 7444.330010299099, 7571.242875712384, 7130.2869713028285, 7211.0, 7215.062041934515, 7239.8914016290855, 7272.23641517633, 6781.525293229427, 6911.308869113049, 6917.100776898971, 6919.619420931897, 6927.792166234819, 4852.393450818648, 4958.727270000185, 4971.875703107451, 4976.850694479172, 5028.421731500778, 4842.225243960949, 4954.405471343462, 5050.444451110301, 5081.4918508148885, 5126.820561280338], "value": 4558.109329593709, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.79372835879064, 297.166448113043, 304.7501049139705, 310.9984450077752, 311.5747005337715, 5029.346184995946, 5229.372475302965, 5242.528172464482, 5257.684538927667, 5321.946780532194, 5026.597872170227, 5079.415867175276, 5137.0, 5143.202803565444, 5269.1832765921245, 3502.7898326100517, 3996.3006473867104, 4007.158496715693, 4018.4976877890263, 4023.6579890709327, 3416.367971925202, 3667.174885650734, 3759.762941050071, 3843.673287770529, 4054.351303791394, 3778.5465744110747, 3817.244067728834, 3982.980085099585, 4026.255142798577, 4064.9431147901464, 3375.443051896434, 3815.8855234343014, 3975.7813320267373, 3977.6420122189143, 3993.6605388542152, 3192.350349210173, 3299.9175020624675, 3474.0793689672255, 3509.5613048368955, 3566.4828599853136, 4388.8933312010095, 4818.542238487338, 5061.810474538481, 5104.489551044903, 5161.664491808058, 4522.163399771053, 4538.591526762574, 4596.3105534170145, 4600.838970636045, 4615.561521655471, 4954.157793175169, 5266.4470230626, 5384.04272859448, 5442.71406009477, 5493.807716729895, 3026.7275945165043, 3164.699353561431, 3729.4778730977414, 3729.4778730977687, 3839.9424008639894, 4745.383100196952, 5459.672419654794, 5663.830085097454, 5706.942930570683, 5712.228849105318, 3195.2331440454122, 3203.583534140547, 3763.8870833875026, 3778.6977041836585, 3804.029972357031, 3372.274960883422, 3439.8476510368805, 3847.2305538892333, 3860.5560360558334, 3868.3037053330672, 4178.770167640809, 4415.880377418857, 4489.753063581469, 4500.459944806644, 4536.274196128604, 5508.3114610673665, 5576.888462230732, 5583.3858275589655, 5615.803446879339, 5662.716864156776, 1240.6526172671665, 1265.8797414245632, 1284.1717092475487, 1309.2733532889147, 1311.1084462565357, 728.1880703016099, 857.5455008845322, 868.9304855611535, 873.6854732296368, 891.2558014058334, 4453.287474004209, 4501.167284052461, 5021.493551934405, 5021.824236151717, 5033.672811267256, 5531.363893152258, 5557.72211389437, 5569.777208911679, 5570.38192049736, 5577.972110139423, 4077.2864748668862, 4691.296305554194, 4699.95300047002, 4771.729302274445, 4794.640401969867, 2133.5626196629655, 2421.9152329668727, 2427.381017840439, 2438.317271164077, 2446.9877650611634, 4061.817218225187, 4083.5916408358926, 4092.693048021351, 4611.608013318838, 4820.975895120572, 4185.811638476276, 4457.013800753503, 4547.681662283675, 4720.433547974265, 4776.14029474691, 4263.531011588785, 4386.342048692658, 4690.554397332248, 4801.45522872878, 4949.010197960422, 4220.345846393814, 4248.63886569645, 4636.930446043245, 4663.743494107856, 4811.591014763784, 3872.5865059253733, 4536.138133754708, 4587.4036375271, 4593.0, 4627.375304333872, 4270.142488017722, 4351.717138386121, 4355.390245365588, 4805.342156955845, 4837.467878533429, 2936.3540021195304, 3032.7877048606388, 3045.375697981864, 3203.5194720791137, 3250.6749325067303, 4029.899252518593, 4250.128723611714, 4611.331356953156, 4623.0, 4634.4670362907345, 4580.65645076614, 4906.411230652345, 5119.080344870674, 5463.371712252982, 5514.834554963358, 4229.492460904711, 5119.385673719029, 5429.945700542944, 5456.42707515721, 5518.530924871431, 5173.508516690908, 5269.051570717308, 5334.813281535127, 5393.9730301348245, 5397.244385785914, 5110.97444512775, 5414.485623865727, 5434.429384914685, 5475.616706830484, 5488.91766623493, 5308.814191503279, 5333.43998880112, 5338.733063346895, 5339.2647389599315, 5433.5924805640525], "value": 3785.7396973737436, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.7107414885747, 732.4653003307585, 747.506645613895, 797.876329168979, 809.6963638635511, 15176.089434633916, 16237.431689890827, 16266.942648727825, 16272.186390680477, 16367.754483682755, 14632.707345853076, 14781.852181478182, 14789.038712483682, 14811.333489992949, 14811.407543698266, 680.4964326398455, 700.9614471204081, 702.115334678304, 703.8381172330367, 842.9915700843005, 675.2403546010738, 675.3887731602907, 832.9791755206107, 859.0121360435487, 861.4228466927174, 883.1609970527992, 892.2371372476537, 895.2971917045121, 895.6193617712479, 895.9417637853551, 891.5987805487491, 892.1791951404723, 892.6340200517822, 892.7544925145572, 896.708569714842, 658.4929604204783, 659.2550418027646, 659.4658326755343, 660.4947215380238, 663.0154220981838, 11904.821427678591, 14580.416783328654, 14723.337449814677, 14826.62933426673, 15467.381304747796, 14166.92916535421, 14686.853131468655, 14749.926250368679, 14864.108153510824, 14899.255037248095, 11895.88104118965, 11905.702357441134, 11925.582604608797, 11965.581204657796, 12235.265884046985, 3850.6726928211137, 3872.7289089763726, 3905.902352441183, 3923.0780766519847, 4021.7586944783407, 105938.47030764873, 121313.0, 124626.37686811599, 125801.27484064492, 127707.3614631921, 11272.705568708652, 11273.969528464073, 11320.26418282809, 11354.637443506832, 11654.0, 23084.19205327839, 23347.299581012598, 23404.829758512005, 23413.297601071994, 23790.0, 8113.797155071171, 8168.469049511763, 8171.428000040059, 8210.178982101861, 8308.70919517814, 4496.437945256843, 4611.838585649486, 4672.439307283148, 4777.355057067321, 4783.880402989953, 3311.403947289511, 3342.298117395374, 3394.660533946635, 3424.007037959014, 3433.210361616842, 665.7337065173872, 671.8219671786981, 681.9283975182634, 690.5442408010689, 692.1901375390805, 544.9239045587635, 559.6977632078632, 560.3220103674518, 582.8222392170429, 675.2167485716545, 8672.60973256205, 8810.603522841488, 9200.171984521425, 9394.389364691273, 9408.623655053721, 558.6648011193333, 611.9541034422436, 657.2934095846888, 666.1107421592228, 675.0684056002685, 4529.773511324421, 4565.429321334833, 4565.771711414416, 4585.79363928624, 4593.701409408378, 160126.19936900475, 162477.0, 166246.0, 168598.47102293474, 171694.0, 138388.30805845905, 140646.0, 142272.0, 142720.0, 145126.0, 119007.0, 119732.20401693981, 123348.0, 123806.0, 126187.73812261944, 8822.338324625807, 8846.778830529289, 8896.929813661283, 8901.465912045298, 9052.592633331384, 58511.70744146252, 59624.99999999827, 65791.35521611998, 68186.65906670435, 70107.64946175237, 64705.0, 65539.01691474728, 66396.0, 85452.0, 96371.51814240884, 13191.208527488381, 13260.0045872016, 13305.66735831612, 13316.201027938354, 13827.308634568433, 14300.0, 14812.925935370255, 14818.777718334019, 15283.46507872219, 15350.616234594225, 13832.585022449342, 13922.303884805922, 14115.153090814583, 14367.425302988182, 14724.411023559365, 13634.590962271148, 13940.512082077079, 14036.719265614835, 14593.781093283822, 14667.413303468169, 13490.76026292943, 13659.0, 13793.931030345186, 13800.723985520433, 13827.51603693866, 9605.47169905634, 10404.583816647551, 11142.331460112095, 11425.428728563706, 11999.940000299943, 10789.244752867538, 11370.830046629484, 11560.768784624428, 11571.594994175164, 11798.292102473879], "value": 7892.394436664541, "unit": "score"}], "name": "dromaeo_css", "value": 7253.59207137044, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 116.0, 111.0, 114.0, 113.0, 113.0, 115.0, 114.0, 124.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 113.0, 141.0, 160.0, 108.0, 128.0, 140.0, 135.0, 197.0, 109.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 185.0, 183.0, 184.0, 183.0, 182.0, 184.0, 183.0, 182.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 78.0, 154.0, 58.0, 58.0, 58.0, 67.0, 138.0, 58.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 133.0, 69.0, 75.0, 92.0, 116.0, 68.0, 70.0, 114.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 87.0, 89.0, 86.0, 88.0, 87.0, 89.0, 129.0], "value": 92.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 99.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0, 97.0], "value": 96.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 84.0, 84.0, 84.0, 84.0, 85.0, 85.0, 84.0, 93.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 56.0, 54.0, 54.0, 55.0, 55.0, 54.0, 53.0, 55.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 71.0, 70.0, 75.0, 78.0, 71.0, 69.0, 69.0, 71.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 86.0, 86.0, 84.0, 85.0, 83.0, 75.0, 90.0, 95.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 161.0, 131.0, 152.0, 140.0, 145.0, 145.0, 149.0, 238.0, 137.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 168.0, 170.0, 166.0, 168.0, 168.0, 167.0, 170.0, 168.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 69.0, 68.0, 66.0, 67.0, 67.0, 67.0, 65.0, 80.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1485.0, "alertThreshold": 2.0}]} 15:38:03 INFO - Return code: 0 15:38:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:38:03 INFO - # TBPL SUCCESS # 15:38:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:38:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:38:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:38:03 INFO - 2016-09-07 15:38:03.166 screenresolution[1681:9847] starting screenresolution argv=screenresolution get 15:38:03 INFO - 2016-09-07 15:38:03.169 screenresolution[1681:9847] Display 0: 1600x1200x32@60 15:38:03 INFO - 2016-09-07 15:38:03.175 screenresolution[1682:9851] starting screenresolution argv=screenresolution list 15:38:03 INFO - Available Modes on Display 0 15:38:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:38:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:38:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:38:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:38:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:38:03 INFO - Intel Iris: 15:38:03 INFO - Chipset Model: Intel Iris 15:38:03 INFO - Type: GPU 15:38:03 INFO - Bus: Built-In 15:38:03 INFO - VRAM (Dynamic, Max): 1536 MB 15:38:03 INFO - Vendor: Intel (0x8086) 15:38:03 INFO - Device ID: 0x0a2e 15:38:03 INFO - Revision ID: 0x0009 15:38:03 INFO - Displays: 15:38:03 INFO - Display: 15:38:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:38:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:38:03 INFO - Display Serial Number: 1600x1200 60 15:38:03 INFO - Main Display: Yes 15:38:03 INFO - Mirror: Off 15:38:03 INFO - Online: Yes 15:38:03 INFO - Rotation: Supported 15:38:03 INFO - Return code: 0 15:38:03 INFO - Running post-action listener: _resource_record_post_action 15:38:03 INFO - [mozharness: 2016-09-07 22:38:03.415583Z] Finished run-tests step (success) 15:38:03 INFO - Running post-run listener: _resource_record_post_run 15:38:03 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 38138880; Write bytes: 704780800; Read time: 373; Write time: 2119 15:38:03 INFO - TinderboxPrint: CPU usage
53.9% 15:38:03 INFO - TinderboxPrint: I/O read bytes / time
38,138,880 / 373 15:38:03 INFO - TinderboxPrint: I/O write bytes / time
704,780,800 / 2,119 15:38:03 INFO - TinderboxPrint: CPU idle
2,239.7 (46.1%) 15:38:03 INFO - TinderboxPrint: CPU system
976.0 (20.1%) 15:38:03 INFO - TinderboxPrint: CPU user
1,638.0 (33.7%) 15:38:03 INFO - TinderboxPrint: Swap in / out
443,535,360 / 0 15:38:03 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 406825472; Write bytes: 408492032; Read time: 30658; Write time: 770 15:38:03 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 34464768; Write bytes: 294720000; Read time: 342; Write time: 1344 15:38:03 INFO - Running post-run listener: _upload_blobber_files 15:38:03 INFO - Blob upload gear active. 15:38:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:38:03 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 15:38:03 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:38:03 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:38:04 INFO - (blobuploader) - INFO - Open directory for files ... 15:38:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:38:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:38:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:05 INFO - (blobuploader) - INFO - Done attempting. 15:38:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:38:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:38:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:06 INFO - (blobuploader) - INFO - Done attempting. 15:38:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:38:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:38:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:08 INFO - (blobuploader) - INFO - Done attempting. 15:38:08 INFO - (blobuploader) - INFO - Iteration through files over. 15:38:08 INFO - Return code: 0 15:38:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:38:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:38:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b716865f44a44bc9e2adfda74a4c96b02b02ab870ffe12cf95d5e9d01229f98422faebc52eb4c99287caca79a1afd02c27cc11f26e7569b5b16311b0b3915daa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af0f2dad815cd091bf30c55baeb44797a65481f0a931b8ae4bd74568a6dcef4f3018a1851ceeb336ed5af04b1cf084bf872c3c96d91798a1728ca98a76cd1bfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f996f39d6a45cc3b1b7b7547008228b89a5e85cf54a67b7b7900a5825cdf52e21a71981c5bc731b32951bef83ad49d461361aa66a39ee344f318e725af59bc1"} 15:38:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:38:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:38:08 INFO - Contents: 15:38:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b716865f44a44bc9e2adfda74a4c96b02b02ab870ffe12cf95d5e9d01229f98422faebc52eb4c99287caca79a1afd02c27cc11f26e7569b5b16311b0b3915daa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af0f2dad815cd091bf30c55baeb44797a65481f0a931b8ae4bd74568a6dcef4f3018a1851ceeb336ed5af04b1cf084bf872c3c96d91798a1728ca98a76cd1bfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f996f39d6a45cc3b1b7b7547008228b89a5e85cf54a67b7b7900a5825cdf52e21a71981c5bc731b32951bef83ad49d461361aa66a39ee344f318e725af59bc1"} 15:38:08 INFO - Running post-run listener: copy_logs_to_upload_dir 15:38:08 INFO - Copying logs to upload dir... 15:38:08 INFO - mkdir: /builds/slave/test/build/upload/logs 15:38:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.611336 ========= master_lag: 0.93 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-07 15:38:09.816330) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-07 15:38:09.819694) ========= 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.pV4jRG9jKB/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.4cXZIbxrMa/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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/Firefox/sha512/b716865f44a44bc9e2adfda74a4c96b02b02ab870ffe12cf95d5e9d01229f98422faebc52eb4c99287caca79a1afd02c27cc11f26e7569b5b16311b0b3915daa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af0f2dad815cd091bf30c55baeb44797a65481f0a931b8ae4bd74568a6dcef4f3018a1851ceeb336ed5af04b1cf084bf872c3c96d91798a1728ca98a76cd1bfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f996f39d6a45cc3b1b7b7547008228b89a5e85cf54a67b7b7900a5825cdf52e21a71981c5bc731b32951bef83ad49d461361aa66a39ee344f318e725af59bc1"} build_url:https://queue.taskcluster.net/v1/task/HJWCn7LmQhiNh140AjPWrg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/HJWCn7LmQhiNh140AjPWrg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b716865f44a44bc9e2adfda74a4c96b02b02ab870ffe12cf95d5e9d01229f98422faebc52eb4c99287caca79a1afd02c27cc11f26e7569b5b16311b0b3915daa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af0f2dad815cd091bf30c55baeb44797a65481f0a931b8ae4bd74568a6dcef4f3018a1851ceeb336ed5af04b1cf084bf872c3c96d91798a1728ca98a76cd1bfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f996f39d6a45cc3b1b7b7547008228b89a5e85cf54a67b7b7900a5825cdf52e21a71981c5bc731b32951bef83ad49d461361aa66a39ee344f318e725af59bc1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-07 15:38:09.853855) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 15:38:09.854198) ========= 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.pV4jRG9jKB/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.4cXZIbxrMa/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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.005090 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 15:38:09.903942) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-07 15:38:09.904308) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-07 15:38:09.904666) ========= ========= Total master_lag: 1.06 =========