builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0332 starttime: 1476971281.63 results: success (0) buildid: 20161020050549 builduid: 9a834c62dddb4b04a0dce382e7899f96 revision: 0895f2ef1268cb87b507dfa1e4d7633621215264 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 06:48:01.625478) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 06:48:01.625907) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 06:48:01.626184) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 06:48:01.650136) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 06:48:01.650457) ========= 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.37nLwv4Pvz/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.UDEKxQWyvX/Listeners TMPDIR=/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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-10-20 06:48:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.8M=0.001s 2016-10-20 06:48:01 (21.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.102873 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 06:48:01.775165) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 06:48:01.775487) ========= 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.37nLwv4Pvz/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.UDEKxQWyvX/Listeners TMPDIR=/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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.027160 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 06:48:01.823881) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 06:48:01.824197) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0895f2ef1268cb87b507dfa1e4d7633621215264 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0895f2ef1268cb87b507dfa1e4d7633621215264 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.37nLwv4Pvz/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.UDEKxQWyvX/Listeners TMPDIR=/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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-10-20 06:48:01,905 truncating revision to first 12 chars 2016-10-20 06:48:01,905 Setting DEBUG logging. 2016-10-20 06:48:01,906 attempt 1/10 2016-10-20 06:48:01,906 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0895f2ef1268?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 06:48:03,599 unpacking tar archive at: mozilla-aurora-0895f2ef1268/testing/mozharness/ program finished with exit code 0 elapsedTime=1.964755 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 06:48:03.810341) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 06:48:03.810655) ========= script_repo_revision: 0895f2ef1268cb87b507dfa1e4d7633621215264 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 06:48:03.811032) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 06:48:03.811295) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 06:48:03.828979) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-20 06:48:03.829252) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.37nLwv4Pvz/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.UDEKxQWyvX/Listeners TMPDIR=/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 06:48:04 INFO - MultiFileLogger online at 20161020 06:48:04 in /builds/slave/test 06:48:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:48:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:48:04 INFO - {'append_to_log': False, 06:48:04 INFO - 'base_work_dir': '/builds/slave/test', 06:48:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:48:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:48:04 INFO - 'branch': 'Mozilla-Aurora', 06:48:04 INFO - 'buildbot_json_path': 'buildprops.json', 06:48:04 INFO - 'config_files': ('talos/mac_config.py',), 06:48:04 INFO - 'default_actions': ('clobber', 06:48:04 INFO - 'read-buildbot-config', 06:48:04 INFO - 'download-and-extract', 06:48:04 INFO - 'populate-webroot', 06:48:04 INFO - 'create-virtualenv', 06:48:04 INFO - 'install', 06:48:04 INFO - 'run-tests'), 06:48:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:48:04 INFO - 'download_minidump_stackwalk': True, 06:48:04 INFO - 'download_symbols': 'ondemand', 06:48:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:48:04 INFO - 'tooltool.py': '/tools/tooltool.py', 06:48:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:48:04 INFO - '/tools/misc-python/virtualenv.py')}, 06:48:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:48:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:48:04 INFO - 'installer_path': 'installer.exe', 06:48:04 INFO - 'log_level': 'info', 06:48:04 INFO - 'log_name': 'talos', 06:48:04 INFO - 'log_to_console': True, 06:48:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:48:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:48:04 INFO - 'opt_config_files': (), 06:48:04 INFO - 'pip_index': False, 06:48:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:48:04 INFO - 'cmd': ('bash', 06:48:04 INFO - '-c', 06:48:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:48:04 INFO - 'enabled': True, 06:48:04 INFO - 'halt_on_failure': False, 06:48:04 INFO - 'name': 'check_screen_resolution'},), 06:48:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:48:04 INFO - 'cmd': ('bash', 06:48:04 INFO - '-c', 06:48:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:48:04 INFO - 'enabled': True, 06:48:04 INFO - 'halt_on_failure': False, 06:48:04 INFO - 'name': 'check_screen_resolution'},), 06:48:04 INFO - 'run_cmd_checks_enabled': True, 06:48:04 INFO - 'sps_profile': False, 06:48:04 INFO - 'sps_profile_interval': 0, 06:48:04 INFO - 'suite': 'dromaeojs', 06:48:04 INFO - 'system_bits': '32', 06:48:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:48:04 INFO - 'title': 't-yosemite-r7-0332', 06:48:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:48:04 INFO - 'use_talos_json': True, 06:48:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:48:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:48:04 INFO - 'work_dir': 'build'} 06:48:04 INFO - [mozharness: 2016-10-20 13:48:04.026435Z] Running clobber step. 06:48:04 INFO - Running pre-action listener: _resource_record_pre_action 06:48:04 INFO - Running main action method: clobber 06:48:04 INFO - rmtree: /builds/slave/test/build 06:48:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:48:06 INFO - Running post-action listener: _resource_record_post_action 06:48:06 INFO - [mozharness: 2016-10-20 13:48:06.033475Z] Finished clobber step (success) 06:48:06 INFO - [mozharness: 2016-10-20 13:48:06.033626Z] Running read-buildbot-config step. 06:48:06 INFO - Running pre-action listener: _resource_record_pre_action 06:48:06 INFO - Running main action method: read_buildbot_config 06:48:06 INFO - Using buildbot properties: 06:48:06 INFO - { 06:48:06 INFO - "project": "", 06:48:06 INFO - "product": "firefox", 06:48:06 INFO - "script_repo_revision": "production", 06:48:06 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 06:48:06 INFO - "repository": "", 06:48:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 06:48:06 INFO - "buildid": "20161020050549", 06:48:06 INFO - "pgo_build": "False", 06:48:06 INFO - "basedir": "/builds/slave/test", 06:48:06 INFO - "buildnumber": 44, 06:48:06 INFO - "slavename": "t-yosemite-r7-0332", 06:48:06 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 06:48:06 INFO - "platform": "yosemite_r7", 06:48:06 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:48:06 INFO - "branch": "mozilla-aurora", 06:48:06 INFO - "repo_path": "releases/mozilla-aurora", 06:48:06 INFO - "revision": "0895f2ef1268cb87b507dfa1e4d7633621215264", 06:48:06 INFO - "stage_platform": "macosx64", 06:48:06 INFO - "builduid": "9a834c62dddb4b04a0dce382e7899f96", 06:48:06 INFO - "slavebuilddir": "test" 06:48:06 INFO - } 06:48:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 06:48:06 INFO - Running post-action listener: _resource_record_post_action 06:48:06 INFO - [mozharness: 2016-10-20 13:48:06.036895Z] Finished read-buildbot-config step (success) 06:48:06 INFO - [mozharness: 2016-10-20 13:48:06.036971Z] Running download-and-extract step. 06:48:06 INFO - Running pre-action listener: _resource_record_pre_action 06:48:06 INFO - Running main action method: download_and_extract 06:48:06 INFO - mkdir: /builds/slave/test/build/tests 06:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:06 INFO - trying https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 06:48:06 INFO - Downloading https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 06:48:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 06:48:07 INFO - Downloaded 1199 bytes. 06:48:07 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 06:48:07 INFO - Using the following test package requirements: 06:48:07 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 06:48:07 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:48:07 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 06:48:07 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:48:07 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 06:48:07 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:48:07 INFO - u'jsshell-mac.zip'], 06:48:07 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:48:07 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 06:48:07 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 06:48:07 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:48:07 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 06:48:07 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:48:07 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 06:48:07 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:48:07 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 06:48:07 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:48:07 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 06:48:07 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:48:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 06:48:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:48:07 INFO - Fetch https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 06:48:08 INFO - Expected file size: 16436099 06:48:14 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 06:48:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 06:48:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:48:14 INFO - Fetch https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 06:48:15 INFO - Expected file size: 16436099 06:48:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 06:48:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 06:48:22 INFO - Fetch https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 06:48:22 INFO - Expected file size: 14414081 06:48:23 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')]} 06:48:23 INFO - trying https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 06:48:23 INFO - Downloading https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 06:48:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 06:48:26 INFO - Downloaded 115419213 bytes. 06:48:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 06:48:26 INFO - mkdir: /builds/slave/test/properties 06:48:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:48:26 INFO - Writing to file /builds/slave/test/properties/build_url 06:48:26 INFO - Contents: 06:48:26 INFO - build_url:https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 06:48:26 INFO - Running post-action listener: _resource_record_post_action 06:48:26 INFO - Running post-action listener: set_extra_try_arguments 06:48:26 INFO - [mozharness: 2016-10-20 13:48:26.906290Z] Finished download-and-extract step (success) 06:48:26 INFO - [mozharness: 2016-10-20 13:48:26.906449Z] Running populate-webroot step. 06:48:26 INFO - Running pre-action listener: _resource_record_pre_action 06:48:26 INFO - Running main action method: populate_webroot 06:48:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:48:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:48:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:48:26 INFO - '--tppagecycles', 06:48:26 INFO - '7'], 06:48:26 INFO - 'tests': ['tsvgm']}}, 06:48:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:48:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:48:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:48:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:48:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:48:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:48:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:26 INFO - 'talos_options': ['--disable-e10s'], 06:48:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:48:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:48:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:26 INFO - 'talos_options': ['--disable-e10s'], 06:48:26 INFO - 'tests': ['damp', 'tps']}, 06:48:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:26 INFO - 'tests': ['damp', 'tps']}, 06:48:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:48:26 INFO - 'tests': ['dromaeo_dom']}, 06:48:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:48:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:48:26 INFO - 'tests': ['basic_compositor_video']}, 06:48:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:48:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:48:26 INFO - 'tests': ['a11yr', 06:48:26 INFO - 'ts_paint', 06:48:26 INFO - 'tpaint', 06:48:26 INFO - 'sessionrestore', 06:48:26 INFO - 'sessionrestore_no_auto_restore', 06:48:26 INFO - 'tabpaint']}, 06:48:26 INFO - 'other-e10s': {'tests': ['a11yr', 06:48:26 INFO - 'ts_paint', 06:48:26 INFO - 'tpaint', 06:48:26 INFO - 'sessionrestore', 06:48:26 INFO - 'sessionrestore_no_auto_restore', 06:48:26 INFO - 'tabpaint']}, 06:48:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:48:26 INFO - 'ts_paint', 06:48:26 INFO - 'tpaint', 06:48:26 INFO - 'sessionrestore', 06:48:26 INFO - 'sessionrestore_no_auto_restore', 06:48:26 INFO - 'tabpaint']}, 06:48:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:48:26 INFO - 'ts_paint', 06:48:26 INFO - 'tpaint', 06:48:26 INFO - 'sessionrestore', 06:48:26 INFO - 'sessionrestore_no_auto_restore', 06:48:26 INFO - 'tabpaint']}, 06:48:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:48:26 INFO - 'tests': ['a11yr', 06:48:26 INFO - 'ts_paint', 06:48:26 INFO - 'tpaint', 06:48:26 INFO - 'sessionrestore', 06:48:26 INFO - 'sessionrestore_no_auto_restore', 06:48:26 INFO - 'tabpaint']}, 06:48:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:48:26 INFO - 'tests': ['a11yr', 06:48:26 INFO - 'ts_paint', 06:48:26 INFO - 'tpaint', 06:48:26 INFO - 'sessionrestore', 06:48:26 INFO - 'sessionrestore_no_auto_restore', 06:48:26 INFO - 'tabpaint']}, 06:48:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:48:26 INFO - 'tests': ['tsvgx', 06:48:26 INFO - 'tsvgr_opacity', 06:48:26 INFO - 'tart', 06:48:26 INFO - 'tscrollx', 06:48:26 INFO - 'cart']}, 06:48:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:48:26 INFO - 'tsvgr_opacity', 06:48:26 INFO - 'tart', 06:48:26 INFO - 'tscrollx', 06:48:26 INFO - 'cart']}, 06:48:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:26 INFO - 'talos_options': ['--disable-e10s'], 06:48:26 INFO - 'tests': ['tp5o']}, 06:48:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:26 INFO - 'tests': ['tp5o']}, 06:48:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:26 INFO - 'talos_options': ['--disable-e10s', 06:48:26 INFO - '--xperf_path', 06:48:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:48:26 INFO - 'tests': ['tp5n']}, 06:48:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:26 INFO - 'talos_options': ['--xperf_path', 06:48:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:48:26 INFO - 'tests': ['tp5n']}}, 06:48:26 INFO - 'talos.zip': {'path': '', 06:48:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:48:26 INFO - Running post-action listener: _resource_record_post_action 06:48:26 INFO - [mozharness: 2016-10-20 13:48:26.924707Z] Finished populate-webroot step (success) 06:48:26 INFO - [mozharness: 2016-10-20 13:48:26.924854Z] Running create-virtualenv step. 06:48:26 INFO - Running pre-action listener: _resource_record_pre_action 06:48:26 INFO - Running main action method: create_virtualenv 06:48:26 INFO - Creating virtualenv /builds/slave/test/build/venv 06:48:26 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 06:48:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:48:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:48:27 INFO - Using real prefix '/tools/python27' 06:48:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:48:27 INFO - Installing distribute.............................................................................................................................................................................................done. 06:48:30 INFO - Installing pip.................done. 06:48:30 INFO - Return code: 0 06:48:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:48: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')]} 06:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48: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')]} 06:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d2a8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d21e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef105713f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0bcd30>, '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 0x10cf22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b4b20>, '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.37nLwv4Pvz/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.UDEKxQWyvX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 06:48: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', 'pip>=1.5'] in /builds/slave/test/build 06:48: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 pip>=1.5 06:48:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37nLwv4Pvz/Render', 06:48:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:30 INFO - 'HOME': '/Users/cltbld', 06:48:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:30 INFO - 'LOGNAME': 'cltbld', 06:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:30 INFO - 'MOZ_NO_REMOTE': '1', 06:48:30 INFO - 'NO_EM_RESTART': '1', 06:48:30 INFO - 'PAGER': '/bin/cat', 06:48:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:30 INFO - 'PWD': '/builds/slave/test', 06:48:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:30 INFO - 'SHELL': '/bin/bash', 06:48:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDEKxQWyvX/Listeners', 06:48:30 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 06:48:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:30 INFO - 'USER': 'cltbld', 06:48:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:30 INFO - 'XPC_FLAGS': '0x0', 06:48:30 INFO - 'XPC_SERVICE_NAME': '0', 06:48:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:30 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 06:48:30 INFO - Cleaning up... 06:48:30 INFO - Return code: 0 06:48:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:48: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')]} 06:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48: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')]} 06:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48: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', '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 0x10d2a8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d21e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef105713f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0bcd30>, '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 0x10cf22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b4b20>, '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.37nLwv4Pvz/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.UDEKxQWyvX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 06:48: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', 'psutil>=3.1.1'] in /builds/slave/test/build 06:48: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 psutil>=3.1.1 06:48:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37nLwv4Pvz/Render', 06:48:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:30 INFO - 'HOME': '/Users/cltbld', 06:48:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:30 INFO - 'LOGNAME': 'cltbld', 06:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:30 INFO - 'MOZ_NO_REMOTE': '1', 06:48:30 INFO - 'NO_EM_RESTART': '1', 06:48:30 INFO - 'PAGER': '/bin/cat', 06:48:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:30 INFO - 'PWD': '/builds/slave/test', 06:48:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:30 INFO - 'SHELL': '/bin/bash', 06:48:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDEKxQWyvX/Listeners', 06:48:30 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 06:48:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:30 INFO - 'USER': 'cltbld', 06:48:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:30 INFO - 'XPC_FLAGS': '0x0', 06:48:30 INFO - 'XPC_SERVICE_NAME': '0', 06:48:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:31 INFO - Downloading/unpacking psutil>=3.1.1 06:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:48:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:48:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:48:34 INFO - Installing collected packages: psutil 06:48:34 INFO - Running setup.py install for psutil 06:48:34 INFO - building 'psutil._psutil_osx' extension 06:48:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:48:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:48:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:48:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:48:35 INFO - building 'psutil._psutil_posix' extension 06:48:35 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 06:48:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:48:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:48:35 INFO - ^ 06:48:35 INFO - 1 warning generated. 06:48:35 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 06:48:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:48:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:48:35 INFO - Successfully installed psutil 06:48:35 INFO - Cleaning up... 06:48:35 INFO - Return code: 0 06:48:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:48:35 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')]} 06:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:35 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')]} 06:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:35 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 0x10d2a8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d21e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef105713f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0bcd30>, '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 0x10cf22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b4b20>, '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.37nLwv4Pvz/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.UDEKxQWyvX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 06:48:35 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 06:48:35 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 06:48:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37nLwv4Pvz/Render', 06:48:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:35 INFO - 'HOME': '/Users/cltbld', 06:48:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:35 INFO - 'LOGNAME': 'cltbld', 06:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:35 INFO - 'MOZ_NO_REMOTE': '1', 06:48:35 INFO - 'NO_EM_RESTART': '1', 06:48:35 INFO - 'PAGER': '/bin/cat', 06:48:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:35 INFO - 'PWD': '/builds/slave/test', 06:48:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:35 INFO - 'SHELL': '/bin/bash', 06:48:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDEKxQWyvX/Listeners', 06:48:35 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 06:48:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:35 INFO - 'USER': 'cltbld', 06:48:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:35 INFO - 'XPC_FLAGS': '0x0', 06:48:35 INFO - 'XPC_SERVICE_NAME': '0', 06:48:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:48:38 INFO - Installing collected packages: mozsystemmonitor 06:48:38 INFO - Running setup.py install for mozsystemmonitor 06:48:38 INFO - Successfully installed mozsystemmonitor 06:48:38 INFO - Cleaning up... 06:48:38 INFO - Return code: 0 06:48:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d2a8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d21e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef105713f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0bcd30>, '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 0x10cf22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b4b20>, '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.37nLwv4Pvz/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.UDEKxQWyvX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 06:48:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:48:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37nLwv4Pvz/Render', 06:48:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:38 INFO - 'HOME': '/Users/cltbld', 06:48:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:38 INFO - 'LOGNAME': 'cltbld', 06:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:38 INFO - 'MOZ_NO_REMOTE': '1', 06:48:38 INFO - 'NO_EM_RESTART': '1', 06:48:38 INFO - 'PAGER': '/bin/cat', 06:48:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:38 INFO - 'PWD': '/builds/slave/test', 06:48:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:38 INFO - 'SHELL': '/bin/bash', 06:48:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDEKxQWyvX/Listeners', 06:48:38 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 06:48:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:38 INFO - 'USER': 'cltbld', 06:48:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:38 INFO - 'XPC_FLAGS': '0x0', 06:48:38 INFO - 'XPC_SERVICE_NAME': '0', 06:48:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:38 INFO - Downloading/unpacking jsonschema==2.5.1 06:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:48:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:41 INFO - Downloading functools32-3.2.3-2.tar.gz 06:48:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:48:42 INFO - warning: no files found matching '*.txt' 06:48:42 INFO - no previously-included directories found matching 'build' 06:48:42 INFO - no previously-included directories found matching 'dist' 06:48:42 INFO - no previously-included directories found matching '.git*' 06:48:42 INFO - Installing collected packages: jsonschema, functools32 06:48:42 INFO - Running setup.py install for functools32 06:48:42 INFO - warning: no files found matching '*.txt' 06:48:42 INFO - no previously-included directories found matching 'build' 06:48:42 INFO - no previously-included directories found matching 'dist' 06:48:42 INFO - no previously-included directories found matching '.git*' 06:48:42 INFO - Successfully installed jsonschema functools32 06:48:42 INFO - Cleaning up... 06:48:42 INFO - Return code: 0 06:48:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:42 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 0x10d2a8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d21e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef105713f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0bcd30>, '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 0x10cf22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b4b20>, '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.37nLwv4Pvz/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.UDEKxQWyvX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 06:48:42 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 06:48:42 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 06:48:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37nLwv4Pvz/Render', 06:48:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:42 INFO - 'HOME': '/Users/cltbld', 06:48:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:42 INFO - 'LOGNAME': 'cltbld', 06:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:42 INFO - 'MOZ_NO_REMOTE': '1', 06:48:42 INFO - 'NO_EM_RESTART': '1', 06:48:42 INFO - 'PAGER': '/bin/cat', 06:48:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:42 INFO - 'PWD': '/builds/slave/test', 06:48:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:42 INFO - 'SHELL': '/bin/bash', 06:48:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDEKxQWyvX/Listeners', 06:48:42 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 06:48:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:42 INFO - 'USER': 'cltbld', 06:48:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:42 INFO - 'XPC_FLAGS': '0x0', 06:48:42 INFO - 'XPC_SERVICE_NAME': '0', 06:48:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:48:42 INFO - Cleaning up... 06:48:42 INFO - Return code: 0 06:48:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:42 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 0x10d2a8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d21e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef105713f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0bcd30>, '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 0x10cf22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b4b20>, '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.37nLwv4Pvz/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.UDEKxQWyvX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 06:48:42 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 06:48:42 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 06:48:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37nLwv4Pvz/Render', 06:48:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:42 INFO - 'HOME': '/Users/cltbld', 06:48:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:42 INFO - 'LOGNAME': 'cltbld', 06:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:42 INFO - 'MOZ_NO_REMOTE': '1', 06:48:42 INFO - 'NO_EM_RESTART': '1', 06:48:42 INFO - 'PAGER': '/bin/cat', 06:48:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:42 INFO - 'PWD': '/builds/slave/test', 06:48:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:42 INFO - 'SHELL': '/bin/bash', 06:48:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDEKxQWyvX/Listeners', 06:48:42 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 06:48:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:42 INFO - 'USER': 'cltbld', 06:48:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:42 INFO - 'XPC_FLAGS': '0x0', 06:48:42 INFO - 'XPC_SERVICE_NAME': '0', 06:48:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:42 INFO - Downloading/unpacking blobuploader==1.2.4 06:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:45 INFO - Downloading blobuploader-1.2.4.tar.gz 06:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:48:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:48: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 06:48: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 06:48: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 06:48: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 06:48: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 06:48: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 06:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:48:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:48:46 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 06:48:46 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 06:48:46 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 06:48:46 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 06:48:46 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 06:48:46 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 06:48:46 INFO - Downloading docopt-0.6.1.tar.gz 06:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:48:46 INFO - Installing collected packages: blobuploader, requests, docopt 06:48:46 INFO - Running setup.py install for blobuploader 06:48:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:48:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:48:46 INFO - Running setup.py install for requests 06:48:47 INFO - Running setup.py install for docopt 06:48:47 INFO - Successfully installed blobuploader requests docopt 06:48:47 INFO - Cleaning up... 06:48:47 INFO - Return code: 0 06:48:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48:47 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')]} 06:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:47 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')]} 06:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:47 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 0x10d2a8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d21e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef105713f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0bcd30>, '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 0x10cf22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b4b20>, '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.37nLwv4Pvz/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.UDEKxQWyvX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 06:48:47 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 06:48:47 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 06:48:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37nLwv4Pvz/Render', 06:48:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:47 INFO - 'HOME': '/Users/cltbld', 06:48:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:47 INFO - 'LOGNAME': 'cltbld', 06:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:47 INFO - 'MOZ_NO_REMOTE': '1', 06:48:47 INFO - 'NO_EM_RESTART': '1', 06:48:47 INFO - 'PAGER': '/bin/cat', 06:48:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:47 INFO - 'PWD': '/builds/slave/test', 06:48:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:47 INFO - 'SHELL': '/bin/bash', 06:48:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDEKxQWyvX/Listeners', 06:48:47 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 06:48:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:47 INFO - 'USER': 'cltbld', 06:48:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:47 INFO - 'XPC_FLAGS': '0x0', 06:48:47 INFO - 'XPC_SERVICE_NAME': '0', 06:48:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:48:47 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-9a3xpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:48:47 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-_yZulq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:48:48 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-BIflQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:48:48 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-3VqU4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:48:48 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-mLGJni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:48:48 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-5YcYFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:48:48 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-_iq4pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:48:48 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-MqkXgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:48:48 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-Yso4j2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:48:48 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-tRPtZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:48:48 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-ZXvyPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:48:48 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-zXEb73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:48:49 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-guPLIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:48:49 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-wghM0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:49 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-B5yfDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:48:49 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-Axyo_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:48:49 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-0zi2gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:48:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:48:49 INFO - Running setup.py install for manifestparser 06:48:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:48:49 INFO - Running setup.py install for mozcrash 06:48:49 INFO - Running setup.py install for mozdebug 06:48:49 INFO - Running setup.py install for mozdevice 06:48:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:48:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:48:50 INFO - Running setup.py install for mozfile 06:48:50 INFO - Running setup.py install for mozhttpd 06:48:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:48:50 INFO - Running setup.py install for mozinfo 06:48:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:48:50 INFO - Running setup.py install for mozInstall 06:48:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:48:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:48:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:48:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:48:50 INFO - Running setup.py install for mozleak 06:48:50 INFO - Running setup.py install for mozlog 06:48:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:48:51 INFO - Running setup.py install for moznetwork 06:48:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:48:51 INFO - Running setup.py install for mozprocess 06:48:51 INFO - Running setup.py install for mozprofile 06:48:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:48:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:48:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:48:51 INFO - Running setup.py install for mozrunner 06:48:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:48:51 INFO - Running setup.py install for mozscreenshot 06:48:51 INFO - Running setup.py install for moztest 06:48:51 INFO - Running setup.py install for mozversion 06:48:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:48:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:48:52 INFO - Cleaning up... 06:48:52 INFO - Return code: 0 06:48:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:52 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 0x10d2a8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d21e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef105713f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0bcd30>, '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 0x10cf22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b4b20>, '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.37nLwv4Pvz/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.UDEKxQWyvX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 06:48:52 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 06:48:52 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 06:48:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37nLwv4Pvz/Render', 06:48:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:52 INFO - 'HOME': '/Users/cltbld', 06:48:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:52 INFO - 'LOGNAME': 'cltbld', 06:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:52 INFO - 'MOZ_NO_REMOTE': '1', 06:48:52 INFO - 'NO_EM_RESTART': '1', 06:48:52 INFO - 'PAGER': '/bin/cat', 06:48:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:52 INFO - 'PWD': '/builds/slave/test', 06:48:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:52 INFO - 'SHELL': '/bin/bash', 06:48:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDEKxQWyvX/Listeners', 06:48:52 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 06:48:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:52 INFO - 'USER': 'cltbld', 06:48:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:52 INFO - 'XPC_FLAGS': '0x0', 06:48:52 INFO - 'XPC_SERVICE_NAME': '0', 06:48:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:48:52 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-ThFhjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:48:52 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)) 06:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:48:52 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-R7Yx5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:48:52 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)) 06:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:48:52 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-vYZ5Vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:48:52 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-uwkTpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:48:52 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-xAlAuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:48:52 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-gEZINo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:48:53 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)) 06:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:48:53 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-K2YOIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:48:53 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)) 06:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:48:53 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-mGT6ZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:48:53 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)) 06:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:48:53 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-zRsrCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:48:53 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)) 06:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:48:53 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-tauJC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:48:53 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-1FS3px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:48:53 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)) 06:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:48:53 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-81ucjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:48:53 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)) 06:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:48:53 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-5VUaBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:48:53 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-dsWbnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:53 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-Cus4_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:54 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)) 06:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:48:54 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-7Em0ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:48:54 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)) 06:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:48:54 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-opaTe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:48:54 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)) 06:48:54 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)) 06:48:54 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)) 06:48:54 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)) 06:48:54 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)) 06:48:54 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)) 06:48:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:56 INFO - Downloading blessings-1.6.tar.gz 06:48:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:48:56 INFO - Installing collected packages: blessings 06:48:56 INFO - Running setup.py install for blessings 06:48:56 INFO - Successfully installed blessings 06:48:56 INFO - Cleaning up... 06:48:57 INFO - Return code: 0 06:48:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:48:57 INFO - Reading from file tmpfile_stdout 06:48:57 INFO - Current package versions: 06:48:57 INFO - blessings == 1.6 06:48:57 INFO - blobuploader == 1.2.4 06:48:57 INFO - docopt == 0.6.1 06:48:57 INFO - functools32 == 3.2.3-2 06:48:57 INFO - jsonschema == 2.5.1 06:48:57 INFO - manifestparser == 1.1 06:48:57 INFO - mozInstall == 1.12 06:48:57 INFO - mozcrash == 0.17 06:48:57 INFO - mozdebug == 0.1 06:48:57 INFO - mozdevice == 0.48 06:48:57 INFO - mozfile == 1.2 06:48:57 INFO - mozhttpd == 0.7 06:48:57 INFO - mozinfo == 0.9 06:48:57 INFO - mozleak == 0.1 06:48:57 INFO - mozlog == 3.4 06:48:57 INFO - moznetwork == 0.27 06:48:57 INFO - mozprocess == 0.23 06:48:57 INFO - mozprofile == 0.28 06:48:57 INFO - mozrunner == 6.12 06:48:57 INFO - mozscreenshot == 0.1 06:48:57 INFO - mozsystemmonitor == 0.3 06:48:57 INFO - moztest == 0.7 06:48:57 INFO - mozversion == 1.4 06:48:57 INFO - psutil == 3.1.1 06:48:57 INFO - requests == 1.2.3 06:48:57 INFO - wsgiref == 0.1.2 06:48:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48: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')]} 06:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48: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')]} 06:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:57 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 0x10d2a8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d21e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef105713f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0bcd30>, '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 0x10cf22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b4b20>, '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.37nLwv4Pvz/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.UDEKxQWyvX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 06:48:57 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 06:48:57 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 06:48:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37nLwv4Pvz/Render', 06:48:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:57 INFO - 'HOME': '/Users/cltbld', 06:48:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:57 INFO - 'LOGNAME': 'cltbld', 06:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:57 INFO - 'MOZ_NO_REMOTE': '1', 06:48:57 INFO - 'NO_EM_RESTART': '1', 06:48:57 INFO - 'PAGER': '/bin/cat', 06:48:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:57 INFO - 'PWD': '/builds/slave/test', 06:48:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:57 INFO - 'SHELL': '/bin/bash', 06:48:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDEKxQWyvX/Listeners', 06:48:57 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 06:48:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:57 INFO - 'USER': 'cltbld', 06:48:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:57 INFO - 'XPC_FLAGS': '0x0', 06:48:57 INFO - 'XPC_SERVICE_NAME': '0', 06:48:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:48:57 INFO - Cleaning up... 06:48:57 INFO - Return code: 0 06:48:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:48: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')]} 06:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48: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')]} 06:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d2a8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d21e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef105713f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0bcd30>, '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 0x10cf22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b4b20>, '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.37nLwv4Pvz/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.UDEKxQWyvX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 06:48:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:48:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37nLwv4Pvz/Render', 06:48:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:57 INFO - 'HOME': '/Users/cltbld', 06:48:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:57 INFO - 'LOGNAME': 'cltbld', 06:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:57 INFO - 'MOZ_NO_REMOTE': '1', 06:48:57 INFO - 'NO_EM_RESTART': '1', 06:48:57 INFO - 'PAGER': '/bin/cat', 06:48:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:57 INFO - 'PWD': '/builds/slave/test', 06:48:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:57 INFO - 'SHELL': '/bin/bash', 06:48:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDEKxQWyvX/Listeners', 06:48:57 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 06:48:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:57 INFO - 'USER': 'cltbld', 06:48:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:57 INFO - 'XPC_FLAGS': '0x0', 06:48:57 INFO - 'XPC_SERVICE_NAME': '0', 06:48:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:48:58 INFO - Cleaning up... 06:48:58 INFO - Return code: 0 06:48:58 INFO - Running post-action listener: _resource_record_post_action 06:48:58 INFO - Running post-action listener: _start_resource_monitoring 06:48:58 INFO - Starting resource monitoring. 06:48:58 INFO - [mozharness: 2016-10-20 13:48:58.269577Z] Finished create-virtualenv step (success) 06:48:58 INFO - [mozharness: 2016-10-20 13:48:58.270553Z] Running install step. 06:48:58 INFO - Running pre-action listener: _resource_record_pre_action 06:48:58 INFO - Running main action method: install 06:48:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:48:58 INFO - Reading from file tmpfile_stdout 06:48:58 INFO - Detecting whether we're running mozinstall >=1.0... 06:48:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:48:58 INFO - Reading from file tmpfile_stdout 06:48:58 INFO - Output received: 06:48:58 INFO - Usage: mozinstall [options] installer 06:48:58 INFO - Options: 06:48:58 INFO - -h, --help show this help message and exit 06:48:58 INFO - -d DEST, --destination=DEST 06:48:58 INFO - Directory to install application into. [default: 06:48:58 INFO - "/builds/slave/test"] 06:48:58 INFO - --app=APP Application being installed. [default: firefox] 06:48:58 INFO - mkdir: /builds/slave/test/build/application 06:48:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 06:49:30 INFO - Reading from file tmpfile_stdout 06:49:30 INFO - Output received: 06:49:30 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:49:30 INFO - Running post-action listener: _resource_record_post_action 06:49:30 INFO - [mozharness: 2016-10-20 13:49:30.896023Z] Finished install step (success) 06:49:30 INFO - [mozharness: 2016-10-20 13:49:30.896126Z] Running run-tests step. 06:49:30 INFO - Running pre-action listener: _resource_record_pre_action 06:49:30 INFO - Running main action method: run_tests 06:49:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:49:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:49:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:49:30 INFO - 2016-10-20 06:49:30.909 screenresolution[1641:7776] starting screenresolution argv=screenresolution get 06:49:30 INFO - 2016-10-20 06:49:30.911 screenresolution[1641:7776] Display 0: 1600x1200x32@60 06:49:30 INFO - 2016-10-20 06:49:30.917 screenresolution[1642:7778] starting screenresolution argv=screenresolution list 06:49:30 INFO - Available Modes on Display 0 06:49:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:49:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:49:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:49:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:49:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:49:31 INFO - Intel Iris: 06:49:31 INFO - Chipset Model: Intel Iris 06:49:31 INFO - Type: GPU 06:49:31 INFO - Bus: Built-In 06:49:31 INFO - VRAM (Dynamic, Max): 1536 MB 06:49:31 INFO - Vendor: Intel (0x8086) 06:49:31 INFO - Device ID: 0x0a2e 06:49:31 INFO - Revision ID: 0x0009 06:49:31 INFO - Displays: 06:49:31 INFO - Display: 06:49:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:49:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:49:31 INFO - Display Serial Number: 1600x1200 60 06:49:31 INFO - Main Display: Yes 06:49:31 INFO - Mirror: Off 06:49:31 INFO - Online: Yes 06:49:31 INFO - Rotation: Supported 06:49:31 INFO - Return code: 0 06:49:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:49:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:49:31 INFO - Python 2.7.3 06:49:31 INFO - Return code: 0 06:49:31 INFO - grabbing minidump binary from tooltool 06:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:31 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 0x10d0bcd30>, '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 0x10cf22db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0b4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:49:31 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 06:49:31 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 06:49:31 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 06:49:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:49:31 INFO - Return code: 0 06:49:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:49:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:49:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:49:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:49:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:49:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0332', '--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 06:49:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0332 --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 06:49:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.37nLwv4Pvz/Render', 06:49:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:49:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:49:31 INFO - 'HOME': '/Users/cltbld', 06:49:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:49:31 INFO - 'LOGNAME': 'cltbld', 06:49:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:49:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:49:31 INFO - 'MOZ_NO_REMOTE': '1', 06:49:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:49:31 INFO - 'NO_EM_RESTART': '1', 06:49:31 INFO - 'PAGER': '/bin/cat', 06:49:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:49:31 INFO - 'PWD': '/builds/slave/test', 06:49:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:49:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:49:31 INFO - 'SHELL': '/bin/bash', 06:49:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDEKxQWyvX/Listeners', 06:49:31 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 06:49:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:49:31 INFO - 'USER': 'cltbld', 06:49:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:49:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:49:31 INFO - 'XPC_FLAGS': '0x0', 06:49:31 INFO - 'XPC_SERVICE_NAME': '0', 06:49:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:49:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0332', '--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 06:49:31 INFO - mozversion application_buildid: 20161020050549 06:49:31 INFO - mozversion application_changeset: 0895f2ef1268cb87b507dfa1e4d7633621215264 06:49:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:49:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:49:31 INFO - mozversion application_name: Firefox 06:49:31 INFO - mozversion application_remotingname: firefox-dev 06:49:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:49:31 INFO - mozversion application_vendor: Mozilla 06:49:31 INFO - mozversion application_version: 51.0a2 06:49:31 INFO - mozversion platform_buildid: 20161020050549 06:49:31 INFO - mozversion platform_changeset: 0895f2ef1268cb87b507dfa1e4d7633621215264 06:49:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:49:31 INFO - mozversion platform_version: 51.0a2 06:49:31 INFO - using testdate: 1476971371 06:49:31 INFO - actual date: 1476971371 06:49:31 INFO - starting webserver on 'localhost:49280' 06:49:31 INFO - SUITE-START | Running 2 tests 06:49:31 INFO - TEST-START | dromaeo_css 06:49:31 INFO - operating with platform_type : mac_ 06:49:31 INFO - Initialising browser for dromaeo_css test... 06:49:31 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/tmpvAZ70u/profile http://localhost:49280/getInfo.html) 06:49:33 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 06:49:33 INFO - PROCESS | 1652 | colorDepth:24 06:49:33 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 06:49:33 INFO - PROCESS | 1652 | __metrics 06:49:33 INFO - PROCESS | 1652 | 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" 06:49:33 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:49:34 INFO - TEST-INFO | 1652: exit 0 06:49:34 INFO - Browser initialized. 06:49:34 INFO - Running cycle 1/1 for dromaeo_css test... 06:49:34 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/tmpvAZ70u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:49:46 INFO - PROCESS | 1653 | RSS: Main: 219701248 06:49:46 INFO - PROCESS | 1653 | 06:50:37 INFO - PROCESS | 1653 | 1476971437636 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] 06:52:50 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 06:52:51 INFO - PROCESS | 1653 | RSS: Main: 313712640 06:52:51 INFO - PROCESS | 1653 | 06:55:54 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 06:55:54 INFO - PROCESS | 1653 | RSS: Main: 349921280 06:55:54 INFO - PROCESS | 1653 | 06:58:57 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 06:58:57 INFO - PROCESS | 1653 | RSS: Main: 321474560 06:58:57 INFO - PROCESS | 1653 | 07:02:00 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 07:02:00 INFO - PROCESS | 1653 | RSS: Main: 316928000 07:02:00 INFO - PROCESS | 1653 | 07:05:03 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 07:05:04 INFO - PROCESS | 1653 | RSS: Main: 310267904 07:05:04 INFO - PROCESS | 1653 | 07:08:07 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 07:08:08 INFO - PROCESS | 1653 | RSS: Main: 391217152 07:08:08 INFO - PROCESS | 1653 | 07:08:08 INFO - PROCESS | 1653 | __start_tp_report 07:08:08 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 07:08:08 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 07:08:08 INFO - PROCESS | 1653 | |i|pagename|runs| 07:08:08 INFO - PROCESS | 1653 | |0;dojo.html;2545.9872700636492;2756.421151558173;3302.983485082574;3317.3033662930784;3318.6017677878644;5531.087370583854;5552.139418390146;5588.524975377093;5591.245181900442;5631.155326700997;5460.0274643262355;5508.421615730341;5511.421300763413;5530.142827861688;5542.057850165472;4990.925136122952;5005.124103281929;5020.397552293712;5064.746762661871;5103.336566246383;5023.949760502384;5043.344365232515;5046.142155833517;5080.2379643053655;5109.591232701375;5166.302549155872;5176.66351687141;5180.818671346504;5185.170372740362;5187.559057480119;5148.176291793333;5165.7158856262895;5168.689878607277;5170.870728231786;5177.715225662587;4999.525045120708;5112.079825631385;5119.8208062717995;5133.537981581639;5139.203423469368;5604.355499117612;5621.381648018714;5632.971835140798;5645.915311270334;5653.745581448804;6092.403605606959;6095.817125486243;6104.572679912408;6136.509079273647;6139.907901381483;6105.611380716572;6137.598912956614;6166.907496387557;6187.907181392283;6213.1922850029205;5627.521660658849;5642.322921249435;5676.744546495376;5701.714914254312;5707.1724599933195;6125.20492926512;6221.4089661482085;6323.462505686976;6334.049892516114;6377.394147555975;5887.146363777314;5904.822855314347;5948.553858460633;6001.309849367379;6005.459508644243;6214.725787283137;6229.906551401733;6255.249370075529;6267.2792628847355;6270.655113968684;5934.7922822701;6142.969285153546;6176.474999625082;6182.752689892444;6190.226221722285;6029.969850150721;6085.513158947274;6090.390960903874;6132.172156758869;6132.7873996921435;4888;4903.117438860968;4915.3855768029;4916.606671466274;4918.385201849769;4291.914161716811;4411.250087485135;4428.535003824616;4429.424174857312;4449.1991441540185;5489.478499542617;5516.558675306046;5526.889462210734;5546.694931778791;5600.803971861047;6115.784757827684;6122.123558664931;6127.864175486541;6131.388317934179;6140.754369825247;5028.321176641107;5564.721763911869;5569.749361278752;5570.08093664549;5596.048671725816;5233.607479439057;5240.292560504283;5244.973775131176;5308.601854860901;5309.41596424393;6249.250089989139;6250.687465626609;6282.089097080898;6284.717187726472;6297.874042519215;5254.448282930391;6101.60339577926;6225.657588832658;6229.5327850410495;6235.345288744798;6171.907421388593;6192.566520343533;6234.9688251558455;6268.592541484789;6285.96857015712;6017.308009578779;6059.969700151471;6085;6119.563485741731;6137.693115344304;6079.939200607937;6177.752889884354;6211.875762484635;6218.53360997936;6233.127362169391;5976.731047102804;5992.760289588367;6008.399160083956;6021.976264035212;6072.514198864169;4860.975695121501;4894.853154405374;5872.882542349043;5912.586118971631;5972.731227094878;5853.09277062056;5866.090755932837;5866.911996320144;5868.882622347614;5892.1161825726485;5782.739776709974;5833;5834.474897259267;5908.143319218603;6014.699265036818;5668.348139963957;5740.483356497935;5793.04414771558;5843.328017277898;5853.590248682552 07:08:08 INFO - PROCESS | 1653 | |1;ext.html;486.63502373220086;496.47373783789175;501.8042963244333;516.7312997241435;520.5185203686589;30863.537046944286;41387.96530086746;42500.57499425005;42522.99999999996;44641.330380044325;44290.557094429045;44385.11229775403;44422.55577444225;44460.11079778402;44782.552174478245;9755;9937.205023598131;9943.502824858764;9957.850632240523;9960.302778805486;8796.428232164888;9009.144131307548;9017.458952462874;9094.99955004949;9099.272058235358;11965.341906195155;12218.266903985745;12256.754864902696;12383.071269654767;12453.066020048487;11942.761144777056;12140.392980350991;12259.203151795105;12271.447784849703;12272.938635306811;12021.699457513545;12060.396980150957;12062.6381208563;12066.396680165957;12072.879271207263;41459.792701036604;41773.791131044454;41790.79104604488;41821.1635767286;41842.37236441456;3232.4343239933155;3285.3593549257903;3321.9501707474406;3748.194138260287;3921.098147426108;31095.37809243825;31902.361952760813;32080.839595802106;32353.867614633375;33000.834995825106;3155.8737650493954;3207.8235697036653;3273.819939903304;3301.356235534072;3301.504774283853;511758.8824111748;515640;516055.41972290276;516565;516801;33932.1516962073;62183.6890815543;62742.37257627365;62864.37135628676;62922.685386572775;34790;35966.820165899;36160.819195904376;36175.63824361723;36196;12771.93614031924;14619.049761765451;14642.04826686262;15057.54827355181;15209.6197595061;12762.61712148637;12845.357732113356;12860.935695321463;12874.871251287555;12889.484420623257;7364.779056628203;7486.887696684554;7704.92295077042;7859.253370929752;7915;3207.3104282579357;3230.1117192772176;3236.9190770230935;3240.303334782986;3261.2116640272225;908.6092980018524;949.5489642419795;955.9325071819364;1030.7783826477344;1032.789829764305;30552.08343749691;30684.53973190404;30888;31260.531092033638;31365.90219342312;896.2964073202505;922.5710044829186;985.2265971212564;1023.9334443261164;1049.6903413493037;13129.934350328187;15765.605859853365;15981.840181598267;16030;16088.276027578788;694758;701844;702270;705883.4705826438;709318;59492.10761838576;60363;60442;60464.395356046756;60749.69625151846;1140.2588317593631;1231.759806837676;1259.3514340114848;1371.3965855023757;1389.7776355783026;25398.746012540378;28653.713462865104;31714.84142579272;32095.518567221978;32130.097203648966;40825.1834963305;51521.48478515167;52152.174673886235;52261.47738522566;52326.21510677419;559123;563232;563853;564151;564231;27010.594841077793;27272;27361.31596710098;27637.447251054466;27896.442071158057;46626.300605491626;46732.53267467282;49191.508084920126;49310.76723081952;49426.764330892016;39621.40567891541;40514.1897162061;40605.59394406018;41165.79417103015;42378.576214237466;40464.79767601143;40478.392824108254;41443.916566655986;41528.58471415368;41817;39353;39686.404703928885;40245.79877100596;40427.19145617013;40448;31617.20956976094;35220.64779352173;35975.640243598275;36290.4556431659;36296;25927.61108583335;26240;26354.604680929417;26481.470370592095;26779.33051673724 07:08:08 INFO - PROCESS | 1653 | |2;jquery.html;341.375283231686;347.63324692449487;373.8205661282586;377.9074126838923;398.87036713068244;14964.925175374121;14990.775138372934;16035.759463608056;20475.385738427834;20890.68663970038;19817;20220.292289769863;20493.385198444033;20894.89552552235;21078.367648970554;5439.694473326393;5907.320658124317;6140.84647883802;6161.845953851145;6172.22847144107;5150.587952963772;5883.382244864292;6106.664133472657;6149.262088549381;6162.599431036968;5975.611585246967;5986.102084687288;6127.877442451148;6135.355787642278;6140.8464788380425;5816.476517113459;6007.789727359565;6008.8497787555225;6019.277686677627;6022.2773267207995;5061.190209566488;5080.060188865072;5177.611679124081;5189.481051894818;5238.81664141757;25208.24375268745;25916.481670366677;25944.292255703716;26130.6080408794;26150.73849261502;2354.7880690737743;2408.421978725093;2419.3830573203722;2426.9514609707885;2459;14688.559343219613;15175.468858590008;15334.769978450333;15571.987820791726;15937.442189523426;1831.9084045797656;1836.6877630802796;1869.3831035758167;1873.7095750158746;1874.756281683386;121254.78745212611;122854.38572807079;122980.38509807482;123178.38410807979;123657;10204.846927296096;10410.635627752992;10644.361338319572;10800.651797942506;10967.945160274148;13442.529511467248;13444.798328025088;13463.663408414868;13469.932650336881;13496.865031349756;8258;8267.173282671685;8363.498190108612;8551.358648101417;8622.741317760478;8603.82792344162;8605.827883442422;8630.956845215735;8762.255208307237;8797.780055498535;6340.334264902119;6449.258335291502;6470.676466176672;6475.514336424787;6574.80275591733;1478.526871401163;1660.3607611069824;1785.6250187460519;1839.6228773101482;1845.796962334142;882.9205371516595;901.7745563609097;950.2303134461108;961.697065424403;977.2768151567931;20564.897175514026;22055.558888822135;22110;22187.778122218893;22191.334259972227;868.4962721621571;977.3061126600052;979.5543027922279;989.3074847606704;1003.0420947994793;10650.786984260272;11511.654650360502;11624.709382265342;11632.651020469399;11666.241694289844;594931;604093;608848;609566;625064;86148;87515.56242218876;96373.51813240889;97083;108251.91748082418;951.5860600638882;954.4416516337881;998.7952469743685;999.8450240212778;1002.3735165521549;17725.29098836032;19626.313079042164;20138;20227.595448090662;20384.694229586865;50091;50625.74687126541;51458;52231.73884130555;53357.733211333696;46750.53249467462;50627.746861265456;77259;78273.60863195648;80064.59967700124;7784.649690763816;7791.259830316111;7808.102068261996;8004.719834805754;8083.83832323362;12042.698932526757;13023.934880325538;13208.867911320764;13274.535391261259;13356.599302020955;11353.205275630626;11517.481713322753;11738;11815.82276265874;11838.585649502225;11041.944790275997;11219.326840389604;11385.658430247106;11718;11721.941390292994;11330.660080197607;11566.537338506365;11610.593629223275;11789.705257368634;11919;7758.107817601048;7986.3610911128135;7992;8391.916080839113;8502.022267439324;9444.716658500256;10104.949475252577;10575.418351990407;11023.83464248021;11205.66383008511 07:08:08 INFO - PROCESS | 1653 | |3;mootools.html;1527.1066426140703;1539.8614124728774;1743.8953662780234;1883.3314173468427;1887.8584106192038;8267.75196744098;8810.77973050674;8818.16227458392;8822.60298286578;8823;7705.845883082335;7892.171322011192;7901.209879012096;8404.537750423724;8609.483430994145;2336.135629816966;2377.7859992600747;2379.4646204604;2384.8926798294033;2388.2238272561485;2344.4842134730334;2344.9531009379803;2346.155384061736;2392.35406440261;2403.158894386959;2307.9538409231805;2323.0939933425975;2323.372689373868;2327.0226504867996;2335.871527066011;2336.8130549555995;2351.200591798788;2356.2695564374926;2359.1742889988536;2366.136360228513;2357.26924653358;2363.6572696959015;2364.746684257329;2366.668666386707;2369.336585755991;8572.228499435081;8758.86861697075;8762.474251544863;8767.473951562926;8776.122387761237;5085.669431486942;5245.711485868275;5256.106461901486;5256.342957130359;5262.158054711266;3424.880129195491;3496.2483066140903;3621.2395396966403;3624.6012938576737;3625.1299688074937;1089.3518356577824;1093.1254996003165;1099.2964502718266;1117.580907159815;1120.2942146447685;11267.15496337778;11428.371439570821;11436.485358158903;11439.48522316506;11442.256253343507;4527.909441811145;4593.150267200512;4749.928751068736;4776.9761151194025;4780.832670856504;9757;9765.267604929659;9765.707028789147;9770.56032478526;9797.657082002095;5176.016556854186;5242.554382877422;5257.973710131501;5263.605229607795;5286.5506431952945;4271.850485233002;4313.827446902089;4723.385959825201;4805.3512775774825;4814.8796280093275;3890.708196885245;3895.5520115187114;3965.3457179565626;3984.2828290907914;4001.779902105354;1284.556827894375;1292.9806052909214;1298.1237664576374;1306.7778477658821;1313.1070871807071;811.8407520209104;831.8918540589806;922.6309476209569;933.4725879877983;940.6331530703031;5164.8192313268855;5590.608657394025;5727.455891690282;5846.239988801429;6025.15647809307;442.34312046610756;446.03433566328533;452.13641943887677;457.63846561216934;458.0426907762792;3886.7084968627464;3914.8042597870563;4009.7393669411395;4036.7577945323374;4041.3533834586915;9796.461194634363;10586.735331616617;10693.984071513194;10703.1437485001;10715.46422678863;10240.180785537139;10637.361758294526;10649.787004260026;10657.73355666099;10658;7980.042394912648;8127.512349259064;8136.023677158779;8137.104918458965;8140.267375936076;5610.4670056344585;5697.857553561194;5780.132980053026;5872.94127058741;5917;9756.07317304855;9793.999999999714;9836.3606365586;9901.306908516335;9939.453330066915;9592.472414017297;9879.357841740552;9934.652287169914;10112.797744045225;10122;6838.623875686885;7005.789826305219;7139.32176443237;7298.525595836254;7360.852782944204;8174.713885013996;8228.753137405887;8244.711435099744;8338.749837504885;8387.664493420194;7297.489175757646;7426.70293188288;7445.851082978202;7480.551166930001;7577.583232922242;7093.82265443368;7213.242609526134;7265.309795569412;7309.817254568678;7379.889301660587;5494.697791621499;6862.593168400565;6942.166939967236;6946.235914049349;6947.756828510978;4993.101241776515;5002.974985125051;5003.2745251938995;5013.39839219296;5047.520485553867;4902.754862256944;4971.875703107451;4975.527324904128;5107.489251074863;5150.484951504969 07:08:08 INFO - PROCESS | 1653 | |4;prototype.html;294.3994251726478;297.2346208513079;303.5022562996686;307.77993734479855;311.21884070981827;4346.826126954922;4436.645068394529;5307.787688492461;5380.838574842751;5489.890202195964;4407.625351845089;4982.551570358667;4987.401511818587;5116.411612664545;5304.2043693446;3362.6973572378542;3751.3247615429214;4041.575634558373;4044.9797751011206;4081.9387709184384;3394.6096198937194;3583.441203076657;4064.4512990746166;4068.4304197412384;4095.5904409559103;3297.746856194655;3386.441237195872;3642.289753498069;4076.8980775480554;4165.916681666365;3715.9628403716024;4006.1787333596544;4019.2363450944226;4019.6784257259496;4026.355783074694;3458.4985177149174;3461.273132642148;3467.49721290414;3469.2541103662834;3469.444888817777;4774.973380723161;4879.756012199376;5243.475652434764;5265.209828658275;5293.258943747878;4474.6420286377015;4597.60920321773;4627.514111018362;4636.652251081148;4691.668915070304;4472.910541789146;5292.497212764782;5498.752556134984;5637.548996080303;5645.887082258373;3652.5982141964364;3827.2154208387215;3858.344081506151;3868.207017561393;3880.8059597020037;5684.090545512699;5914.013423221289;5921.200637913869;5950.821475355746;6008.188894499231;3868.9226215475533;3877.9806100969313;3910.393888947218;3911.8044097794996;3914.7651140931634;3967.7222594418113;3976.721629485908;3981.1838573092446;3981.3477406875822;3997.940545755377;4459.264221403432;4601.861944141681;4659.58063774262;4675.644063221695;4678.274867395559;5448.575383954181;5636.605437619327;5669.688167150846;5679.882085487988;5692.345380281238;1313.6847156682327;1337.4716986790359;1347.8854297384637;1350.1966330033615;1350.4058214385639;727.2727272727273;820.4216027700456;823.7775800533942;837.9107160691077;871.6426265231224;4654.509837237129;4986.927810520756;5192.324997750268;5252.868678283074;5274.472552744694;5319.547838433699;5401.946620408982;5455.972720136453;5704.828855134353;5823.621464604787;4494.235979883428;4983.676061056092;5153.799653282637;5217.556507696889;5250.553702935294;2770;2999.3851260491547;3003.785949034512;3006.0460700544822;3020;5217.530422261939;5459.672419654833;5603.13151461516;5937.871804357158;5973.223480947536;4621.491635920046;5636.8016473575335;5651;5747.534378733396;5747.6838773867;5038.647294689483;5455.290812194468;5912.9113063304085;5954.8809023819285;5990.9101363479585;5019.644695932151;5214.687118772886;5600;5632.746526406239;5733.254676891977;5172.767225474788;5622.269105016485;5668.914966275592;5687.146927960839;5689.857753556194;5081.822136225214;5843.824685259449;5928.911066334094;5943.494802941798;6026.337102918763;3525.3301872644115;3670.871519496805;3680.4847321375564;3810.3903375459795;3848.288066707668;5752.482276595127;5763.049096898964;5813.540943138825;5814.447627475383;5866.794662186803;5254.108520932385;5447.291852059207;5676.893005863982;5705.600607957404;5717.399128244098;4628.67599268048;5157.819476318311;5207.71357575337;5593.776248949996;5629.577781666309;4501.762015445778;4878.999805040029;5223.503767142115;5459.727013649381;5470.945290547043;5408.918866216931;5561.749721262472;5569.582281328998;5637.295338082739;5666.971665141813;4442.600165985077;5421.647592906448;5535.308086489189;5554.888902222014;5589.329280486205 07:08:08 INFO - PROCESS | 1653 | |5;yui.html;699.55578207838;738.7672883041841;763.1338430880952;777.6189667063139;789.4710543935563;14901.4784482543;16737.83262167378;17156.82843171568;17178.141092945334;17181.14094295285;16539.503814885542;16543.007419554837;16545.751813722803;16578.83421165788;16603.584910377245;672.609886265967;693.4868197533839;823.0411570520351;845.9915400846005;853.3685073045964;692.2765709833236;826.7891687619649;837.798928257217;854.2354592639584;857.0272740439615;900.1583519409373;903.5888670654837;904.0372003815947;906.4425378392274;906.7370462565848;709.6593635055151;731.9780406587757;899.3479727197795;900.7162743735702;903.0653273861521;645.515863102673;660.2308310817891;662.059874977533;662.5329142954206;665.1353240786957;15371.154586497738;15398.846011539854;15428.228588570639;15437.382504699799;15446.304916278683;13334;13571.524996625169;13603.047786654937;13633.795493067611;13874.236916969563;12308.830661087271;12700.491980320776;12724.300163491005;12738.617841464678;13266.867331326659;4523.185826551219;4523.276275795857;4536.183486972343;4638.46657634373;4715.7877895494785;111435;112851.43574282076;113053.43473282582;113060.86939130585;116296.83703163029;10556.894431055745;10590.523426445829;10718.08896243828;10883.346999180074;11131.165162612837;20778.1688732449;21243;21310.36068917904;21416.78583214179;21688.240911568337;7962.800929976797;8032.959835200903;8055.637496312563;8077.717279895293;8215.973003374578;4156.251874662529;4260.914781704349;4323.4379530661445;4382.868513944587;4505.774711264424;3561.3767590672046;3691.243295124493;3704.666580007812;3708.072981754561;3710.7959062251293;662.6786008785735;670.1823774994499;681.9522633415613;683.8803209438428;688.1466980943594;597.2027343496394;637.9266384365765;668.5019660352971;669.3908543225641;699.8880179171308;9556.187724043395;9587.328886977844;9612.423254604746;9646.324757267064;9692.806143877084;596.4214711729616;635.2186810223451;670.4334837062675;676.2594958520413;685.6434653980002;4284.143171365677;4563.771811409416;4628.976855115703;4640.65195110368;4716.174669432836;147879;151003;157657.42342576658;160925;169401.15299423423;112604;116823;127809.36095319464;132254;133698;86835;103581;106692;108170.99999999843;114923.4253828759;7973.760787176394;9832.213422926292;10001.249906256915;10037.598496060076;10089.29374943747;61295.69352153211;63502.68248658727;64383.678081611164;66003.33996660163;66349;82662;92206;98445;106830;108753;13110.803337949748;13607.523736669169;13781.724365512835;14276.898576689393;14807.703845923237;12697.746045079231;14383.928080359532;14407.78388324197;15418.46035388756;15454.227288635298;14313.212773297568;14706.970512064052;14877;14966;14996.700065998837;13813.654658633615;14112.858871411154;14124.011319207557;14435;15137.470188543348;13504.594862154152;13708.725825483236;13717.931410343284;13884.88920886347;14431.927840360731;10283.897161028293;10554.683359499228;10691.358518488916;10806.459677016275;11245.943770281096;11347.716307092389;11681.2856773474;11700.765984680429;11741.47163377633;11810.881891180978 07:08:08 INFO - PROCESS | 1653 | __end_tp_report 07:08:08 INFO - PROCESS | 1653 | __start_cc_report 07:08:08 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1024 07:08:08 INFO - PROCESS | 1653 | __end_cc_report 07:08:08 INFO - PROCESS | 1653 | __startTimestamp1476972488033__endTimestamp 07:08:08 INFO - PROCESS | 1653 | 07:08:08 INFO - PROCESS | 1653 | ------- Summary: start ------- 07:08:08 INFO - PROCESS | 1653 | Number of tests: 6 07:08:08 INFO - PROCESS | 1653 | 07:08:08 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5620.69 Median:5833.00 stddev:670.26 (11.5%) stddev-sans-first:627.41 07:08:08 INFO - PROCESS | 1653 | Values: 2546.0 2756.4 3303.0 3317.3 3318.6 5531.1 5552.1 5588.5 5591.2 5631.2 5460.0 5508.4 5511.4 5530.1 5542.1 4990.9 5005.1 5020.4 5064.7 5103.3 5023.9 5043.3 5046.1 5080.2 5109.6 5166.3 5176.7 5180.8 5185.2 5187.6 5148.2 5165.7 5168.7 5170.9 5177.7 4999.5 5112.1 5119.8 5133.5 5139.2 5604.4 5621.4 5633.0 5645.9 5653.7 6092.4 6095.8 6104.6 6136.5 6139.9 6105.6 6137.6 6166.9 6187.9 6213.2 5627.5 5642.3 5676.7 5701.7 5707.2 6125.2 6221.4 6323.5 6334.0 6377.4 5887.1 5904.8 5948.6 6001.3 6005.5 6214.7 6229.9 6255.2 6267.3 6270.7 5934.8 6143.0 6176.5 6182.8 6190.2 6030.0 6085.5 6090.4 6132.2 6132.8 4888.0 4903.1 4915.4 4916.6 4918.4 4291.9 4411.3 4428.5 4429.4 4449.2 5489.5 5516.6 5526.9 5546.7 5600.8 6115.8 6122.1 6127.9 6131.4 6140.8 5028.3 5564.7 5569.7 5570.1 5596.0 5233.6 5240.3 5245.0 5308.6 5309.4 6249.3 6250.7 6282.1 6284.7 6297.9 5254.4 6101.6 6225.7 6229.5 6235.3 6171.9 6192.6 6235.0 6268.6 6286.0 6017.3 6060.0 6085.0 6119.6 6137.7 6079.9 6177.8 6211.9 6218.5 6233.1 5976.7 5992.8 6008.4 6022.0 6072.5 4861.0 4894.9 5872.9 5912.6 5972.7 5853.1 5866.1 5866.9 5868.9 5892.1 5782.7 5833.0 5834.5 5908.1 6014.7 5668.3 5740.5 5793.0 5843.3 5853.6 07:08:08 INFO - PROCESS | 1653 | 07:08:08 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:71730.22 Median:21637.05 stddev:160446.76 (741.5%) stddev-sans-first:160807.69 07:08:08 INFO - PROCESS | 1653 | Values: 486.6 496.5 501.8 516.7 520.5 30863.5 41388.0 42500.6 42523.0 44641.3 44290.6 44385.1 44422.6 44460.1 44782.6 9755.0 9937.2 9943.5 9957.9 9960.3 8796.4 9009.1 9017.5 9095.0 9099.3 11965.3 12218.3 12256.8 12383.1 12453.1 11942.8 12140.4 12259.2 12271.4 12272.9 12021.7 12060.4 12062.6 12066.4 12072.9 41459.8 41773.8 41790.8 41821.2 41842.4 3232.4 3285.4 3322.0 3748.2 3921.1 31095.4 31902.4 32080.8 32353.9 33000.8 3155.9 3207.8 3273.8 3301.4 3301.5 511758.9 515640.0 516055.4 516565.0 516801.0 33932.2 62183.7 62742.4 62864.4 62922.7 34790.0 35966.8 36160.8 36175.6 36196.0 12771.9 14619.0 14642.0 15057.5 15209.6 12762.6 12845.4 12860.9 12874.9 12889.5 7364.8 7486.9 7704.9 7859.3 7915.0 3207.3 3230.1 3236.9 3240.3 3261.2 908.6 949.5 955.9 1030.8 1032.8 30552.1 30684.5 30888.0 31260.5 31365.9 896.3 922.6 985.2 1023.9 1049.7 13129.9 15765.6 15981.8 16030.0 16088.3 694758.0 701844.0 702270.0 705883.5 709318.0 59492.1 60363.0 60442.0 60464.4 60749.7 1140.3 1231.8 1259.4 1371.4 1389.8 25398.7 28653.7 31714.8 32095.5 32130.1 40825.2 51521.5 52152.2 52261.5 52326.2 559123.0 563232.0 563853.0 564151.0 564231.0 27010.6 27272.0 27361.3 27637.4 27896.4 46626.3 46732.5 49191.5 49310.8 49426.8 39621.4 40514.2 40605.6 41165.8 42378.6 40464.8 40478.4 41443.9 41528.6 41817.0 39353.0 39686.4 40245.8 40427.2 40448.0 31617.2 35220.6 35975.6 36290.5 36296.0 25927.6 26240.0 26354.6 26481.5 26779.3 07:08:08 INFO - PROCESS | 1653 | 07:08:08 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:34351.51 Median:26140.67 stddev:100762.89 (385.5%) stddev-sans-first:101013.20 07:08:08 INFO - PROCESS | 1653 | Values: 341.4 347.6 373.8 377.9 398.9 14964.9 14990.8 16035.8 20475.4 20890.7 19817.0 20220.3 20493.4 20894.9 21078.4 5439.7 5907.3 6140.8 6161.8 6172.2 5150.6 5883.4 6106.7 6149.3 6162.6 5975.6 5986.1 6127.9 6135.4 6140.8 5816.5 6007.8 6008.8 6019.3 6022.3 5061.2 5080.1 5177.6 5189.5 5238.8 25208.2 25916.5 25944.3 26130.6 26150.7 2354.8 2408.4 2419.4 2427.0 2459.0 14688.6 15175.5 15334.8 15572.0 15937.4 1831.9 1836.7 1869.4 1873.7 1874.8 121254.8 122854.4 122980.4 123178.4 123657.0 10204.8 10410.6 10644.4 10800.7 10967.9 13442.5 13444.8 13463.7 13469.9 13496.9 8258.0 8267.2 8363.5 8551.4 8622.7 8603.8 8605.8 8631.0 8762.3 8797.8 6340.3 6449.3 6470.7 6475.5 6574.8 1478.5 1660.4 1785.6 1839.6 1845.8 882.9 901.8 950.2 961.7 977.3 20564.9 22055.6 22110.0 22187.8 22191.3 868.5 977.3 979.6 989.3 1003.0 10650.8 11511.7 11624.7 11632.7 11666.2 594931.0 604093.0 608848.0 609566.0 625064.0 86148.0 87515.6 96373.5 97083.0 108251.9 951.6 954.4 998.8 999.8 1002.4 17725.3 19626.3 20138.0 20227.6 20384.7 50091.0 50625.7 51458.0 52231.7 53357.7 46750.5 50627.7 77259.0 78273.6 80064.6 7784.6 7791.3 7808.1 8004.7 8083.8 12042.7 13023.9 13208.9 13274.5 13356.6 11353.2 11517.5 11738.0 11815.8 11838.6 11041.9 11219.3 11385.7 11718.0 11721.9 11330.7 11566.5 11610.6 11789.7 11919.0 7758.1 7986.4 7992.0 8391.9 8502.0 9444.7 10104.9 10575.4 11023.8 11205.7 07:08:08 INFO - PROCESS | 1653 | 07:08:08 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5620.57 Median:5003.12 stddev:3143.11 (62.8%) stddev-sans-first:3136.87 07:08:08 INFO - PROCESS | 1653 | Values: 1527.1 1539.9 1743.9 1883.3 1887.9 8267.8 8810.8 8818.2 8822.6 8823.0 7705.8 7892.2 7901.2 8404.5 8609.5 2336.1 2377.8 2379.5 2384.9 2388.2 2344.5 2345.0 2346.2 2392.4 2403.2 2308.0 2323.1 2323.4 2327.0 2335.9 2336.8 2351.2 2356.3 2359.2 2366.1 2357.3 2363.7 2364.7 2366.7 2369.3 8572.2 8758.9 8762.5 8767.5 8776.1 5085.7 5245.7 5256.1 5256.3 5262.2 3424.9 3496.2 3621.2 3624.6 3625.1 1089.4 1093.1 1099.3 1117.6 1120.3 11267.2 11428.4 11436.5 11439.5 11442.3 4527.9 4593.2 4749.9 4777.0 4780.8 9757.0 9765.3 9765.7 9770.6 9797.7 5176.0 5242.6 5258.0 5263.6 5286.6 4271.9 4313.8 4723.4 4805.4 4814.9 3890.7 3895.6 3965.3 3984.3 4001.8 1284.6 1293.0 1298.1 1306.8 1313.1 811.8 831.9 922.6 933.5 940.6 5164.8 5590.6 5727.5 5846.2 6025.2 442.3 446.0 452.1 457.6 458.0 3886.7 3914.8 4009.7 4036.8 4041.4 9796.5 10586.7 10694.0 10703.1 10715.5 10240.2 10637.4 10649.8 10657.7 10658.0 7980.0 8127.5 8136.0 8137.1 8140.3 5610.5 5697.9 5780.1 5872.9 5917.0 9756.1 9794.0 9836.4 9901.3 9939.5 9592.5 9879.4 9934.7 10112.8 10122.0 6838.6 7005.8 7139.3 7298.5 7360.9 8174.7 8228.8 8244.7 8338.7 8387.7 7297.5 7426.7 7445.9 7480.6 7577.6 7093.8 7213.2 7265.3 7309.8 7379.9 5494.7 6862.6 6942.2 6946.2 6947.8 4993.1 5003.0 5003.3 5013.4 5047.5 4902.8 4971.9 4975.5 5107.5 5150.5 07:08:08 INFO - PROCESS | 1653 | 07:08:08 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4514.91 Median:5135.11 stddev:1393.49 (27.1%) stddev-sans-first:1360.92 07:08:08 INFO - PROCESS | 1653 | Values: 294.4 297.2 303.5 307.8 311.2 4346.8 4436.6 5307.8 5380.8 5489.9 4407.6 4982.6 4987.4 5116.4 5304.2 3362.7 3751.3 4041.6 4045.0 4081.9 3394.6 3583.4 4064.5 4068.4 4095.6 3297.7 3386.4 3642.3 4076.9 4165.9 3716.0 4006.2 4019.2 4019.7 4026.4 3458.5 3461.3 3467.5 3469.3 3469.4 4775.0 4879.8 5243.5 5265.2 5293.3 4474.6 4597.6 4627.5 4636.7 4691.7 4472.9 5292.5 5498.8 5637.5 5645.9 3652.6 3827.2 3858.3 3868.2 3880.8 5684.1 5914.0 5921.2 5950.8 6008.2 3868.9 3878.0 3910.4 3911.8 3914.8 3967.7 3976.7 3981.2 3981.3 3997.9 4459.3 4601.9 4659.6 4675.6 4678.3 5448.6 5636.6 5669.7 5679.9 5692.3 1313.7 1337.5 1347.9 1350.2 1350.4 727.3 820.4 823.8 837.9 871.6 4654.5 4986.9 5192.3 5252.9 5274.5 5319.5 5401.9 5456.0 5704.8 5823.6 4494.2 4983.7 5153.8 5217.6 5250.6 2770.0 2999.4 3003.8 3006.0 3020.0 5217.5 5459.7 5603.1 5937.9 5973.2 4621.5 5636.8 5651.0 5747.5 5747.7 5038.6 5455.3 5912.9 5954.9 5990.9 5019.6 5214.7 5600.0 5632.7 5733.3 5172.8 5622.3 5668.9 5687.1 5689.9 5081.8 5843.8 5928.9 5943.5 6026.3 3525.3 3670.9 3680.5 3810.4 3848.3 5752.5 5763.0 5813.5 5814.4 5866.8 5254.1 5447.3 5676.9 5705.6 5717.4 4628.7 5157.8 5207.7 5593.8 5629.6 4501.8 4879.0 5223.5 5459.7 5470.9 5408.9 5561.7 5569.6 5637.3 5667.0 4442.6 5421.6 5535.3 5554.9 5589.3 07:08:08 INFO - PROCESS | 1653 | 07:08:08 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:25371.15 Median:21276.68 stddev:40290.84 (189.4%) stddev-sans-first:40361.28 07:08:08 INFO - PROCESS | 1653 | Values: 699.6 738.8 763.1 777.6 789.5 14901.5 16737.8 17156.8 17178.1 17181.1 16539.5 16543.0 16545.8 16578.8 16603.6 672.6 693.5 823.0 846.0 853.4 692.3 826.8 837.8 854.2 857.0 900.2 903.6 904.0 906.4 906.7 709.7 732.0 899.3 900.7 903.1 645.5 660.2 662.1 662.5 665.1 15371.2 15398.8 15428.2 15437.4 15446.3 13334.0 13571.5 13603.0 13633.8 13874.2 12308.8 12700.5 12724.3 12738.6 13266.9 4523.2 4523.3 4536.2 4638.5 4715.8 111435.0 112851.4 113053.4 113060.9 116296.8 10556.9 10590.5 10718.1 10883.3 11131.2 20778.2 21243.0 21310.4 21416.8 21688.2 7962.8 8033.0 8055.6 8077.7 8216.0 4156.3 4260.9 4323.4 4382.9 4505.8 3561.4 3691.2 3704.7 3708.1 3710.8 662.7 670.2 682.0 683.9 688.1 597.2 637.9 668.5 669.4 699.9 9556.2 9587.3 9612.4 9646.3 9692.8 596.4 635.2 670.4 676.3 685.6 4284.1 4563.8 4629.0 4640.7 4716.2 147879.0 151003.0 157657.4 160925.0 169401.2 112604.0 116823.0 127809.4 132254.0 133698.0 86835.0 103581.0 106692.0 108171.0 114923.4 7973.8 9832.2 10001.2 10037.6 10089.3 61295.7 63502.7 64383.7 66003.3 66349.0 82662.0 92206.0 98445.0 106830.0 108753.0 13110.8 13607.5 13781.7 14276.9 14807.7 12697.7 14383.9 14407.8 15418.5 15454.2 14313.2 14707.0 14877.0 14966.0 14996.7 13813.7 14112.9 14124.0 14435.0 15137.5 13504.6 13708.7 13717.9 13884.9 14431.9 10283.9 10554.7 10691.4 10806.5 11245.9 11347.7 11681.3 11700.8 11741.5 11810.9 07:08:08 INFO - PROCESS | 1653 | -------- Summary: end -------- 07:08:08 INFO - PROCESS | 1653 | 07:08:08 INFO - TEST-INFO | 1653: exit 0 07:08:08 INFO - TEST-OK | dromaeo_css | took 1117166ms 07:08:08 INFO - TEST-START | kraken 07:08:08 INFO - operating with platform_type : mac_ 07:08:08 INFO - Initialising browser for kraken test... 07:08:08 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/tmpSbWIDq/profile http://localhost:49280/getInfo.html) 07:08:10 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 07:08:10 INFO - PROCESS | 1662 | colorDepth:24 07:08:10 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 07:08:10 INFO - PROCESS | 1662 | __metrics 07:08:10 INFO - PROCESS | 1662 | 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" 07:08:10 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:08:11 INFO - TEST-INFO | 1662: exit 0 07:08:11 INFO - Browser initialized. 07:08:11 INFO - Running cycle 1/1 for kraken test... 07:08:11 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/tmpSbWIDq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:08:23 INFO - PROCESS | 1663 | RSS: Main: 219615232 07:08:23 INFO - PROCESS | 1663 | 07:08:26 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 07:08:27 INFO - PROCESS | 1663 | RSS: Main: 270184448 07:08:27 INFO - PROCESS | 1663 | 07:08:29 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 07:08:30 INFO - PROCESS | 1663 | RSS: Main: 280866816 07:08:30 INFO - PROCESS | 1663 | 07:08:33 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 07:08:34 INFO - PROCESS | 1663 | RSS: Main: 379195392 07:08:34 INFO - PROCESS | 1663 | 07:08:36 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 07:08:36 INFO - PROCESS | 1663 | RSS: Main: 281042944 07:08:36 INFO - PROCESS | 1663 | 07:08:38 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:08:39 INFO - PROCESS | 1663 | RSS: Main: 281583616 07:08:39 INFO - PROCESS | 1663 | 07:08:42 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 07:08:42 INFO - PROCESS | 1663 | RSS: Main: 318623744 07:08:42 INFO - PROCESS | 1663 | 07:08:46 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 07:08:46 INFO - PROCESS | 1663 | RSS: Main: 319234048 07:08:46 INFO - PROCESS | 1663 | 07:08:49 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 07:08:49 INFO - PROCESS | 1663 | RSS: Main: 319434752 07:08:49 INFO - PROCESS | 1663 | 07:08:51 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:08:52 INFO - PROCESS | 1663 | RSS: Main: 290586624 07:08:52 INFO - PROCESS | 1663 | 07:08:54 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:08:54 INFO - PROCESS | 1663 | RSS: Main: 295907328 07:08:54 INFO - PROCESS | 1663 | 07:08:56 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:08:57 INFO - PROCESS | 1663 | RSS: Main: 298532864 07:08:57 INFO - PROCESS | 1663 | 07:09:00 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:09:01 INFO - PROCESS | 1663 | RSS: Main: 311029760 07:09:01 INFO - PROCESS | 1663 | 07:09:03 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:09:04 INFO - PROCESS | 1663 | RSS: Main: 310784000 07:09:04 INFO - PROCESS | 1663 | 07:09:06 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 07:09:06 INFO - PROCESS | 1663 | RSS: Main: 354594816 07:09:06 INFO - PROCESS | 1663 | 07:09:06 INFO - PROCESS | 1663 | __start_tp_report 07:09:06 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 07:09:06 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 07:09:06 INFO - PROCESS | 1663 | |i|pagename|runs| 07:09:06 INFO - PROCESS | 1663 | |0;ai-astar;113;115;113;114;112;113;113;113;114;113 07:09:06 INFO - PROCESS | 1663 | |1;audio-beat-detection;143;110;108;143;111;108;107;109;140;108 07:09:06 INFO - PROCESS | 1663 | |2;audio-dft;183;184;185;185;196;260;204;184;186;182 07:09:06 INFO - PROCESS | 1663 | |3;audio-fft;81;59;59;91;77;86;49;73;97;82 07:09:06 INFO - PROCESS | 1663 | |4;audio-oscillator;87;72;95;69;68;69;91;67;68;89 07:09:06 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;88;86;89;86;88;86;90;86;87;85 07:09:06 INFO - PROCESS | 1663 | |6;imaging-darkroom;96;96;97;97;129;162;156;95;115;168 07:09:06 INFO - PROCESS | 1663 | |7;imaging-desaturate;84;86;86;85;88;84;85;84;84;83 07:09:06 INFO - PROCESS | 1663 | |8;json-parse-financial;58;55;54;55;56;58;58;58;58;58 07:09:06 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;64;65;74;78;72;69;69;72;71;72 07:09:06 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;80;82;82;84;93;100;99;83;86;83 07:09:06 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;135;140;139;139;138;141;137;136;172;138 07:09:06 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;163;164;166;164;167;164;165;165;164;160 07:09:06 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;67;67;68;79;85;86;86;72;65;65 07:09:06 INFO - PROCESS | 1663 | __end_tp_report 07:09:06 INFO - PROCESS | 1663 | __start_cc_report 07:09:06 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1968 07:09:06 INFO - PROCESS | 1663 | __end_cc_report 07:09:06 INFO - PROCESS | 1663 | __startTimestamp1476972546626__endTimestamp 07:09:06 INFO - PROCESS | 1663 | 07:09:06 INFO - PROCESS | 1663 | ------- Summary: start ------- 07:09:06 INFO - PROCESS | 1663 | Number of tests: 14 07:09:06 INFO - PROCESS | 1663 | 07:09:06 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 07:09:06 INFO - PROCESS | 1663 | Values: 113.0 115.0 113.0 114.0 112.0 113.0 113.0 113.0 114.0 113.0 07:09:06 INFO - PROCESS | 1663 | 07:09:06 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:118.70 Median:110.50 stddev:16.14 (14.6%) stddev-sans-first:14.53 07:09:06 INFO - PROCESS | 1663 | Values: 143.0 110.0 108.0 143.0 111.0 108.0 107.0 109.0 140.0 108.0 07:09:06 INFO - PROCESS | 1663 | 07:09:06 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:194.90 Median:185.50 stddev:23.90 (12.9%) stddev-sans-first:24.96 07:09:06 INFO - PROCESS | 1663 | Values: 183.0 184.0 185.0 185.0 196.0 260.0 204.0 184.0 186.0 182.0 07:09:06 INFO - PROCESS | 1663 | 07:09:06 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:75.40 Median:81.50 stddev:15.42 (18.9%) stddev-sans-first:16.22 07:09:06 INFO - PROCESS | 1663 | Values: 81.0 59.0 59.0 91.0 77.0 86.0 49.0 73.0 97.0 82.0 07:09:06 INFO - PROCESS | 1663 | 07:09:06 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:79.50 stddev:11.43 (14.4%) stddev-sans-first:11.60 07:09:06 INFO - PROCESS | 1663 | Values: 87.0 72.0 95.0 69.0 68.0 69.0 91.0 67.0 68.0 89.0 07:09:06 INFO - PROCESS | 1663 | 07:09:06 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:87.50 stddev:1.60 (1.8%) stddev-sans-first:1.66 07:09:06 INFO - PROCESS | 1663 | Values: 88.0 86.0 89.0 86.0 88.0 86.0 90.0 86.0 87.0 85.0 07:09:06 INFO - PROCESS | 1663 | 07:09:06 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:121.10 Median:95.50 stddev:30.36 (31.8%) stddev-sans-first:30.81 07:09:06 INFO - PROCESS | 1663 | Values: 96.0 96.0 97.0 97.0 129.0 162.0 156.0 95.0 115.0 168.0 07:09:06 INFO - PROCESS | 1663 | 07:09:06 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:1.45 (1.7%) stddev-sans-first:1.50 07:09:06 INFO - PROCESS | 1663 | Values: 84.0 86.0 86.0 85.0 88.0 84.0 85.0 84.0 84.0 83.0 07:09:06 INFO - PROCESS | 1663 | 07:09:06 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:58.00 stddev:1.62 (2.8%) stddev-sans-first:1.66 07:09:06 INFO - PROCESS | 1663 | Values: 58.0 55.0 54.0 55.0 56.0 58.0 58.0 58.0 58.0 58.0 07:09:06 INFO - PROCESS | 1663 | 07:09:06 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:72.00 stddev:4.12 (5.7%) stddev-sans-first:3.61 07:09:06 INFO - PROCESS | 1663 | Values: 64.0 65.0 74.0 78.0 72.0 69.0 69.0 72.0 71.0 72.0 07:09:06 INFO - PROCESS | 1663 | 07:09:06 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:83.50 stddev:7.38 (8.8%) stddev-sans-first:7.35 07:09:06 INFO - PROCESS | 1663 | Values: 80.0 82.0 82.0 84.0 93.0 100.0 99.0 83.0 86.0 83.0 07:09:06 INFO - PROCESS | 1663 | 07:09:06 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:139.00 stddev:10.87 (7.8%) stddev-sans-first:11.27 07:09:06 INFO - PROCESS | 1663 | Values: 135.0 140.0 139.0 139.0 138.0 141.0 137.0 136.0 172.0 138.0 07:09:06 INFO - PROCESS | 1663 | 07:09:06 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:164.50 stddev:1.87 (1.1%) stddev-sans-first:1.94 07:09:06 INFO - PROCESS | 1663 | Values: 163.0 164.0 166.0 164.0 167.0 164.0 165.0 165.0 164.0 160.0 07:09:06 INFO - PROCESS | 1663 | 07:09:06 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.00 Median:75.50 stddev:9.03 (12.0%) stddev-sans-first:9.22 07:09:06 INFO - PROCESS | 1663 | Values: 67.0 67.0 68.0 79.0 85.0 86.0 86.0 72.0 65.0 65.0 07:09:06 INFO - PROCESS | 1663 | -------- Summary: end -------- 07:09:06 INFO - PROCESS | 1663 | 07:09:07 INFO - TEST-INFO | 1663: exit 0 07:09:07 INFO - TEST-OK | kraken | took 58790ms 07:09:07 INFO - SUITE-END | took 1175s 07:09:07 INFO - Completed test suite (00:19:36) 07:09:07 INFO - javascript benchmark 07:09:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2545.9872700636492, 2756.421151558173, 3302.983485082574, 3317.3033662930784, 3318.6017677878644, 5531.087370583854, 5552.139418390146, 5588.524975377093, 5591.245181900442, 5631.155326700997, 5460.0274643262355, 5508.421615730341, 5511.421300763413, 5530.142827861688, 5542.057850165472, 4990.925136122952, 5005.124103281929, 5020.397552293712, 5064.746762661871, 5103.336566246383, 5023.949760502384, 5043.344365232515, 5046.142155833517, 5080.2379643053655, 5109.591232701375, 5166.302549155872, 5176.66351687141, 5180.818671346504, 5185.170372740362, 5187.559057480119, 5148.176291793333, 5165.7158856262895, 5168.689878607277, 5170.870728231786, 5177.715225662587, 4999.525045120708, 5112.079825631385, 5119.8208062717995, 5133.537981581639, 5139.203423469368, 5604.355499117612, 5621.381648018714, 5632.971835140798, 5645.915311270334, 5653.745581448804, 6092.403605606959, 6095.817125486243, 6104.572679912408, 6136.509079273647, 6139.907901381483, 6105.611380716572, 6137.598912956614, 6166.907496387557, 6187.907181392283, 6213.1922850029205, 5627.521660658849, 5642.322921249435, 5676.744546495376, 5701.714914254312, 5707.1724599933195, 6125.20492926512, 6221.4089661482085, 6323.462505686976, 6334.049892516114, 6377.394147555975, 5887.146363777314, 5904.822855314347, 5948.553858460633, 6001.309849367379, 6005.459508644243, 6214.725787283137, 6229.906551401733, 6255.249370075529, 6267.2792628847355, 6270.655113968684, 5934.7922822701, 6142.969285153546, 6176.474999625082, 6182.752689892444, 6190.226221722285, 6029.969850150721, 6085.513158947274, 6090.390960903874, 6132.172156758869, 6132.7873996921435, 4888.0, 4903.117438860968, 4915.3855768029, 4916.606671466274, 4918.385201849769, 4291.914161716811, 4411.250087485135, 4428.535003824616, 4429.424174857312, 4449.1991441540185, 5489.478499542617, 5516.558675306046, 5526.889462210734, 5546.694931778791, 5600.803971861047, 6115.784757827684, 6122.123558664931, 6127.864175486541, 6131.388317934179, 6140.754369825247, 5028.321176641107, 5564.721763911869, 5569.749361278752, 5570.08093664549, 5596.048671725816, 5233.607479439057, 5240.292560504283, 5244.973775131176, 5308.601854860901, 5309.41596424393, 6249.250089989139, 6250.687465626609, 6282.089097080898, 6284.717187726472, 6297.874042519215, 5254.448282930391, 6101.60339577926, 6225.657588832658, 6229.5327850410495, 6235.345288744798, 6171.907421388593, 6192.566520343533, 6234.9688251558455, 6268.592541484789, 6285.96857015712, 6017.308009578779, 6059.969700151471, 6085.0, 6119.563485741731, 6137.693115344304, 6079.939200607937, 6177.752889884354, 6211.875762484635, 6218.53360997936, 6233.127362169391, 5976.731047102804, 5992.760289588367, 6008.399160083956, 6021.976264035212, 6072.514198864169, 4860.975695121501, 4894.853154405374, 5872.882542349043, 5912.586118971631, 5972.731227094878, 5853.09277062056, 5866.090755932837, 5866.911996320144, 5868.882622347614, 5892.1161825726485, 5782.739776709974, 5833.0, 5834.474897259267, 5908.143319218603, 6014.699265036818, 5668.348139963957, 5740.483356497935, 5793.04414771558, 5843.328017277898, 5853.590248682552], "value": 5573.98288034056, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.63502373220086, 496.47373783789175, 501.8042963244333, 516.7312997241435, 520.5185203686589, 30863.537046944286, 41387.96530086746, 42500.57499425005, 42522.99999999996, 44641.330380044325, 44290.557094429045, 44385.11229775403, 44422.55577444225, 44460.11079778402, 44782.552174478245, 9755.0, 9937.205023598131, 9943.502824858764, 9957.850632240523, 9960.302778805486, 8796.428232164888, 9009.144131307548, 9017.458952462874, 9094.99955004949, 9099.272058235358, 11965.341906195155, 12218.266903985745, 12256.754864902696, 12383.071269654767, 12453.066020048487, 11942.761144777056, 12140.392980350991, 12259.203151795105, 12271.447784849703, 12272.938635306811, 12021.699457513545, 12060.396980150957, 12062.6381208563, 12066.396680165957, 12072.879271207263, 41459.792701036604, 41773.791131044454, 41790.79104604488, 41821.1635767286, 41842.37236441456, 3232.4343239933155, 3285.3593549257903, 3321.9501707474406, 3748.194138260287, 3921.098147426108, 31095.37809243825, 31902.361952760813, 32080.839595802106, 32353.867614633375, 33000.834995825106, 3155.8737650493954, 3207.8235697036653, 3273.819939903304, 3301.356235534072, 3301.504774283853, 511758.8824111748, 515640.0, 516055.41972290276, 516565.0, 516801.0, 33932.1516962073, 62183.6890815543, 62742.37257627365, 62864.37135628676, 62922.685386572775, 34790.0, 35966.820165899, 36160.819195904376, 36175.63824361723, 36196.0, 12771.93614031924, 14619.049761765451, 14642.04826686262, 15057.54827355181, 15209.6197595061, 12762.61712148637, 12845.357732113356, 12860.935695321463, 12874.871251287555, 12889.484420623257, 7364.779056628203, 7486.887696684554, 7704.92295077042, 7859.253370929752, 7915.0, 3207.3104282579357, 3230.1117192772176, 3236.9190770230935, 3240.303334782986, 3261.2116640272225, 908.6092980018524, 949.5489642419795, 955.9325071819364, 1030.7783826477344, 1032.789829764305, 30552.08343749691, 30684.53973190404, 30888.0, 31260.531092033638, 31365.90219342312, 896.2964073202505, 922.5710044829186, 985.2265971212564, 1023.9334443261164, 1049.6903413493037, 13129.934350328187, 15765.605859853365, 15981.840181598267, 16030.0, 16088.276027578788, 694758.0, 701844.0, 702270.0, 705883.4705826438, 709318.0, 59492.10761838576, 60363.0, 60442.0, 60464.395356046756, 60749.69625151846, 1140.2588317593631, 1231.759806837676, 1259.3514340114848, 1371.3965855023757, 1389.7776355783026, 25398.746012540378, 28653.713462865104, 31714.84142579272, 32095.518567221978, 32130.097203648966, 40825.1834963305, 51521.48478515167, 52152.174673886235, 52261.47738522566, 52326.21510677419, 559123.0, 563232.0, 563853.0, 564151.0, 564231.0, 27010.594841077793, 27272.0, 27361.31596710098, 27637.447251054466, 27896.442071158057, 46626.300605491626, 46732.53267467282, 49191.508084920126, 49310.76723081952, 49426.764330892016, 39621.40567891541, 40514.1897162061, 40605.59394406018, 41165.79417103015, 42378.576214237466, 40464.79767601143, 40478.392824108254, 41443.916566655986, 41528.58471415368, 41817.0, 39353.0, 39686.404703928885, 40245.79877100596, 40427.19145617013, 40448.0, 31617.20956976094, 35220.64779352173, 35975.640243598275, 36290.4556431659, 36296.0, 25927.61108583335, 26240.0, 26354.604680929417, 26481.470370592095, 26779.33051673724], "value": 19280.701618515774, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.375283231686, 347.63324692449487, 373.8205661282586, 377.9074126838923, 398.87036713068244, 14964.925175374121, 14990.775138372934, 16035.759463608056, 20475.385738427834, 20890.68663970038, 19817.0, 20220.292289769863, 20493.385198444033, 20894.89552552235, 21078.367648970554, 5439.694473326393, 5907.320658124317, 6140.84647883802, 6161.845953851145, 6172.22847144107, 5150.587952963772, 5883.382244864292, 6106.664133472657, 6149.262088549381, 6162.599431036968, 5975.611585246967, 5986.102084687288, 6127.877442451148, 6135.355787642278, 6140.8464788380425, 5816.476517113459, 6007.789727359565, 6008.8497787555225, 6019.277686677627, 6022.2773267207995, 5061.190209566488, 5080.060188865072, 5177.611679124081, 5189.481051894818, 5238.81664141757, 25208.24375268745, 25916.481670366677, 25944.292255703716, 26130.6080408794, 26150.73849261502, 2354.7880690737743, 2408.421978725093, 2419.3830573203722, 2426.9514609707885, 2459.0, 14688.559343219613, 15175.468858590008, 15334.769978450333, 15571.987820791726, 15937.442189523426, 1831.9084045797656, 1836.6877630802796, 1869.3831035758167, 1873.7095750158746, 1874.756281683386, 121254.78745212611, 122854.38572807079, 122980.38509807482, 123178.38410807979, 123657.0, 10204.846927296096, 10410.635627752992, 10644.361338319572, 10800.651797942506, 10967.945160274148, 13442.529511467248, 13444.798328025088, 13463.663408414868, 13469.932650336881, 13496.865031349756, 8258.0, 8267.173282671685, 8363.498190108612, 8551.358648101417, 8622.741317760478, 8603.82792344162, 8605.827883442422, 8630.956845215735, 8762.255208307237, 8797.780055498535, 6340.334264902119, 6449.258335291502, 6470.676466176672, 6475.514336424787, 6574.80275591733, 1478.526871401163, 1660.3607611069824, 1785.6250187460519, 1839.6228773101482, 1845.796962334142, 882.9205371516595, 901.7745563609097, 950.2303134461108, 961.697065424403, 977.2768151567931, 20564.897175514026, 22055.558888822135, 22110.0, 22187.778122218893, 22191.334259972227, 868.4962721621571, 977.3061126600052, 979.5543027922279, 989.3074847606704, 1003.0420947994793, 10650.786984260272, 11511.654650360502, 11624.709382265342, 11632.651020469399, 11666.241694289844, 594931.0, 604093.0, 608848.0, 609566.0, 625064.0, 86148.0, 87515.56242218876, 96373.51813240889, 97083.0, 108251.91748082418, 951.5860600638882, 954.4416516337881, 998.7952469743685, 999.8450240212778, 1002.3735165521549, 17725.29098836032, 19626.313079042164, 20138.0, 20227.595448090662, 20384.694229586865, 50091.0, 50625.74687126541, 51458.0, 52231.73884130555, 53357.733211333696, 46750.53249467462, 50627.746861265456, 77259.0, 78273.60863195648, 80064.59967700124, 7784.649690763816, 7791.259830316111, 7808.102068261996, 8004.719834805754, 8083.83832323362, 12042.698932526757, 13023.934880325538, 13208.867911320764, 13274.535391261259, 13356.599302020955, 11353.205275630626, 11517.481713322753, 11738.0, 11815.82276265874, 11838.585649502225, 11041.944790275997, 11219.326840389604, 11385.658430247106, 11718.0, 11721.941390292994, 11330.660080197607, 11566.537338506365, 11610.593629223275, 11789.705257368634, 11919.0, 7758.107817601048, 7986.3610911128135, 7992.0, 8391.916080839113, 8502.022267439324, 9444.716658500256, 10104.949475252577, 10575.418351990407, 11023.83464248021, 11205.66383008511], "value": 9628.363204321875, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1527.1066426140703, 1539.8614124728774, 1743.8953662780234, 1883.3314173468427, 1887.8584106192038, 8267.75196744098, 8810.77973050674, 8818.16227458392, 8822.60298286578, 8823.0, 7705.845883082335, 7892.171322011192, 7901.209879012096, 8404.537750423724, 8609.483430994145, 2336.135629816966, 2377.7859992600747, 2379.4646204604, 2384.8926798294033, 2388.2238272561485, 2344.4842134730334, 2344.9531009379803, 2346.155384061736, 2392.35406440261, 2403.158894386959, 2307.9538409231805, 2323.0939933425975, 2323.372689373868, 2327.0226504867996, 2335.871527066011, 2336.8130549555995, 2351.200591798788, 2356.2695564374926, 2359.1742889988536, 2366.136360228513, 2357.26924653358, 2363.6572696959015, 2364.746684257329, 2366.668666386707, 2369.336585755991, 8572.228499435081, 8758.86861697075, 8762.474251544863, 8767.473951562926, 8776.122387761237, 5085.669431486942, 5245.711485868275, 5256.106461901486, 5256.342957130359, 5262.158054711266, 3424.880129195491, 3496.2483066140903, 3621.2395396966403, 3624.6012938576737, 3625.1299688074937, 1089.3518356577824, 1093.1254996003165, 1099.2964502718266, 1117.580907159815, 1120.2942146447685, 11267.15496337778, 11428.371439570821, 11436.485358158903, 11439.48522316506, 11442.256253343507, 4527.909441811145, 4593.150267200512, 4749.928751068736, 4776.9761151194025, 4780.832670856504, 9757.0, 9765.267604929659, 9765.707028789147, 9770.56032478526, 9797.657082002095, 5176.016556854186, 5242.554382877422, 5257.973710131501, 5263.605229607795, 5286.5506431952945, 4271.850485233002, 4313.827446902089, 4723.385959825201, 4805.3512775774825, 4814.8796280093275, 3890.708196885245, 3895.5520115187114, 3965.3457179565626, 3984.2828290907914, 4001.779902105354, 1284.556827894375, 1292.9806052909214, 1298.1237664576374, 1306.7778477658821, 1313.1070871807071, 811.8407520209104, 831.8918540589806, 922.6309476209569, 933.4725879877983, 940.6331530703031, 5164.8192313268855, 5590.608657394025, 5727.455891690282, 5846.239988801429, 6025.15647809307, 442.34312046610756, 446.03433566328533, 452.13641943887677, 457.63846561216934, 458.0426907762792, 3886.7084968627464, 3914.8042597870563, 4009.7393669411395, 4036.7577945323374, 4041.3533834586915, 9796.461194634363, 10586.735331616617, 10693.984071513194, 10703.1437485001, 10715.46422678863, 10240.180785537139, 10637.361758294526, 10649.787004260026, 10657.73355666099, 10658.0, 7980.042394912648, 8127.512349259064, 8136.023677158779, 8137.104918458965, 8140.267375936076, 5610.4670056344585, 5697.857553561194, 5780.132980053026, 5872.94127058741, 5917.0, 9756.07317304855, 9793.999999999714, 9836.3606365586, 9901.306908516335, 9939.453330066915, 9592.472414017297, 9879.357841740552, 9934.652287169914, 10112.797744045225, 10122.0, 6838.623875686885, 7005.789826305219, 7139.32176443237, 7298.525595836254, 7360.852782944204, 8174.713885013996, 8228.753137405887, 8244.711435099744, 8338.749837504885, 8387.664493420194, 7297.489175757646, 7426.70293188288, 7445.851082978202, 7480.551166930001, 7577.583232922242, 7093.82265443368, 7213.242609526134, 7265.309795569412, 7309.817254568678, 7379.889301660587, 5494.697791621499, 6862.593168400565, 6942.166939967236, 6946.235914049349, 6947.756828510978, 4993.101241776515, 5002.974985125051, 5003.2745251938995, 5013.39839219296, 5047.520485553867, 4902.754862256944, 4971.875703107451, 4975.527324904128, 5107.489251074863, 5150.484951504969], "value": 4465.543664455045, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.3994251726478, 297.2346208513079, 303.5022562996686, 307.77993734479855, 311.21884070981827, 4346.826126954922, 4436.645068394529, 5307.787688492461, 5380.838574842751, 5489.890202195964, 4407.625351845089, 4982.551570358667, 4987.401511818587, 5116.411612664545, 5304.2043693446, 3362.6973572378542, 3751.3247615429214, 4041.575634558373, 4044.9797751011206, 4081.9387709184384, 3394.6096198937194, 3583.441203076657, 4064.4512990746166, 4068.4304197412384, 4095.5904409559103, 3297.746856194655, 3386.441237195872, 3642.289753498069, 4076.8980775480554, 4165.916681666365, 3715.9628403716024, 4006.1787333596544, 4019.2363450944226, 4019.6784257259496, 4026.355783074694, 3458.4985177149174, 3461.273132642148, 3467.49721290414, 3469.2541103662834, 3469.444888817777, 4774.973380723161, 4879.756012199376, 5243.475652434764, 5265.209828658275, 5293.258943747878, 4474.6420286377015, 4597.60920321773, 4627.514111018362, 4636.652251081148, 4691.668915070304, 4472.910541789146, 5292.497212764782, 5498.752556134984, 5637.548996080303, 5645.887082258373, 3652.5982141964364, 3827.2154208387215, 3858.344081506151, 3868.207017561393, 3880.8059597020037, 5684.090545512699, 5914.013423221289, 5921.200637913869, 5950.821475355746, 6008.188894499231, 3868.9226215475533, 3877.9806100969313, 3910.393888947218, 3911.8044097794996, 3914.7651140931634, 3967.7222594418113, 3976.721629485908, 3981.1838573092446, 3981.3477406875822, 3997.940545755377, 4459.264221403432, 4601.861944141681, 4659.58063774262, 4675.644063221695, 4678.274867395559, 5448.575383954181, 5636.605437619327, 5669.688167150846, 5679.882085487988, 5692.345380281238, 1313.6847156682327, 1337.4716986790359, 1347.8854297384637, 1350.1966330033615, 1350.4058214385639, 727.2727272727273, 820.4216027700456, 823.7775800533942, 837.9107160691077, 871.6426265231224, 4654.509837237129, 4986.927810520756, 5192.324997750268, 5252.868678283074, 5274.472552744694, 5319.547838433699, 5401.946620408982, 5455.972720136453, 5704.828855134353, 5823.621464604787, 4494.235979883428, 4983.676061056092, 5153.799653282637, 5217.556507696889, 5250.553702935294, 2770.0, 2999.3851260491547, 3003.785949034512, 3006.0460700544822, 3020.0, 5217.530422261939, 5459.672419654833, 5603.13151461516, 5937.871804357158, 5973.223480947536, 4621.491635920046, 5636.8016473575335, 5651.0, 5747.534378733396, 5747.6838773867, 5038.647294689483, 5455.290812194468, 5912.9113063304085, 5954.8809023819285, 5990.9101363479585, 5019.644695932151, 5214.687118772886, 5600.0, 5632.746526406239, 5733.254676891977, 5172.767225474788, 5622.269105016485, 5668.914966275592, 5687.146927960839, 5689.857753556194, 5081.822136225214, 5843.824685259449, 5928.911066334094, 5943.494802941798, 6026.337102918763, 3525.3301872644115, 3670.871519496805, 3680.4847321375564, 3810.3903375459795, 3848.288066707668, 5752.482276595127, 5763.049096898964, 5813.540943138825, 5814.447627475383, 5866.794662186803, 5254.108520932385, 5447.291852059207, 5676.893005863982, 5705.600607957404, 5717.399128244098, 4628.67599268048, 5157.819476318311, 5207.71357575337, 5593.776248949996, 5629.577781666309, 4501.762015445778, 4878.999805040029, 5223.503767142115, 5459.727013649381, 5470.945290547043, 5408.918866216931, 5561.749721262472, 5569.582281328998, 5637.295338082739, 5666.971665141813, 4442.600165985077, 5421.647592906448, 5535.308086489189, 5554.888902222014, 5589.329280486205], "value": 4065.5326462736757, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.55578207838, 738.7672883041841, 763.1338430880952, 777.6189667063139, 789.4710543935563, 14901.4784482543, 16737.83262167378, 17156.82843171568, 17178.141092945334, 17181.14094295285, 16539.503814885542, 16543.007419554837, 16545.751813722803, 16578.83421165788, 16603.584910377245, 672.609886265967, 693.4868197533839, 823.0411570520351, 845.9915400846005, 853.3685073045964, 692.2765709833236, 826.7891687619649, 837.798928257217, 854.2354592639584, 857.0272740439615, 900.1583519409373, 903.5888670654837, 904.0372003815947, 906.4425378392274, 906.7370462565848, 709.6593635055151, 731.9780406587757, 899.3479727197795, 900.7162743735702, 903.0653273861521, 645.515863102673, 660.2308310817891, 662.059874977533, 662.5329142954206, 665.1353240786957, 15371.154586497738, 15398.846011539854, 15428.228588570639, 15437.382504699799, 15446.304916278683, 13334.0, 13571.524996625169, 13603.047786654937, 13633.795493067611, 13874.236916969563, 12308.830661087271, 12700.491980320776, 12724.300163491005, 12738.617841464678, 13266.867331326659, 4523.185826551219, 4523.276275795857, 4536.183486972343, 4638.46657634373, 4715.7877895494785, 111435.0, 112851.43574282076, 113053.43473282582, 113060.86939130585, 116296.83703163029, 10556.894431055745, 10590.523426445829, 10718.08896243828, 10883.346999180074, 11131.165162612837, 20778.1688732449, 21243.0, 21310.36068917904, 21416.78583214179, 21688.240911568337, 7962.800929976797, 8032.959835200903, 8055.637496312563, 8077.717279895293, 8215.973003374578, 4156.251874662529, 4260.914781704349, 4323.4379530661445, 4382.868513944587, 4505.774711264424, 3561.3767590672046, 3691.243295124493, 3704.666580007812, 3708.072981754561, 3710.7959062251293, 662.6786008785735, 670.1823774994499, 681.9522633415613, 683.8803209438428, 688.1466980943594, 597.2027343496394, 637.9266384365765, 668.5019660352971, 669.3908543225641, 699.8880179171308, 9556.187724043395, 9587.328886977844, 9612.423254604746, 9646.324757267064, 9692.806143877084, 596.4214711729616, 635.2186810223451, 670.4334837062675, 676.2594958520413, 685.6434653980002, 4284.143171365677, 4563.771811409416, 4628.976855115703, 4640.65195110368, 4716.174669432836, 147879.0, 151003.0, 157657.42342576658, 160925.0, 169401.15299423423, 112604.0, 116823.0, 127809.36095319464, 132254.0, 133698.0, 86835.0, 103581.0, 106692.0, 108170.99999999843, 114923.4253828759, 7973.760787176394, 9832.213422926292, 10001.249906256915, 10037.598496060076, 10089.29374943747, 61295.69352153211, 63502.68248658727, 64383.678081611164, 66003.33996660163, 66349.0, 82662.0, 92206.0, 98445.0, 106830.0, 108753.0, 13110.803337949748, 13607.523736669169, 13781.724365512835, 14276.898576689393, 14807.703845923237, 12697.746045079231, 14383.928080359532, 14407.78388324197, 15418.46035388756, 15454.227288635298, 14313.212773297568, 14706.970512064052, 14877.0, 14966.0, 14996.700065998837, 13813.654658633615, 14112.858871411154, 14124.011319207557, 14435.0, 15137.470188543348, 13504.594862154152, 13708.725825483236, 13717.931410343284, 13884.88920886347, 14431.927840360731, 10283.897161028293, 10554.683359499228, 10691.358518488916, 10806.459677016275, 11245.943770281096, 11347.716307092389, 11681.2856773474, 11700.765984680429, 11741.47163377633, 11810.881891180978], "value": 7989.273312654615, "unit": "score"}], "name": "dromaeo_css", "value": 7290.0597564638065, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 113.0, 114.0, 112.0, 113.0, 113.0, 113.0, 114.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 108.0, 143.0, 111.0, 108.0, 107.0, 109.0, 140.0, 108.0], "value": 118.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 185.0, 185.0, 196.0, 260.0, 204.0, 184.0, 186.0, 182.0], "value": 194.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 91.0, 77.0, 86.0, 49.0, 73.0, 97.0, 82.0], "value": 75.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 95.0, 69.0, 68.0, 69.0, 91.0, 67.0, 68.0, 89.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 86.0, 88.0, 86.0, 90.0, 86.0, 87.0, 85.0], "value": 87.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 97.0, 129.0, 162.0, 156.0, 95.0, 115.0, 168.0], "value": 121.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 86.0, 85.0, 88.0, 84.0, 85.0, 84.0, 84.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 54.0, 55.0, 56.0, 58.0, 58.0, 58.0, 58.0, 58.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 74.0, 78.0, 72.0, 69.0, 69.0, 72.0, 71.0, 72.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 82.0, 84.0, 93.0, 100.0, 99.0, 83.0, 86.0, 83.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 140.0, 139.0, 139.0, 138.0, 141.0, 137.0, 136.0, 172.0, 138.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 166.0, 164.0, 167.0, 164.0, 165.0, 165.0, 164.0, 160.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 79.0, 85.0, 86.0, 86.0, 72.0, 65.0, 65.0], "value": 74.0, "unit": "score"}], "name": "kraken", "value": 1467.2, "alertThreshold": 2.0}]} 07:09:07 INFO - Return code: 0 07:09:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:09:07 INFO - # TBPL SUCCESS # 07:09:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:09:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:09:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:09:07 INFO - 2016-10-20 07:09:07.958 screenresolution[1667:10027] starting screenresolution argv=screenresolution get 07:09:07 INFO - 2016-10-20 07:09:07.960 screenresolution[1667:10027] Display 0: 1600x1200x32@60 07:09:07 INFO - 2016-10-20 07:09:07.966 screenresolution[1668:10031] starting screenresolution argv=screenresolution list 07:09:07 INFO - Available Modes on Display 0 07:09:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:09:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:09:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:09:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:09:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:09:08 INFO - Intel Iris: 07:09:08 INFO - Chipset Model: Intel Iris 07:09:08 INFO - Type: GPU 07:09:08 INFO - Bus: Built-In 07:09:08 INFO - VRAM (Dynamic, Max): 1536 MB 07:09:08 INFO - Vendor: Intel (0x8086) 07:09:08 INFO - Device ID: 0x0a2e 07:09:08 INFO - Revision ID: 0x0009 07:09:08 INFO - Displays: 07:09:08 INFO - Display: 07:09:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:09:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:09:08 INFO - Display Serial Number: 1600x1200 60 07:09:08 INFO - Main Display: Yes 07:09:08 INFO - Mirror: Off 07:09:08 INFO - Online: Yes 07:09:08 INFO - Rotation: Supported 07:09:08 INFO - Return code: 0 07:09:08 INFO - Running post-action listener: _resource_record_post_action 07:09:08 INFO - [mozharness: 2016-10-20 14:09:08.201101Z] Finished run-tests step (success) 07:09:08 INFO - Running post-run listener: _resource_record_post_run 07:09:08 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 36733952; Write bytes: 659201024; Read time: 239; Write time: 1820 07:09:08 INFO - TinderboxPrint: CPU usage
53.4% 07:09:08 INFO - TinderboxPrint: I/O read bytes / time
36,733,952 / 239 07:09:08 INFO - TinderboxPrint: I/O write bytes / time
659,201,024 / 1,820 07:09:08 INFO - TinderboxPrint: CPU idle
2,254.7 (46.6%) 07:09:08 INFO - TinderboxPrint: CPU system
969.6 (20.0%) 07:09:08 INFO - TinderboxPrint: CPU user
1,613.3 (33.4%) 07:09:08 INFO - TinderboxPrint: Swap in / out
400,031,744 / 0 07:09:08 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 356573696; Write bytes: 356456448; Read time: 27358; Write time: 720 07:09:08 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 34923520; Write bytes: 291722240; Read time: 221; Write time: 1064 07:09:08 INFO - Running post-run listener: _upload_blobber_files 07:09:08 INFO - Blob upload gear active. 07:09:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:09:08 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 07:09:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:09:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:09:09 INFO - (blobuploader) - INFO - Open directory for files ... 07:09:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:09:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:09:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:09:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:09:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:09:10 INFO - (blobuploader) - INFO - Done attempting. 07:09:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:09:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:09:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:09:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:09:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:09:11 INFO - (blobuploader) - INFO - Done attempting. 07:09:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:09:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:09:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:09:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:09:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:09:13 INFO - (blobuploader) - INFO - Done attempting. 07:09:13 INFO - (blobuploader) - INFO - Iteration through files over. 07:09:13 INFO - Return code: 0 07:09:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:09:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:09:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5669256e032f75a6342106b3fbf55cbe6302a7e4a88670cc3aaa904a9546e4712ac4050ce2c312df40dbecc7f98775f01bb01d249406fd90492720283ee1758a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/755a2182f6d5ea1eee5d35f56395499141ce030d8b6a4232e842d40d049ad7312e597583b1f5e32a0e81786e2fe5c63b7a88d974b2eb7a0f452129d27bbec230", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffbcc275bce5823ad565c6e6c376a970cc433fcf70bb7d996c397bb9c24416dc3a12317a2bf300fbb88c96b733cc89bd9cb51efed6ea18c2498f892a0c933f47"} 07:09:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:09:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:09:13 INFO - Contents: 07:09:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5669256e032f75a6342106b3fbf55cbe6302a7e4a88670cc3aaa904a9546e4712ac4050ce2c312df40dbecc7f98775f01bb01d249406fd90492720283ee1758a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/755a2182f6d5ea1eee5d35f56395499141ce030d8b6a4232e842d40d049ad7312e597583b1f5e32a0e81786e2fe5c63b7a88d974b2eb7a0f452129d27bbec230", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffbcc275bce5823ad565c6e6c376a970cc433fcf70bb7d996c397bb9c24416dc3a12317a2bf300fbb88c96b733cc89bd9cb51efed6ea18c2498f892a0c933f47"} 07:09:13 INFO - Running post-run listener: copy_logs_to_upload_dir 07:09:13 INFO - Copying logs to upload dir... 07:09:13 INFO - mkdir: /builds/slave/test/build/upload/logs 07:09:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.866474 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-20 07:09:13.732248) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 07:09:13.735837) ========= 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.37nLwv4Pvz/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.UDEKxQWyvX/Listeners TMPDIR=/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5669256e032f75a6342106b3fbf55cbe6302a7e4a88670cc3aaa904a9546e4712ac4050ce2c312df40dbecc7f98775f01bb01d249406fd90492720283ee1758a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/755a2182f6d5ea1eee5d35f56395499141ce030d8b6a4232e842d40d049ad7312e597583b1f5e32a0e81786e2fe5c63b7a88d974b2eb7a0f452129d27bbec230", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffbcc275bce5823ad565c6e6c376a970cc433fcf70bb7d996c397bb9c24416dc3a12317a2bf300fbb88c96b733cc89bd9cb51efed6ea18c2498f892a0c933f47"} build_url:https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011220 build_url: 'https://queue.taskcluster.net/v1/task/T-Bo9bjUQqSjwWomCweQvw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5669256e032f75a6342106b3fbf55cbe6302a7e4a88670cc3aaa904a9546e4712ac4050ce2c312df40dbecc7f98775f01bb01d249406fd90492720283ee1758a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/755a2182f6d5ea1eee5d35f56395499141ce030d8b6a4232e842d40d049ad7312e597583b1f5e32a0e81786e2fe5c63b7a88d974b2eb7a0f452129d27bbec230", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffbcc275bce5823ad565c6e6c376a970cc433fcf70bb7d996c397bb9c24416dc3a12317a2bf300fbb88c96b733cc89bd9cb51efed6ea18c2498f892a0c933f47"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 07:09:13.769006) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 07:09:13.769339) ========= 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.37nLwv4Pvz/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.UDEKxQWyvX/Listeners TMPDIR=/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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.005126 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 07:09:13.818291) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 07:09:13.818613) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 07:09:13.818933) ========= ========= Total master_lag: 0.17 =========