builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0050 starttime: 1486763293.49 results: success (0) buildid: 20170210123623 builduid: 7de64d49336f444ea24f88f7aa023c9f revision: a288fe35e494cec3620717eab66eaff6f68a6369 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 13:48:13.486964) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-10 13:48:13.487461) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 13:48:13.487849) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-10 13:48:13.515275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 13:48:13.515608) ========= 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.c28hXDojkw/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.vkI0Da9UfR/Listeners TMPDIR=/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-10 13:48:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.3M=0.001s 2017-02-10 13:48:13 (15.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120912 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 13:48:13.664633) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 13:48:13.665423) ========= 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.c28hXDojkw/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.vkI0Da9UfR/Listeners TMPDIR=/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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.028535 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 13:48:13.718591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2017-02-10 13:48:13.718980) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a288fe35e494cec3620717eab66eaff6f68a6369 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a288fe35e494cec3620717eab66eaff6f68a6369 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.c28hXDojkw/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.vkI0Da9UfR/Listeners TMPDIR=/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-10 13:48:13,828 truncating revision to first 12 chars 2017-02-10 13:48:13,828 Setting DEBUG logging. 2017-02-10 13:48:13,829 attempt 1/10 2017-02-10 13:48:13,829 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a288fe35e494?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-10 13:48:15,287 unpacking tar archive at: mozilla-central-a288fe35e494/testing/mozharness/ program finished with exit code 0 elapsedTime=1.741168 ========= master_lag: 3.61 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2017-02-10 13:48:19.072953) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 13:48:19.073273) ========= script_repo_revision: a288fe35e494cec3620717eab66eaff6f68a6369 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-10 13:48:19.073669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 13:48:19.073950) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-10 13:48:19.418605) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-02-10 13:48:19.520178) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.c28hXDojkw/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.vkI0Da9UfR/Listeners TMPDIR=/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 13:48:19 INFO - MultiFileLogger online at 20170210 13:48:19 in /builds/slave/test 13:48:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:48:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:48:19 INFO - {'append_to_log': False, 13:48:19 INFO - 'base_work_dir': '/builds/slave/test', 13:48:19 INFO - 'blob_upload_branch': 'Firefox', 13:48:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:48:19 INFO - 'branch': 'Firefox', 13:48:19 INFO - 'buildbot_json_path': 'buildprops.json', 13:48:19 INFO - 'config_files': ('talos/mac_config.py',), 13:48:19 INFO - 'default_actions': ('clobber', 13:48:19 INFO - 'read-buildbot-config', 13:48:19 INFO - 'download-and-extract', 13:48:19 INFO - 'populate-webroot', 13:48:19 INFO - 'create-virtualenv', 13:48:19 INFO - 'install', 13:48:19 INFO - 'run-tests'), 13:48:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:48:19 INFO - 'download_minidump_stackwalk': True, 13:48:19 INFO - 'download_symbols': 'ondemand', 13:48:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:48:19 INFO - 'tooltool.py': '/tools/tooltool.py', 13:48:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:48:19 INFO - '/tools/misc-python/virtualenv.py')}, 13:48:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:48:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:48:19 INFO - 'installer_path': 'installer.exe', 13:48:19 INFO - 'log_level': 'info', 13:48:19 INFO - 'log_name': 'talos', 13:48:19 INFO - 'log_to_console': True, 13:48:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:48:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:48:19 INFO - 'opt_config_files': (), 13:48:19 INFO - 'pip_index': False, 13:48:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:48:19 INFO - 'cmd': ('bash', 13:48:19 INFO - '-c', 13:48:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:48:19 INFO - 'enabled': True, 13:48:19 INFO - 'halt_on_failure': False, 13:48:19 INFO - 'name': 'check_screen_resolution'},), 13:48:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:48:19 INFO - 'cmd': ('bash', 13:48:19 INFO - '-c', 13:48:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:48:19 INFO - 'enabled': True, 13:48:19 INFO - 'halt_on_failure': False, 13:48:19 INFO - 'name': 'check_screen_resolution'},), 13:48:19 INFO - 'run_cmd_checks_enabled': True, 13:48:19 INFO - 'sps_profile': False, 13:48:19 INFO - 'sps_profile_interval': 0, 13:48:19 INFO - 'suite': 'dromaeojs', 13:48:19 INFO - 'system_bits': '32', 13:48:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:48:19 INFO - 'title': 't-yosemite-r7-0050', 13:48:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:48:19 INFO - 'use_talos_json': True, 13:48:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:48:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:48:19 INFO - 'work_dir': 'build'} 13:48:19 INFO - [mozharness: 2017-02-10 21:48:19.738297Z] Running clobber step. 13:48:19 INFO - Running pre-action listener: _resource_record_pre_action 13:48:19 INFO - Running main action method: clobber 13:48:19 INFO - rmtree: /builds/slave/test/build 13:48:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:48:22 INFO - Running post-action listener: _resource_record_post_action 13:48:22 INFO - [mozharness: 2017-02-10 21:48:22.076460Z] Finished clobber step (success) 13:48:22 INFO - [mozharness: 2017-02-10 21:48:22.076572Z] Running read-buildbot-config step. 13:48:22 INFO - Running pre-action listener: _resource_record_pre_action 13:48:22 INFO - Running main action method: read_buildbot_config 13:48:22 INFO - Using buildbot properties: 13:48:22 INFO - { 13:48:22 INFO - "project": "", 13:48:22 INFO - "product": "firefox", 13:48:22 INFO - "script_repo_revision": "production", 13:48:22 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 13:48:22 INFO - "repository": "", 13:48:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 13:48:22 INFO - "buildid": "20170210123623", 13:48:22 INFO - "pgo_build": "False", 13:48:22 INFO - "basedir": "/builds/slave/test", 13:48:22 INFO - "buildnumber": 7, 13:48:22 INFO - "slavename": "t-yosemite-r7-0050", 13:48:22 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 13:48:22 INFO - "platform": "yosemite_r7", 13:48:22 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:48:22 INFO - "branch": "mozilla-central", 13:48:22 INFO - "repo_path": "mozilla-central", 13:48:22 INFO - "revision": "a288fe35e494cec3620717eab66eaff6f68a6369", 13:48:22 INFO - "stage_platform": "macosx64", 13:48:22 INFO - "builduid": "7de64d49336f444ea24f88f7aa023c9f", 13:48:22 INFO - "slavebuilddir": "test" 13:48:22 INFO - } 13:48:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 13:48:22 INFO - Running post-action listener: _resource_record_post_action 13:48:22 INFO - [mozharness: 2017-02-10 21:48:22.079949Z] Finished read-buildbot-config step (success) 13:48:22 INFO - [mozharness: 2017-02-10 21:48:22.080056Z] Running download-and-extract step. 13:48:22 INFO - Running pre-action listener: _resource_record_pre_action 13:48:22 INFO - Running main action method: download_and_extract 13:48:22 INFO - mkdir: /builds/slave/test/build/tests 13:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:22 INFO - trying https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 13:48:22 INFO - Downloading https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 13:48:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 13:48:23 INFO - Downloaded 1199 bytes. 13:48:23 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 13:48:23 INFO - Using the following test package requirements: 13:48:23 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 13:48:23 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 13:48:23 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 13:48:23 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 13:48:23 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 13:48:23 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 13:48:23 INFO - u'jsshell-mac.zip'], 13:48:23 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 13:48:23 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 13:48:23 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 13:48:23 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 13:48:23 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 13:48:23 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 13:48:23 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 13:48:23 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 13:48:23 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 13:48:23 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 13:48:23 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 13:48:23 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:48:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 13:48:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:48:23 INFO - Fetch https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 13:48:24 INFO - Expected file size: 34948708 13:48:24 INFO - Obtained file size: 34948708 13:48:31 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:48:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 13:48:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:48:31 INFO - Fetch https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 13:48:33 INFO - Expected file size: 34948708 13:48:33 INFO - Obtained file size: 34948708 13:48:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 13:48:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:48:39 INFO - Fetch https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 13:48:40 INFO - Expected file size: 14403454 13:48:40 INFO - Obtained file size: 14403454 13:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:41 INFO - trying https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 13:48:41 INFO - Downloading https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 13:48:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 13:48:43 INFO - Downloaded 70482046 bytes. 13:48:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 13:48:43 INFO - mkdir: /builds/slave/test/properties 13:48:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:48:43 INFO - Writing to file /builds/slave/test/properties/build_url 13:48:43 INFO - Contents: 13:48:43 INFO - build_url:https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 13:48:44 INFO - Running post-action listener: _resource_record_post_action 13:48:44 INFO - Running post-action listener: set_extra_try_arguments 13:48:44 INFO - [mozharness: 2017-02-10 21:48:44.077571Z] Finished download-and-extract step (success) 13:48:44 INFO - [mozharness: 2017-02-10 21:48:44.077730Z] Running populate-webroot step. 13:48:44 INFO - Running pre-action listener: _resource_record_pre_action 13:48:44 INFO - Running main action method: populate_webroot 13:48:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:48:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:48:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:48:44 INFO - '--tppagecycles', 13:48:44 INFO - '7'], 13:48:44 INFO - 'tests': ['tsvgm']}}, 13:48:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:48:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:48:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:48:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:48:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:48:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:48:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:48:44 INFO - 'talos_options': ['--disable-e10s'], 13:48:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:48:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:48:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:48:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:48:44 INFO - 'talos_options': ['--disable-e10s'], 13:48:44 INFO - 'tests': ['damp', 'tps']}, 13:48:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:48:44 INFO - 'tests': ['damp', 'tps']}, 13:48:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:48:44 INFO - 'tests': ['dromaeo_dom']}, 13:48:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:48:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:48:44 INFO - 'tests': ['basic_compositor_video']}, 13:48:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:48:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:48:44 INFO - 'tests': ['a11yr', 13:48:44 INFO - 'ts_paint', 13:48:44 INFO - 'tpaint', 13:48:44 INFO - 'sessionrestore', 13:48:44 INFO - 'sessionrestore_no_auto_restore', 13:48:44 INFO - 'tabpaint']}, 13:48:44 INFO - 'other-e10s': {'tests': ['a11yr', 13:48:44 INFO - 'ts_paint', 13:48:44 INFO - 'tpaint', 13:48:44 INFO - 'sessionrestore', 13:48:44 INFO - 'sessionrestore_no_auto_restore', 13:48:44 INFO - 'tabpaint']}, 13:48:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:48:44 INFO - 'ts_paint', 13:48:44 INFO - 'tpaint', 13:48:44 INFO - 'sessionrestore', 13:48:44 INFO - 'sessionrestore_no_auto_restore', 13:48:44 INFO - 'tabpaint']}, 13:48:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:48:44 INFO - 'ts_paint', 13:48:44 INFO - 'tpaint', 13:48:44 INFO - 'sessionrestore', 13:48:44 INFO - 'sessionrestore_no_auto_restore', 13:48:44 INFO - 'tabpaint']}, 13:48:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:48:44 INFO - 'tests': ['a11yr', 13:48:44 INFO - 'ts_paint', 13:48:44 INFO - 'tpaint', 13:48:44 INFO - 'sessionrestore', 13:48:44 INFO - 'sessionrestore_no_auto_restore', 13:48:44 INFO - 'tabpaint']}, 13:48:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:48:44 INFO - 'tests': ['a11yr', 13:48:44 INFO - 'ts_paint', 13:48:44 INFO - 'tpaint', 13:48:44 INFO - 'sessionrestore', 13:48:44 INFO - 'sessionrestore_no_auto_restore', 13:48:44 INFO - 'tabpaint']}, 13:48:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:48:44 INFO - 'tests': ['tsvgx', 13:48:44 INFO - 'tsvgr_opacity', 13:48:44 INFO - 'tart', 13:48:44 INFO - 'tscrollx', 13:48:44 INFO - 'cart', 13:48:44 INFO - 'tsvg_static']}, 13:48:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:48:44 INFO - 'tsvgr_opacity', 13:48:44 INFO - 'tart', 13:48:44 INFO - 'tscrollx', 13:48:44 INFO - 'cart', 13:48:44 INFO - 'tsvg_static']}, 13:48:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:48:44 INFO - 'talos_options': ['--disable-e10s'], 13:48:44 INFO - 'tests': ['tp5o']}, 13:48:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:48:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:48:44 INFO - 'talos_options': ['--disable-e10s', 13:48:44 INFO - '--xperf_path', 13:48:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:48:44 INFO - 'tests': ['tp5n']}, 13:48:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:48:44 INFO - 'talos_options': ['--xperf_path', 13:48:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:48:44 INFO - 'tests': ['tp5n']}}, 13:48:44 INFO - 'talos.zip': {'path': '', 13:48:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:48:44 INFO - Running post-action listener: _resource_record_post_action 13:48:44 INFO - [mozharness: 2017-02-10 21:48:44.096580Z] Finished populate-webroot step (success) 13:48:44 INFO - [mozharness: 2017-02-10 21:48:44.096712Z] Running create-virtualenv step. 13:48:44 INFO - Running pre-action listener: _resource_record_pre_action 13:48:44 INFO - Running main action method: create_virtualenv 13:48:44 INFO - Creating virtualenv /builds/slave/test/build/venv 13:48:44 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 13:48:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:48:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:48:44 INFO - Using real prefix '/tools/python27' 13:48:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:48:44 INFO - Installing distribute.............................................................................................................................................................................................done. 13:48:47 INFO - Installing pip.................done. 13:48:47 INFO - Return code: 0 13:48:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:48:48 INFO - Reading from file tmpfile_stdout 13:48:48 INFO - Output received: 13:48:48 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:48:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c173b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c176768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92c34beb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf51d30>, '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 0x10be78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46be8>, '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.c28hXDojkw/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.vkI0Da9UfR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 13:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:48:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c28hXDojkw/Render', 13:48:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:48:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:48:48 INFO - 'HOME': '/Users/cltbld', 13:48:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:48:48 INFO - 'LOGNAME': 'cltbld', 13:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:48 INFO - 'MOZ_NO_REMOTE': '1', 13:48:48 INFO - 'NO_EM_RESTART': '1', 13:48:48 INFO - 'PAGER': '/bin/cat', 13:48:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:48 INFO - 'PWD': '/builds/slave/test', 13:48:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:48:48 INFO - 'SHELL': '/bin/bash', 13:48:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vkI0Da9UfR/Listeners', 13:48:48 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 13:48:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:48:48 INFO - 'USER': 'cltbld', 13:48:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:48:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:48 INFO - 'XPC_FLAGS': '0x0', 13:48:48 INFO - 'XPC_SERVICE_NAME': '0', 13:48:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:48 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 13:48:48 INFO - Cleaning up... 13:48:48 INFO - Return code: 0 13:48:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c173b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c176768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92c34beb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf51d30>, '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 0x10be78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46be8>, '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.c28hXDojkw/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.vkI0Da9UfR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 13:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:48:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c28hXDojkw/Render', 13:48:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:48:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:48:48 INFO - 'HOME': '/Users/cltbld', 13:48:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:48:48 INFO - 'LOGNAME': 'cltbld', 13:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:48 INFO - 'MOZ_NO_REMOTE': '1', 13:48:48 INFO - 'NO_EM_RESTART': '1', 13:48:48 INFO - 'PAGER': '/bin/cat', 13:48:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:48 INFO - 'PWD': '/builds/slave/test', 13:48:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:48:48 INFO - 'SHELL': '/bin/bash', 13:48:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vkI0Da9UfR/Listeners', 13:48:48 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 13:48:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:48:48 INFO - 'USER': 'cltbld', 13:48:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:48:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:48 INFO - 'XPC_FLAGS': '0x0', 13:48:48 INFO - 'XPC_SERVICE_NAME': '0', 13:48:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:48 INFO - Downloading/unpacking psutil>=3.1.1 13:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:48:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:48:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:48:52 INFO - Installing collected packages: psutil 13:48:52 INFO - Running setup.py install for psutil 13:48:52 INFO - building 'psutil._psutil_osx' extension 13:48:52 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 13:48:52 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 13:48:52 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 13:48:53 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 13:48:53 INFO - building 'psutil._psutil_posix' extension 13:48:53 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 13:48:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:48:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:48:53 INFO - ^ 13:48:53 INFO - 1 warning generated. 13:48:53 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 13:48:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:48:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:48:53 INFO - Successfully installed psutil 13:48:53 INFO - Cleaning up... 13:48:53 INFO - Return code: 0 13:48:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:48:53 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')]} 13:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:53 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')]} 13:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:53 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 0x10c173b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c176768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92c34beb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf51d30>, '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 0x10be78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46be8>, '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.c28hXDojkw/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.vkI0Da9UfR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 13:48:53 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 13:48:53 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 13:48:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c28hXDojkw/Render', 13:48:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:48:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:48:53 INFO - 'HOME': '/Users/cltbld', 13:48:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:48:53 INFO - 'LOGNAME': 'cltbld', 13:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:53 INFO - 'MOZ_NO_REMOTE': '1', 13:48:53 INFO - 'NO_EM_RESTART': '1', 13:48:53 INFO - 'PAGER': '/bin/cat', 13:48:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:53 INFO - 'PWD': '/builds/slave/test', 13:48:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:48:53 INFO - 'SHELL': '/bin/bash', 13:48:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vkI0Da9UfR/Listeners', 13:48:53 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 13:48:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:48:53 INFO - 'USER': 'cltbld', 13:48:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:48:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:53 INFO - 'XPC_FLAGS': '0x0', 13:48:53 INFO - 'XPC_SERVICE_NAME': '0', 13:48:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:48:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:48:56 INFO - Installing collected packages: mozsystemmonitor 13:48:56 INFO - Running setup.py install for mozsystemmonitor 13:48:56 INFO - Successfully installed mozsystemmonitor 13:48:56 INFO - Cleaning up... 13:48:56 INFO - Return code: 0 13:48:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:56 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 0x10c173b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c176768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92c34beb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf51d30>, '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 0x10be78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46be8>, '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.c28hXDojkw/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.vkI0Da9UfR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 13:48:56 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 13:48:56 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 13:48:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c28hXDojkw/Render', 13:48:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:48:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:48:56 INFO - 'HOME': '/Users/cltbld', 13:48:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:48:56 INFO - 'LOGNAME': 'cltbld', 13:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:56 INFO - 'MOZ_NO_REMOTE': '1', 13:48:56 INFO - 'NO_EM_RESTART': '1', 13:48:56 INFO - 'PAGER': '/bin/cat', 13:48:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:56 INFO - 'PWD': '/builds/slave/test', 13:48:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:48:56 INFO - 'SHELL': '/bin/bash', 13:48:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vkI0Da9UfR/Listeners', 13:48:56 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 13:48:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:48:56 INFO - 'USER': 'cltbld', 13:48:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:48:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:56 INFO - 'XPC_FLAGS': '0x0', 13:48:56 INFO - 'XPC_SERVICE_NAME': '0', 13:48:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:48:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:56 INFO - Downloading/unpacking jsonschema==2.5.1 13:48:56 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 13:48:56 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 13:48:56 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 13:48:56 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 13:48:56 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 13:48:56 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 13:48:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:48:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:48:59 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 13:48:59 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 13:48:59 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 13:48:59 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 13:48:59 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 13:48:59 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 13:49:00 INFO - Downloading functools32-3.2.3-2.tar.gz 13:49:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:49:00 INFO - warning: no files found matching '*.txt' 13:49:00 INFO - no previously-included directories found matching 'build' 13:49:00 INFO - no previously-included directories found matching 'dist' 13:49:00 INFO - no previously-included directories found matching '.git*' 13:49:00 INFO - Installing collected packages: jsonschema, functools32 13:49:00 INFO - Running setup.py install for functools32 13:49:00 INFO - warning: no files found matching '*.txt' 13:49:00 INFO - no previously-included directories found matching 'build' 13:49:00 INFO - no previously-included directories found matching 'dist' 13:49:00 INFO - no previously-included directories found matching '.git*' 13:49:00 INFO - Successfully installed jsonschema functools32 13:49:00 INFO - Cleaning up... 13:49:00 INFO - Return code: 0 13:49:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c173b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c176768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92c34beb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf51d30>, '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 0x10be78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46be8>, '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.c28hXDojkw/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.vkI0Da9UfR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 13:49:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:49:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:49:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c28hXDojkw/Render', 13:49:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:00 INFO - 'HOME': '/Users/cltbld', 13:49:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:00 INFO - 'LOGNAME': 'cltbld', 13:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:00 INFO - 'MOZ_NO_REMOTE': '1', 13:49:00 INFO - 'NO_EM_RESTART': '1', 13:49:00 INFO - 'PAGER': '/bin/cat', 13:49:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:00 INFO - 'PWD': '/builds/slave/test', 13:49:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:00 INFO - 'SHELL': '/bin/bash', 13:49:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vkI0Da9UfR/Listeners', 13:49:00 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 13:49:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:00 INFO - 'USER': 'cltbld', 13:49:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:00 INFO - 'XPC_FLAGS': '0x0', 13:49:00 INFO - 'XPC_SERVICE_NAME': '0', 13:49:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:49:00 INFO - Cleaning up... 13:49:00 INFO - Return code: 0 13:49:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c173b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c176768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92c34beb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf51d30>, '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 0x10be78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46be8>, '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.c28hXDojkw/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.vkI0Da9UfR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 13:49:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:49:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:49:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c28hXDojkw/Render', 13:49:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:00 INFO - 'HOME': '/Users/cltbld', 13:49:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:00 INFO - 'LOGNAME': 'cltbld', 13:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:00 INFO - 'MOZ_NO_REMOTE': '1', 13:49:00 INFO - 'NO_EM_RESTART': '1', 13:49:00 INFO - 'PAGER': '/bin/cat', 13:49:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:00 INFO - 'PWD': '/builds/slave/test', 13:49:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:00 INFO - 'SHELL': '/bin/bash', 13:49:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vkI0Da9UfR/Listeners', 13:49:00 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 13:49:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:00 INFO - 'USER': 'cltbld', 13:49:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:00 INFO - 'XPC_FLAGS': '0x0', 13:49:00 INFO - 'XPC_SERVICE_NAME': '0', 13:49:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:00 INFO - Downloading/unpacking blobuploader==1.2.4 13:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:03 INFO - Downloading blobuploader-1.2.4.tar.gz 13:49:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:49:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:49:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:49:04 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 13:49:04 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 13:49:04 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 13:49:04 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 13:49:04 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 13:49:04 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 13:49:04 INFO - Downloading docopt-0.6.1.tar.gz 13:49:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:49:04 INFO - Installing collected packages: blobuploader, requests, docopt 13:49:04 INFO - Running setup.py install for blobuploader 13:49:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:49:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:49:05 INFO - Running setup.py install for requests 13:49:05 INFO - Running setup.py install for docopt 13:49:05 INFO - Successfully installed blobuploader requests docopt 13:49:05 INFO - Cleaning up... 13:49:05 INFO - Return code: 0 13:49:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:05 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')]} 13:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:05 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')]} 13:49:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:05 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 0x10c173b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c176768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92c34beb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf51d30>, '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 0x10be78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46be8>, '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.c28hXDojkw/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.vkI0Da9UfR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 13:49:05 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 13:49:05 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 13:49:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c28hXDojkw/Render', 13:49:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:05 INFO - 'HOME': '/Users/cltbld', 13:49:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:05 INFO - 'LOGNAME': 'cltbld', 13:49:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:05 INFO - 'MOZ_NO_REMOTE': '1', 13:49:05 INFO - 'NO_EM_RESTART': '1', 13:49:05 INFO - 'PAGER': '/bin/cat', 13:49:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:05 INFO - 'PWD': '/builds/slave/test', 13:49:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:05 INFO - 'SHELL': '/bin/bash', 13:49:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vkI0Da9UfR/Listeners', 13:49:05 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 13:49:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:05 INFO - 'USER': 'cltbld', 13:49:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:05 INFO - 'XPC_FLAGS': '0x0', 13:49:05 INFO - 'XPC_SERVICE_NAME': '0', 13:49:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:49:06 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-y8AnGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:49:06 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-JWSmQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:49:06 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-fFILuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:49:06 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-HvbIMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:49:06 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-lgPyrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:49:06 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-_3Tsgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:49:06 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-pN47tN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:49:06 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-0on5R6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:49:06 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-XiQy2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:49:07 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-dknCfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:49:07 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-SAQ4i9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:49:07 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-yrzhBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:49:07 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-DqiDLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:49:07 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-sKMAfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:07 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-khl5Mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:49:07 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-xzRxSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:49:07 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-DU2iPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:49:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:49:07 INFO - Running setup.py install for manifestparser 13:49:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:49:07 INFO - Running setup.py install for mozcrash 13:49:08 INFO - Running setup.py install for mozdebug 13:49:08 INFO - Running setup.py install for mozdevice 13:49:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:49:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:49:08 INFO - Running setup.py install for mozfile 13:49:08 INFO - Running setup.py install for mozhttpd 13:49:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:49:08 INFO - Running setup.py install for mozinfo 13:49:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:49:08 INFO - Running setup.py install for mozInstall 13:49:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:49:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:49:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:49:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:49:08 INFO - Running setup.py install for mozleak 13:49:09 INFO - Running setup.py install for mozlog 13:49:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:49:09 INFO - Running setup.py install for moznetwork 13:49:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:49:09 INFO - Running setup.py install for mozprocess 13:49:09 INFO - Running setup.py install for mozprofile 13:49:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:49:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:49:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:49:09 INFO - Running setup.py install for mozrunner 13:49:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:49:09 INFO - Running setup.py install for mozscreenshot 13:49:10 INFO - Running setup.py install for moztest 13:49:10 INFO - Running setup.py install for mozversion 13:49:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:49:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:49:10 INFO - Cleaning up... 13:49:10 INFO - Return code: 0 13:49:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:10 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')]} 13:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:10 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')]} 13:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:11 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 0x10c173b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c176768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92c34beb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf51d30>, '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 0x10be78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46be8>, '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.c28hXDojkw/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.vkI0Da9UfR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 13:49:11 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 13:49:11 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 13:49:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c28hXDojkw/Render', 13:49:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:11 INFO - 'HOME': '/Users/cltbld', 13:49:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:11 INFO - 'LOGNAME': 'cltbld', 13:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:11 INFO - 'MOZ_NO_REMOTE': '1', 13:49:11 INFO - 'NO_EM_RESTART': '1', 13:49:11 INFO - 'PAGER': '/bin/cat', 13:49:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:11 INFO - 'PWD': '/builds/slave/test', 13:49:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:11 INFO - 'SHELL': '/bin/bash', 13:49:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vkI0Da9UfR/Listeners', 13:49:11 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 13:49:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:11 INFO - 'USER': 'cltbld', 13:49:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:11 INFO - 'XPC_FLAGS': '0x0', 13:49:11 INFO - 'XPC_SERVICE_NAME': '0', 13:49:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:49:11 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-Ru8hqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:49:11 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)) 13:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:49:11 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-OiKSYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:49:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:49:11 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-Nni28g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:49:11 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)) 13:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:49:11 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-zTARj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:49:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:49:11 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-tVnpOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:49:11 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)) 13:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:49:11 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-Pn6Utz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:49:12 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)) 13:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:49:12 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-Ka5Ii4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:49:12 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)) 13:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:49:12 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-Z5MM1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:49:12 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)) 13:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:49:12 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-_xdAOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:49:12 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)) 13:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:49:12 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-iVWj00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:49:12 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)) 13:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:49:12 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-zBEZLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:49:12 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)) 13:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:49:12 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-2RAJZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:49:12 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-AzW3Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:49:12 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)) 13:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:49:12 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-Ua6WhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:12 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-wd3Jlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:12 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)) 13:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:49:12 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-5VSmBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:49:13 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-k9VWiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:49:13 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)) 13:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:49:13 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)) 13:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:49:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:49:13 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 13:49:13 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 13:49:13 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 13:49:13 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 13:49:13 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 13:49:13 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 13:49:16 INFO - Downloading blessings-1.6.tar.gz 13:49:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:49:16 INFO - Installing collected packages: blessings 13:49:16 INFO - Running setup.py install for blessings 13:49:16 INFO - Successfully installed blessings 13:49:16 INFO - Cleaning up... 13:49:16 INFO - Return code: 0 13:49:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:49:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:49:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:49:16 INFO - Reading from file tmpfile_stdout 13:49:16 INFO - Current package versions: 13:49:16 INFO - blessings == 1.6 13:49:16 INFO - blobuploader == 1.2.4 13:49:16 INFO - docopt == 0.6.1 13:49:16 INFO - functools32 == 3.2.3-2 13:49:16 INFO - jsonschema == 2.5.1 13:49:16 INFO - manifestparser == 1.1 13:49:16 INFO - mozInstall == 1.12 13:49:16 INFO - mozcrash == 1.0 13:49:16 INFO - mozdebug == 0.1 13:49:16 INFO - mozdevice == 0.49 13:49:16 INFO - mozfile == 1.2 13:49:16 INFO - mozhttpd == 0.7 13:49:16 INFO - mozinfo == 0.9 13:49:16 INFO - mozleak == 0.1 13:49:16 INFO - mozlog == 3.4 13:49:16 INFO - moznetwork == 0.27 13:49:16 INFO - mozprocess == 0.24 13:49:16 INFO - mozprofile == 0.28 13:49:16 INFO - mozrunner == 6.13 13:49:16 INFO - mozscreenshot == 0.1 13:49:16 INFO - mozsystemmonitor == 0.3 13:49:16 INFO - moztest == 0.8 13:49:16 INFO - mozversion == 1.4 13:49:16 INFO - psutil == 3.1.1 13:49:16 INFO - requests == 1.2.3 13:49:16 INFO - wsgiref == 0.1.2 13:49:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:16 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 0x10c173b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c176768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92c34beb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf51d30>, '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 0x10be78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46be8>, '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.c28hXDojkw/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.vkI0Da9UfR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 13:49:16 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 13:49:16 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 13:49:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c28hXDojkw/Render', 13:49:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:16 INFO - 'HOME': '/Users/cltbld', 13:49:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:16 INFO - 'LOGNAME': 'cltbld', 13:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:16 INFO - 'MOZ_NO_REMOTE': '1', 13:49:16 INFO - 'NO_EM_RESTART': '1', 13:49:16 INFO - 'PAGER': '/bin/cat', 13:49:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:16 INFO - 'PWD': '/builds/slave/test', 13:49:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:16 INFO - 'SHELL': '/bin/bash', 13:49:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vkI0Da9UfR/Listeners', 13:49:16 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 13:49:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:16 INFO - 'USER': 'cltbld', 13:49:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:16 INFO - 'XPC_FLAGS': '0x0', 13:49:16 INFO - 'XPC_SERVICE_NAME': '0', 13:49:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:17 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)) 13:49:17 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)) 13:49:17 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)) 13:49:17 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)) 13:49:17 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)) 13:49:17 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)) 13:49:17 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)) 13:49:17 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)) 13:49:17 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)) 13:49:17 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)) 13:49:17 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)) 13:49:17 INFO - Cleaning up... 13:49:17 INFO - Return code: 0 13:49:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:49:17 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')]} 13:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:17 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')]} 13:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:17 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 0x10c173b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c176768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92c34beb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf51d30>, '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 0x10be78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46be8>, '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.c28hXDojkw/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.vkI0Da9UfR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 13:49:17 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 13:49:17 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 13:49:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c28hXDojkw/Render', 13:49:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:17 INFO - 'HOME': '/Users/cltbld', 13:49:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:17 INFO - 'LOGNAME': 'cltbld', 13:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:17 INFO - 'MOZ_NO_REMOTE': '1', 13:49:17 INFO - 'NO_EM_RESTART': '1', 13:49:17 INFO - 'PAGER': '/bin/cat', 13:49:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:17 INFO - 'PWD': '/builds/slave/test', 13:49:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:17 INFO - 'SHELL': '/bin/bash', 13:49:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vkI0Da9UfR/Listeners', 13:49:17 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 13:49:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:17 INFO - 'USER': 'cltbld', 13:49:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:17 INFO - 'XPC_FLAGS': '0x0', 13:49:17 INFO - 'XPC_SERVICE_NAME': '0', 13:49:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:49:17 INFO - Cleaning up... 13:49:17 INFO - Return code: 0 13:49:17 INFO - Running post-action listener: _resource_record_post_action 13:49:17 INFO - Running post-action listener: _start_resource_monitoring 13:49:17 INFO - Starting resource monitoring. 13:49:17 INFO - [mozharness: 2017-02-10 21:49:17.504039Z] Finished create-virtualenv step (success) 13:49:17 INFO - [mozharness: 2017-02-10 21:49:17.505026Z] Running install step. 13:49:17 INFO - Running pre-action listener: _resource_record_pre_action 13:49:17 INFO - Running main action method: install 13:49:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:49:17 INFO - Reading from file tmpfile_stdout 13:49:17 INFO - Detecting whether we're running mozinstall >=1.0... 13:49:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:49:17 INFO - Reading from file tmpfile_stdout 13:49:17 INFO - Output received: 13:49:17 INFO - Usage: mozinstall [options] installer 13:49:17 INFO - Options: 13:49:17 INFO - -h, --help show this help message and exit 13:49:17 INFO - -d DEST, --destination=DEST 13:49:17 INFO - Directory to install application into. [default: 13:49:17 INFO - "/builds/slave/test"] 13:49:17 INFO - --app=APP Application being installed. [default: firefox] 13:49:17 INFO - mkdir: /builds/slave/test/build/application 13:49:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:49:40 INFO - Reading from file tmpfile_stdout 13:49:40 INFO - Output received: 13:49:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:49:40 INFO - Running post-action listener: _resource_record_post_action 13:49:40 INFO - [mozharness: 2017-02-10 21:49:40.049940Z] Finished install step (success) 13:49:40 INFO - [mozharness: 2017-02-10 21:49:40.050096Z] Running run-tests step. 13:49:40 INFO - Running pre-action listener: _resource_record_pre_action 13:49:40 INFO - Running main action method: run_tests 13:49:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:49:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:49:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:49:40 INFO - 2017-02-10 13:49:40.064 screenresolution[1622:7371] starting screenresolution argv=screenresolution get 13:49:40 INFO - 2017-02-10 13:49:40.067 screenresolution[1622:7371] Display 0: 1600x1200x32@60 13:49:40 INFO - 2017-02-10 13:49:40.073 screenresolution[1623:7373] starting screenresolution argv=screenresolution list 13:49:40 INFO - Available Modes on Display 0 13:49:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:49:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:49:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:49:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:49:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:49:40 INFO - Intel Iris: 13:49:40 INFO - Chipset Model: Intel Iris 13:49:40 INFO - Type: GPU 13:49:40 INFO - Bus: Built-In 13:49:40 INFO - VRAM (Dynamic, Max): 1536 MB 13:49:40 INFO - Vendor: Intel (0x8086) 13:49:40 INFO - Device ID: 0x0a2e 13:49:40 INFO - Revision ID: 0x0009 13:49:40 INFO - Displays: 13:49:40 INFO - Display: 13:49:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:49:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:49:40 INFO - Display Serial Number: 1600x1200 60 13:49:40 INFO - Main Display: Yes 13:49:40 INFO - Mirror: Off 13:49:40 INFO - Online: Yes 13:49:40 INFO - Rotation: Supported 13:49:40 INFO - Return code: 0 13:49:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:49:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:49:40 INFO - Python 2.7.3 13:49:40 INFO - Return code: 0 13:49:40 INFO - grabbing minidump binary from tooltool 13:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:40 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 0x10bf51d30>, '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 0x10be78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf46be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:49:40 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 13:49:40 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 13:49:40 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 13:49:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:49:40 INFO - Return code: 0 13:49:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:49:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:49:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:49:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:49:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:49:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0050', '--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 13:49:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0050 --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 13:49:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.c28hXDojkw/Render', 13:49:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:40 INFO - 'HOME': '/Users/cltbld', 13:49:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:40 INFO - 'LOGNAME': 'cltbld', 13:49:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:49:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:40 INFO - 'MOZ_NO_REMOTE': '1', 13:49:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:49:40 INFO - 'NO_EM_RESTART': '1', 13:49:40 INFO - 'PAGER': '/bin/cat', 13:49:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:40 INFO - 'PWD': '/builds/slave/test', 13:49:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:49:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:40 INFO - 'SHELL': '/bin/bash', 13:49:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vkI0Da9UfR/Listeners', 13:49:40 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 13:49:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:40 INFO - 'USER': 'cltbld', 13:49:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:40 INFO - 'XPC_FLAGS': '0x0', 13:49:40 INFO - 'XPC_SERVICE_NAME': '0', 13:49:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0050', '--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 13:49:40 INFO - mozversion application_buildid: 20170210123623 13:49:40 INFO - mozversion application_changeset: a288fe35e494cec3620717eab66eaff6f68a6369 13:49:40 INFO - mozversion application_display_name: Nightly 13:49:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:49:40 INFO - mozversion application_name: Firefox 13:49:40 INFO - mozversion application_remotingname: firefox 13:49:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:49:40 INFO - mozversion application_vendor: Mozilla 13:49:40 INFO - mozversion application_version: 54.0a1 13:49:40 INFO - mozversion platform_buildid: 20170210123623 13:49:40 INFO - mozversion platform_changeset: a288fe35e494cec3620717eab66eaff6f68a6369 13:49:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:49:40 INFO - mozversion platform_version: 54.0a1 13:49:40 INFO - using testdate: 1486763380 13:49:40 INFO - actual date: 1486763380 13:49:40 INFO - starting webserver on 'localhost:49240' 13:49:40 INFO - SUITE-START | Running 2 tests 13:49:40 INFO - TEST-START | dromaeo_css 13:49:40 INFO - operating with platform_type : mac_ 13:49:40 INFO - Initialising browser for dromaeo_css test... 13:49:40 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/tmpaezurB/profile http://localhost:49240/getInfo.html) 13:49:42 INFO - PROCESS | 1633 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 13:49:43 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 13:49:43 INFO - PROCESS | 1633 | colorDepth:24 13:49:43 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 13:49:43 INFO - PROCESS | 1633 | __metrics 13:49:43 INFO - PROCESS | 1633 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:49:43 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:49:44 INFO - TEST-INFO | 1633: exit 0 13:49:44 INFO - Browser initialized. 13:49:44 INFO - Running cycle 1/1 for dromaeo_css test... 13:49:44 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/tmpaezurB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:49:56 INFO - PROCESS | 1635 | RSS: Main: 237056000 13:49:56 INFO - PROCESS | 1635 | 13:53:00 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 13:53:01 INFO - PROCESS | 1635 | RSS: Main: 384114688 13:53:01 INFO - PROCESS | 1635 | 13:54:45 INFO - PROCESS | 1635 | ************************* 13:54:45 INFO - PROCESS | 1635 | A coding exception was thrown and uncaught in a Task. 13:54:45 INFO - PROCESS | 1635 | 13:54:45 ERROR - PROCESS | 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:54:45 INFO - PROCESS | 1635 | Full stack: 13:54:45 INFO - PROCESS | 1635 | ************************* 13:56:04 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 13:56:05 INFO - PROCESS | 1635 | RSS: Main: 370532352 13:56:05 INFO - PROCESS | 1635 | 13:59:07 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 13:59:08 INFO - PROCESS | 1635 | RSS: Main: 353124352 13:59:08 INFO - PROCESS | 1635 | 14:02:10 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 14:02:11 INFO - PROCESS | 1635 | RSS: Main: 339668992 14:02:11 INFO - PROCESS | 1635 | 14:05:15 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 14:05:15 INFO - PROCESS | 1635 | RSS: Main: 330993664 14:05:15 INFO - PROCESS | 1635 | 14:08:18 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 14:08:19 INFO - PROCESS | 1635 | RSS: Main: 517152768 14:08:19 INFO - PROCESS | 1635 | 14:08:19 INFO - PROCESS | 1635 | __start_tp_report 14:08:19 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 14:08:19 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 14:08:19 INFO - PROCESS | 1635 | |i|pagename|runs| 14:08:19 INFO - PROCESS | 1635 | |0;dojo.html;3339.215284408164;3348.0625424881027;3351.0617027232374;3364.4448665970117;3386.49202619607;5432.972835135829;5530.253415788868;5606.915896261554;5645.520130788883;5686.4313568643165;5323.281357016811;5531.806386776464;5580.693061881595;5602.915956260659;5607.411221821701;4540.954590454086;4913.017396520692;5085.5423011929015;5106.106431374513;5204.609654275925;5130.127878260686;5206.505381988705;5211.088059589557;5213.1919552469235;5216.6869987800665;5171.405288391846;5172.120739474299;5210.036143313499;5234.953009398117;5237.554807841319;5169.7156656383695;5246.160614301732;5257.369115706101;5259.2899958505495;5266.973665131688;5090.083784918713;5162.174052151638;5192.740362981874;5215.713135777531;5247.029299579552;5133.743312834381;5384.40771515133;5469.890602187934;5520.337559492887;5531.751071201766;6174.629522228635;6205.03821907605;6261.373862613747;6272.937270627281;6286.4342209201395;6192.845178870519;6263.404976527223;6272.8118156455375;6289.968550157266;6295.338989406138;5547.1679248113105;5846.7368968396095;5863.3222830211525;5866.882662346772;5901.970490147522;6135.030575315113;6175.567710260329;6219.689015549205;6283.403076707706;6297.96851015742;6092.398214864459;6098.32918378978;6099.551912188652;6102.511799056065;6116.327204007555;6226.657533835682;6231;6240.968795155995;6249.531285153632;6262.655553944485;5867.295924489089;6003.609765365237;6115.553609370865;6125.111858780452;6149.846253843601;5853.0635098384055;5986.73059712314;5995;6134.079888016833;6164.815055548341;4908.41099068107;4943.604511639061;4956.033573453142;4981.501849815062;4991.051700176955;4431.977840110843;4453.977730111329;4498.640108791289;4503.864884053483;4506.684532082788;5444.074507333763;5502.0921547944145;5509.889802203934;5652.519535839418;5676.886462270814;6150.630962142286;6170.950938340493;6194.783182588588;6267.623942563369;6272.18461599989;5620.57845661577;5627.887442251132;5645.2096706461125;5645.322561292589;5667.121596152603;5213.973930130401;5388.568914486832;5389.056915039931;5392.164214546751;5399.83800485986;6155.569110162335;6182.258129024546;6213.565050446426;6247;6251.499880009679;6231.345708700521;6238.75044998195;6251.874962500634;6255.624662520263;6261.499080073492;6234.906476402948;6236.6258024518675;6239.500839932885;6247.09417134522;6252.531060170414;5912.911306330322;6000.489958353414;6116.061877111602;6117.1130186123655;6123.173371594956;5312.893742125213;6255.499560035278;6258.561900666909;6264.342244064308;6264.843378915563;6048.848778780566;6068.362821903813;6080.300765412034;6087.604305720114;6089.360617135314;5713.400092990176;5832.50423713989;5993.101034844808;6015.909761353496;6098.054801505774;5914.378990205966;5914.615549989237;5929.673867937132;5964.433378829004;5965.552583556338;5788.450097240755;6084.421979911901;6099.481544068626;6116.449519543263;6120.663363514871;5704.0588302929555;5742.741576629145;5782.884342313214;5783.94216057834;5794.246747922743 14:08:19 INFO - PROCESS | 1635 | |1;ext.html;442.7586965104018;445.7036071012776;505.345577477167;510.8365323096608;513.6276199755175;25049.49901001979;37838.67564635235;39236.60763392365;39264.41103383445;41318.17363652725;40034.79895603129;40333.99165020876;40377;40379.394309085386;40426.79786601063;8912.420692654989;9150.588223529958;9157.542122893828;9163.679271225508;9188.816223675523;7642.04474440695;7868;10609.522571484264;10876.456177191109;10904;10692.305000174963;10774.622888198915;10795.08241799448;10899.564017439332;10916.617918372858;7619.123800762928;10693.091087257553;10765.461726913623;10774.40740759258;10778.137748980063;7726.536407815493;10489.370637761758;10806.837897431546;10818.67543973682;10866.782664346669;38134.85595432114;38418.231635367134;38472.80763596164;38507.807460962795;38647;3764.623537646241;3781.8487260509546;3796.088938654703;3803.410471376941;3883.961160388388;28378.162980673565;28879.278018049506;29022.709772902213;29442.411151776843;29658.110256692333;2552.642630031797;3043.178341847689;3077.1691643256418;3095.5356696495483;3143.104215298629;333391.33304333565;335379.32310338534;336999;337664;337939;47849.8655228612;58530.414695853346;58747.70626146842;58824.82350352969;58853.70573147107;48895.75552122216;51231.7438412813;51243.23135152976;51322;51360;14108.717825643429;14679.266036698122;14708.779368309484;15095.849041509664;15135.318910649048;11399.259048161843;11466.140039497071;11487.195896287347;11490.655280341603;11497.310161390344;16210.35158593643;16304.103274319788;16321.939073960155;16348.264328105026;16373.181340932906;5910.581460449461;5942.64344139353;7130.3939165170505;7138.179109402381;7165.7850264492145;730.5908691132983;770.1220608506308;785.1638005524098;828.492144297373;829.8464784014976;28622.713772862004;28772.42455150885;28816.982811203434;29369.853150734536;29389.559156612668;1008.5108722269694;1011.3982180602529;1019.2304809868501;1031.5512751952924;1159.4898244772273;11353.659390218307;14170.433182672577;14822.88828337879;15086.755075882586;15188.46840360582;212686;214737;214980;215043;216238;56032.439675603535;56250.87498250012;56281;56390.71804640951;56473;1320.108926474645;1357.9049466537247;1358.7418390505773;1360.4422186903323;1361.6800051987577;25032.49805011705;25733.099341522957;27958.72041279561;28992.565111522923;29057.85471072631;47450.52549474461;47909;48497.03005939932;48518.02963940772;51462.48537514577;423801;502339;516015;516301;517779;21313.467163321042;21862.45343866416;21950.121995120015;23929.64105538453;23945.76054239505;37664;40128.598714012485;40193.1961360777;40497.79751101226;40601.1879762409;27148.592771108055;32610.53252603686;33046;33901.32197356089;34167;27555.448891021668;32716.345673086882;33063.008109756745;33535.49696754502;34082.636694532936;32547.674523254464;33123.66876331302;33172.1706957328;33349.33301334008;33501.16247093842;27635.447291053664;29500;29605.407891842475;30210.800804187555;30578;22477.662835057814;22536.66195007109;22731.318060458212;22758.886205568866;22773.31680049601 14:08:19 INFO - PROCESS | 1635 | |2;jquery.html;343.86589230200224;390.61524398467486;401.36584196968784;410.2861021822027;415.61347946409825;11244.212905096647;18770.624587508242;20284.985750712443;20783.584328313424;21062.57874842502;21180.682289765668;21782.673259901116;21986;22079.779202207974;22457.877106144708;6426.485881129498;6460;6575.638339891304;6666.866662666768;6686.398224159825;6505.284418713938;6626.436752876011;6642.269350371455;7267.164276108236;7652.961735191344;7760.262775036391;7768.961155194216;7774.222577742209;7788.4937479063965;7788.6105694715325;7241.203467618558;7575.621218939059;7639.7394429918995;7736.535807851547;7761.805954851117;6843.315668433167;7153.105861767279;7201.89197162043;7299.744508942162;7521.887171692429;27242.863785681144;27845.58231626527;27872;27902.302442438897;28113.57829632557;2732.412531305779;2768.7231276872153;2865.4842128416876;2871.1673614651727;2878.8992385266624;15089.47186848466;15857.207139643087;15952;16330.918345408198;16956.660866782597;1603.815561210464;1873.7525693348034;1912.407153782332;1916.9808301916942;1940;148561.7715734265;154746;155251;157564;157591.2120439402;17613.55966100832;18627.720584191247;21682.24112156067;22052;22053.779462205493;30496.237594060327;37200.81399592985;37349.253014939546;38203.42694859579;38928.22143557113;8370.455920365279;8931.464112153291;10101.242406819518;10240.334378265388;10278.280520363653;7811;7986.880196796937;8011.839763204704;8291.95854020726;8316.584170791437;8443.831123377498;10009.599616015423;10372;10483.318584291997;10492.685219443429;3666.385813071144;3695.1685870678884;3868;3954.959338291527;3978.482797236341;800.983980320402;806.7902345390123;823.6664151018847;824.4352618456377;852.6376290076693;19158.425247242605;20194.09126589307;20989.055492502568;22072.44818879541;22203.555928881655;1001.464216644092;1020.2552136939927;1025.5333823110466;1068.6420049283422;1074.215822449616;10666;10898.07366373867;10940.343579385262;10964.342139471657;11002.779944401067;704269;706150;712355;726658;728204;105628;132061;146756;150092;158301;1019.1388276906002;1036.9688909332733;1055.1137044882337;1058.8676415448224;1060.7931453366518;17589.20848561792;18445.90777046106;19155.808441915404;19195.904020479808;19255.711164332268;36501.45247821338;49484.25773613471;52682.73658631682;55062;56316.49366087471;63716;81947;83476.58261708895;84607.57696211725;87391;7868.544319300948;7929.920700792918;8183.508989460652;8322.833543329221;8335.416520843726;11181.776364472827;12207.38963051826;12659.11386202957;12664.6833829155;12702.745945081231;10744.46277686097;10800.567977281135;10934.781304374028;11024.724381890517;11077.390743509184;10617.522211500656;10726.570937162425;10820.04612541558;10878;10949.56201751921;11191.384473854016;11287.661370158909;11478.483468244116;11592.536298547964;11604.245724027911;7758.418118641237;7947.721829735931;8042.798930026796;8251.752447426587;8400.83198336042;9634.759131021781;9903.95048024784;10641.840372394576;10904.236703430684;10988.175886808362 14:08:19 INFO - PROCESS | 1635 | |3;mootools.html;1402.614281072705;1424.7577911755006;1426.1514398932632;1427.9928600356998;1437.5615437291626;8144.307733842623;8281.254687078177;8529.744107676772;8535.57322133894;8548.65805367786;7994.840103197933;8349.123342049088;8350.206730360605;8444.113368096354;8480.533570653612;2236.955260894777;2274.624686926655;2276.601594720917;2278.943026424344;2285.5771682238756;1981.564055907698;2229.8885055747146;2283.600369935263;2290.3129061281634;2291.163725240284;2011.3463124484529;2200.7909248621354;2278.020451205981;2283.4405570635217;2288.5194109236995;2170.9891450542805;2189.2884812436023;2192.1341070277153;2195.4182141732454;2196.3850121965797;1883.896385698786;2218.9778102219093;2272.47733021406;2272.522770218256;2276.920307789236;8332.916670833274;8405.663773449054;8413.621387037598;8423.241908228227;8435.662573497053;5042.268871013719;5181.740912954375;5182.274481572583;5197.298364720752;5198.350206224222;3240.627327857303;3337.3801565770996;3418.102952861161;3428.9657103428895;3489.5114683944266;951.6431338248157;1155.9364234967074;1227.245244174835;1238.052889539503;1241.6150993192139;10789.97495237951;10827.24209305349;10881.129509639131;10894.509747061322;10907.236493445462;3413.6415676354122;4382.8466003690355;4458.9331160032625;4470.485894122153;4490.348899409567;8785.604647790864;8793.428427152214;8807.515586642668;8808.515531645693;8819.162179592928;5097.821576244888;5110.693358398508;5112.258722485293;5115.309433226466;5123;4502.257127573979;4549.6805926281;4631.62946964242;4748.7863046163;4768.833090841804;3448.2241495663275;3495.965040349615;3505.369033573981;3527.6119626841028;3537.451694987281;1048.7063622185647;1131.7114135895458;1137.5790957345835;1141.7431078007548;1143.8684551276542;719.3238355945394;725.3073314984177;799.2526987266808;833.7373727275889;883.3463237204422;5388.245645609618;5394.865128371822;5650.85872853182;5728.198052272685;5896.7641294348605;886.9246114080246;926.9756918604979;935.1350001248953;941.3316545252948;987.6740675577186;3643.9453408198897;3647.6717095461004;3776;3814.790186539767;3834.5206849143856;7840.9215907841335;9520.8571871422;10047.09576138151;10094.747631309276;10178;10006.299559030944;10120.038596333337;10129.949350253202;10142.137918277029;10143.934886836923;7301.379382752525;7698.307152356315;7773.028371453568;7796.5322080674205;7821.765347039598;5242.962918552769;5247.921281180709;5459.890802184013;5489.560835133259;5836.358000620014;7065.470089743187;8848.778780530538;9347.158755711747;9356.391834530734;9375.10936461035;9057.18485336323;9090.181883630505;9375.531223438664;9498.810023799348;9509.66716164931;7027.964860175666;7186.964065179641;7244.492885497964;7248.891266630899;7258.673359698721;7721;7736.2650548197835;7753.844923101619;7806.92193078062;7896.052473703192;5562.72186390687;5948.791792287249;7093.538919970186;7162.283771622796;7163.677634506564;5501.9174712380145;6710.966445167938;6737.629430381376;6960.303969602999;7005.754798582229;5549.472800083986;6147.770445910746;6181.876362472815;6279.748810047547;6351.301356850835;4701.177293973609;4732.692374995614;4896.290037944407;4912.508749125059;5007.549320561167;4707.19977603815;4751.786169622306;4806.399200099988;4810.230363141881;5075.6193285502995 14:08:19 INFO - PROCESS | 1635 | |4;prototype.html;350.1246882793017;354.62941226418394;363.31152466076776;368.491481755178;371.8865745947488;4257.361395790633;4570.725756454611;5122.487751224876;5181;5197.636165468419;4155.646770024551;4998.400191976959;5108.310378098956;5143;5223.753785872073;4085.7957102144924;4092.3452247640384;4107.034846810997;4118.546959834416;4126.360414135814;3404.948925766103;3899.298126337258;4113.300738874398;4125.133721918401;4140.523839758436;3544.5746510418785;4017.899552511196;4035.899102522431;4036.9394459083137;4079.6124368184974;4032.778197199153;4038.909494436515;4051.270771261172;4053.3919912013434;4055.3575801800316;3016.6078409806805;3147.5436061770915;3449.292894956528;3584.602005217967;3602.1354874830113;4414.823407063714;4818.180909245437;4942.555170034678;4947.317911909932;5001.549860512571;4640.582347588699;4695.178343789823;4699.530046995307;4703.764811759398;4707.975570504682;5160.922586161173;5459.617826752129;5468.894475626912;5487.807926722546;5544.445555444423;3285.895643669014;3810.314143454177;3908.9119595519505;3992.6207010333974;3992.840286388541;4552.56750608695;5576.462709467223;5608.6634801911605;5657.3494048184575;5664.49019588239;3863.5363756349416;3983.92032159361;4035.7174997750462;4056.452378928866;4083.9795801020805;3825.024618722208;3933.9213215735526;4100.302948498763;4141.97929010353;4152.069287781196;3971.702122340836;4190.20386126635;4483.708558943658;4618.168729628632;4629.916537558112;4473.955260447419;5388.234588989743;5392.676439413648;5455.727213639302;5479;1152.6168597682815;1164.5923926625612;1285.8778416050461;1288.9484420623257;1327.5220920468623;836.2897873847874;895.0646574329841;938.5776400619749;943.919766819828;950.9096635819586;4250.853319073848;4685.8594242172785;4692.967547139624;4889.168841296988;4960.998595849531;4973.626977976666;5124.333836601292;5138.640295179302;5379.246905433242;5441.5374693151525;4585.968157164678;4761.857144285677;4780.593649539828;4791.736454495036;4818.68678535894;2278.7037685101163;2494.862782546941;2575.8794924207655;2652.713433984516;2755.8622068896875;4073.857414990461;4629.791659375336;4696.7651617419;5073.365829271341;5298.735063246822;5339.652922560022;5412.864678383072;5424.321959755031;5450.065226844493;5480.657238976397;5193.428722840485;5307.938412317552;5319.4414586467865;5429.457054294539;5492.890142197134;4111.814968326492;5292.5501332387175;5392.865178370572;5641.323041235078;5688.269630577429;5357.678539287655;5645.491905728504;5658.632188907708;5670.432956704297;5676.17695434168;5634.563186387445;5897.557683173865;5897.938371093244;5905.291365036223;5979.684469416721;3204.983975080203;3330.6336303007133;3766.924661506809;3795.8671446500343;3832.865849695247;4730.668853180245;5592.7762889483965;5624.578156638187;5641.9435805641415;5731.914021289767;4854.878628034327;4993.725345106054;5036.834161310525;5359.802480982778;5514.187764240186;4543.931841022321;5299.258103865385;5485.122380419273;5517.751701173537;5539.695316757456;4407.347244783206;5063.974680126576;5209.739513024258;5262.552683021986;5334.813281535127;4539.773011349485;5082.517160869711;5398.569379114616;5401.972990135024;5480.205370221375;4837.71800472882;4882.95117048825;5342.6260161788305;5344.839654810362;5359.758810853443 14:08:19 INFO - PROCESS | 1635 | |5;yui.html;693.6705065094078;698.5319835710077;702.9683664235109;751.4138971602152;838.5597561280327;13480.730385392286;14560.199189044599;15853.445129420472;16457.177141142925;16647.1676416179;14837.85162148381;15025.774613380781;15232.619184520392;15259.618509537268;15441.922790386032;799.2447137455092;867.1718508824058;868.583080121542;871.5947084605657;872.7687162901836;842.6839935024366;873.0614589316478;882.1090698394604;882.9205371516563;884.9159329863653;923.0077666508497;923.0999775219175;924.5146298193436;926.1988380051241;927.5640448988964;919.0809190809191;920.1396694091046;921.9858156028382;922.179260458186;922.3267015078997;688.6591137387026;688.6625553478759;689.7482418917109;690.3131384272681;691.7647999680133;14313.42746290147;14544.854551454457;14576.489822856256;14580.416783328761;14638.41446342145;13307.225063938631;13357.732845343136;13558.796618050737;13630;13684.384202710802;11284.887151128465;11545.134114941413;11551.76896462066;11567.826482602768;12081.335526546036;3590.263995880838;3592.5329707138167;3669.3028324618235;3671.0822294426393;3764.0966168119726;96072;98547.52178717325;98979.50510247475;99037;99260.02219933414;9245.982941876387;9780.728505294266;10404;10435;10708.946455267675;18551.90724046371;21208.25771098004;21553;21846;21916;7236.565806051653;7241.818954526179;7259.4918355715645;7270.200277969419;7471.402287816962;4010.5451819341724;4045.8179381927885;4048.6558642515715;4069.3895915612893;4090.202410529918;3549.5563054618174;3620.2216523447587;3652.7990960496895;3658.158623516606;3660.9633903660624;542.620165883875;554.5563549160655;555.7776889244254;560.9719514024282;578.2222910185877;661.9966900165468;666.1506579111672;684.2815044203666;692.9203141638675;707.9221285658573;9464.337496375325;9895.861975872724;9912.851307230398;9942.552585133686;9953.954834742393;582.909649004405;659.6932426421737;668.4084585142184;684.6405637040593;692.8510370270316;4465.196264672325;4677.46209185948;4687.484376718558;4702.388689470347;4832.299316599144;94420.52789736008;95175;96215.03784962201;96460.51769741246;99811;72319.27680723126;72729.6363518179;75989;81765.59117204495;84649.57675211584;68654.97017544841;69474.65262673654;70303;70659;72778;9083.227925626132;10142.442165680959;10413.77865983194;10594.947025264824;10727.731806704895;44984.550154499346;45471.54528454673;46023.539764603265;46365.53634463612;47103.52896470991;49623.00753984972;60532.69733651303;66673.33326666865;68609;68840.31159688339;12565.560205392767;12591.496340146292;12902.096853220184;12999.870001299865;13083;14045.789313160516;14090.929545352208;14137.151770893779;14353.569392918229;14681.48614798477;11428.314301141958;13021.218726876039;13223.296439194219;13756.312184390941;13761.655958601115;11888.524459021888;12798.61604151877;12950.935245323713;13399.196048237138;13694.931525342708;12727.2999984998;13113.934430327787;13137.34313284351;13388.330583470983;13528.323583820573;10493;10847.858021995362;10930.6723415181;10964.342139471657;11011.064059554707;9630.807383852423;10076.97690692804;10442.582296708351;10450.320729152581;10472.424016678851 14:08:19 INFO - PROCESS | 1635 | __end_tp_report 14:08:19 INFO - PROCESS | 1635 | __start_cc_report 14:08:19 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,1604 14:08:19 INFO - PROCESS | 1635 | __end_cc_report 14:08:19 INFO - PROCESS | 1635 | __startTimestamp1486764499053__endTimestamp 14:08:19 INFO - PROCESS | 1635 | 14:08:19 INFO - PROCESS | 1635 | ------- Summary: start ------- 14:08:19 INFO - PROCESS | 1635 | Number of tests: 6 14:08:19 INFO - PROCESS | 1635 | 14:08:19 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5678.62 Median:5863.32 stddev:629.16 (10.7%) stddev-sans-first:603.73 14:08:19 INFO - PROCESS | 1635 | Values: 3339.2 3348.1 3351.1 3364.4 3386.5 5433.0 5530.3 5606.9 5645.5 5686.4 5323.3 5531.8 5580.7 5602.9 5607.4 4541.0 4913.0 5085.5 5106.1 5204.6 5130.1 5206.5 5211.1 5213.2 5216.7 5171.4 5172.1 5210.0 5235.0 5237.6 5169.7 5246.2 5257.4 5259.3 5267.0 5090.1 5162.2 5192.7 5215.7 5247.0 5133.7 5384.4 5469.9 5520.3 5531.8 6174.6 6205.0 6261.4 6272.9 6286.4 6192.8 6263.4 6272.8 6290.0 6295.3 5547.2 5846.7 5863.3 5866.9 5902.0 6135.0 6175.6 6219.7 6283.4 6298.0 6092.4 6098.3 6099.6 6102.5 6116.3 6226.7 6231.0 6241.0 6249.5 6262.7 5867.3 6003.6 6115.6 6125.1 6149.8 5853.1 5986.7 5995.0 6134.1 6164.8 4908.4 4943.6 4956.0 4981.5 4991.1 4432.0 4454.0 4498.6 4503.9 4506.7 5444.1 5502.1 5509.9 5652.5 5676.9 6150.6 6171.0 6194.8 6267.6 6272.2 5620.6 5627.9 5645.2 5645.3 5667.1 5214.0 5388.6 5389.1 5392.2 5399.8 6155.6 6182.3 6213.6 6247.0 6251.5 6231.3 6238.8 6251.9 6255.6 6261.5 6234.9 6236.6 6239.5 6247.1 6252.5 5912.9 6000.5 6116.1 6117.1 6123.2 5312.9 6255.5 6258.6 6264.3 6264.8 6048.8 6068.4 6080.3 6087.6 6089.4 5713.4 5832.5 5993.1 6015.9 6098.1 5914.4 5914.6 5929.7 5964.4 5965.6 5788.5 6084.4 6099.5 6116.4 6120.7 5704.1 5742.7 5782.9 5783.9 5794.2 14:08:19 INFO - PROCESS | 1635 | 14:08:19 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:49861.76 Median:32663.44 stddev:97823.47 (299.5%) stddev-sans-first:98027.53 14:08:19 INFO - PROCESS | 1635 | Values: 442.8 445.7 505.3 510.8 513.6 25049.5 37838.7 39236.6 39264.4 41318.2 40034.8 40334.0 40377.0 40379.4 40426.8 8912.4 9150.6 9157.5 9163.7 9188.8 7642.0 7868.0 10609.5 10876.5 10904.0 10692.3 10774.6 10795.1 10899.6 10916.6 7619.1 10693.1 10765.5 10774.4 10778.1 7726.5 10489.4 10806.8 10818.7 10866.8 38134.9 38418.2 38472.8 38507.8 38647.0 3764.6 3781.8 3796.1 3803.4 3884.0 28378.2 28879.3 29022.7 29442.4 29658.1 2552.6 3043.2 3077.2 3095.5 3143.1 333391.3 335379.3 336999.0 337664.0 337939.0 47849.9 58530.4 58747.7 58824.8 58853.7 48895.8 51231.7 51243.2 51322.0 51360.0 14108.7 14679.3 14708.8 15095.8 15135.3 11399.3 11466.1 11487.2 11490.7 11497.3 16210.4 16304.1 16321.9 16348.3 16373.2 5910.6 5942.6 7130.4 7138.2 7165.8 730.6 770.1 785.2 828.5 829.8 28622.7 28772.4 28817.0 29369.9 29389.6 1008.5 1011.4 1019.2 1031.6 1159.5 11353.7 14170.4 14822.9 15086.8 15188.5 212686.0 214737.0 214980.0 215043.0 216238.0 56032.4 56250.9 56281.0 56390.7 56473.0 1320.1 1357.9 1358.7 1360.4 1361.7 25032.5 25733.1 27958.7 28992.6 29057.9 47450.5 47909.0 48497.0 48518.0 51462.5 423801.0 502339.0 516015.0 516301.0 517779.0 21313.5 21862.5 21950.1 23929.6 23945.8 37664.0 40128.6 40193.2 40497.8 40601.2 27148.6 32610.5 33046.0 33901.3 34167.0 27555.4 32716.3 33063.0 33535.5 34082.6 32547.7 33123.7 33172.2 33349.3 33501.2 27635.4 29500.0 29605.4 30210.8 30578.0 22477.7 22536.7 22731.3 22758.9 22773.3 14:08:19 INFO - PROCESS | 1635 | 14:08:19 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:41060.50 Median:14987.64 stddev:119330.26 (796.2%) stddev-sans-first:119625.85 14:08:19 INFO - PROCESS | 1635 | Values: 343.9 390.6 401.4 410.3 415.6 11244.2 18770.6 20285.0 20783.6 21062.6 21180.7 21782.7 21986.0 22079.8 22457.9 6426.5 6460.0 6575.6 6666.9 6686.4 6505.3 6626.4 6642.3 7267.2 7653.0 7760.3 7769.0 7774.2 7788.5 7788.6 7241.2 7575.6 7639.7 7736.5 7761.8 6843.3 7153.1 7201.9 7299.7 7521.9 27242.9 27845.6 27872.0 27902.3 28113.6 2732.4 2768.7 2865.5 2871.2 2878.9 15089.5 15857.2 15952.0 16330.9 16956.7 1603.8 1873.8 1912.4 1917.0 1940.0 148561.8 154746.0 155251.0 157564.0 157591.2 17613.6 18627.7 21682.2 22052.0 22053.8 30496.2 37200.8 37349.3 38203.4 38928.2 8370.5 8931.5 10101.2 10240.3 10278.3 7811.0 7986.9 8011.8 8292.0 8316.6 8443.8 10009.6 10372.0 10483.3 10492.7 3666.4 3695.2 3868.0 3955.0 3978.5 801.0 806.8 823.7 824.4 852.6 19158.4 20194.1 20989.1 22072.4 22203.6 1001.5 1020.3 1025.5 1068.6 1074.2 10666.0 10898.1 10940.3 10964.3 11002.8 704269.0 706150.0 712355.0 726658.0 728204.0 105628.0 132061.0 146756.0 150092.0 158301.0 1019.1 1037.0 1055.1 1058.9 1060.8 17589.2 18445.9 19155.8 19195.9 19255.7 36501.5 49484.3 52682.7 55062.0 56316.5 63716.0 81947.0 83476.6 84607.6 87391.0 7868.5 7929.9 8183.5 8322.8 8335.4 11181.8 12207.4 12659.1 12664.7 12702.7 10744.5 10800.6 10934.8 11024.7 11077.4 10617.5 10726.6 10820.0 10878.0 10949.6 11191.4 11287.7 11478.5 11592.5 11604.2 7758.4 7947.7 8042.8 8251.8 8400.8 9634.8 9904.0 10641.8 10904.2 10988.2 14:08:19 INFO - PROCESS | 1635 | 14:08:19 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:5319.78 Median:5113.78 stddev:2948.95 (57.7%) stddev-sans-first:2942.53 14:08:19 INFO - PROCESS | 1635 | Values: 1402.6 1424.8 1426.2 1428.0 1437.6 8144.3 8281.3 8529.7 8535.6 8548.7 7994.8 8349.1 8350.2 8444.1 8480.5 2237.0 2274.6 2276.6 2278.9 2285.6 1981.6 2229.9 2283.6 2290.3 2291.2 2011.3 2200.8 2278.0 2283.4 2288.5 2171.0 2189.3 2192.1 2195.4 2196.4 1883.9 2219.0 2272.5 2272.5 2276.9 8332.9 8405.7 8413.6 8423.2 8435.7 5042.3 5181.7 5182.3 5197.3 5198.4 3240.6 3337.4 3418.1 3429.0 3489.5 951.6 1155.9 1227.2 1238.1 1241.6 10790.0 10827.2 10881.1 10894.5 10907.2 3413.6 4382.8 4458.9 4470.5 4490.3 8785.6 8793.4 8807.5 8808.5 8819.2 5097.8 5110.7 5112.3 5115.3 5123.0 4502.3 4549.7 4631.6 4748.8 4768.8 3448.2 3496.0 3505.4 3527.6 3537.5 1048.7 1131.7 1137.6 1141.7 1143.9 719.3 725.3 799.3 833.7 883.3 5388.2 5394.9 5650.9 5728.2 5896.8 886.9 927.0 935.1 941.3 987.7 3643.9 3647.7 3776.0 3814.8 3834.5 7840.9 9520.9 10047.1 10094.7 10178.0 10006.3 10120.0 10129.9 10142.1 10143.9 7301.4 7698.3 7773.0 7796.5 7821.8 5243.0 5247.9 5459.9 5489.6 5836.4 7065.5 8848.8 9347.2 9356.4 9375.1 9057.2 9090.2 9375.5 9498.8 9509.7 7028.0 7187.0 7244.5 7248.9 7258.7 7721.0 7736.3 7753.8 7806.9 7896.1 5562.7 5948.8 7093.5 7162.3 7163.7 5501.9 6711.0 6737.6 6960.3 7005.8 5549.5 6147.8 6181.9 6279.7 6351.3 4701.2 4732.7 4896.3 4912.5 5007.5 4707.2 4751.8 4806.4 4810.2 5075.6 14:08:19 INFO - PROCESS | 1635 | 14:08:19 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4383.17 Median:4804.96 stddev:1316.96 (27.4%) stddev-sans-first:1285.40 14:08:19 INFO - PROCESS | 1635 | Values: 350.1 354.6 363.3 368.5 371.9 4257.4 4570.7 5122.5 5181.0 5197.6 4155.6 4998.4 5108.3 5143.0 5223.8 4085.8 4092.3 4107.0 4118.5 4126.4 3404.9 3899.3 4113.3 4125.1 4140.5 3544.6 4017.9 4035.9 4036.9 4079.6 4032.8 4038.9 4051.3 4053.4 4055.4 3016.6 3147.5 3449.3 3584.6 3602.1 4414.8 4818.2 4942.6 4947.3 5001.5 4640.6 4695.2 4699.5 4703.8 4708.0 5160.9 5459.6 5468.9 5487.8 5544.4 3285.9 3810.3 3908.9 3992.6 3992.8 4552.6 5576.5 5608.7 5657.3 5664.5 3863.5 3983.9 4035.7 4056.5 4084.0 3825.0 3933.9 4100.3 4142.0 4152.1 3971.7 4190.2 4483.7 4618.2 4629.9 4474.0 5388.2 5392.7 5455.7 5479.0 1152.6 1164.6 1285.9 1288.9 1327.5 836.3 895.1 938.6 943.9 950.9 4250.9 4685.9 4693.0 4889.2 4961.0 4973.6 5124.3 5138.6 5379.2 5441.5 4586.0 4761.9 4780.6 4791.7 4818.7 2278.7 2494.9 2575.9 2652.7 2755.9 4073.9 4629.8 4696.8 5073.4 5298.7 5339.7 5412.9 5424.3 5450.1 5480.7 5193.4 5307.9 5319.4 5429.5 5492.9 4111.8 5292.6 5392.9 5641.3 5688.3 5357.7 5645.5 5658.6 5670.4 5676.2 5634.6 5897.6 5897.9 5905.3 5979.7 3205.0 3330.6 3766.9 3795.9 3832.9 4730.7 5592.8 5624.6 5641.9 5731.9 4854.9 4993.7 5036.8 5359.8 5514.2 4543.9 5299.3 5485.1 5517.8 5539.7 4407.3 5064.0 5209.7 5262.6 5334.8 4539.8 5082.5 5398.6 5402.0 5480.2 4837.7 4883.0 5342.6 5344.8 5359.8 14:08:19 INFO - PROCESS | 1635 | 14:08:19 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:19177.55 Median:25521.50 stddev:26851.50 (105.2%) stddev-sans-first:26890.96 14:08:19 INFO - PROCESS | 1635 | Values: 693.7 698.5 703.0 751.4 838.6 13480.7 14560.2 15853.4 16457.2 16647.2 14837.9 15025.8 15232.6 15259.6 15441.9 799.2 867.2 868.6 871.6 872.8 842.7 873.1 882.1 882.9 884.9 923.0 923.1 924.5 926.2 927.6 919.1 920.1 922.0 922.2 922.3 688.7 688.7 689.7 690.3 691.8 14313.4 14544.9 14576.5 14580.4 14638.4 13307.2 13357.7 13558.8 13630.0 13684.4 11284.9 11545.1 11551.8 11567.8 12081.3 3590.3 3592.5 3669.3 3671.1 3764.1 96072.0 98547.5 98979.5 99037.0 99260.0 9246.0 9780.7 10404.0 10435.0 10708.9 18551.9 21208.3 21553.0 21846.0 21916.0 7236.6 7241.8 7259.5 7270.2 7471.4 4010.5 4045.8 4048.7 4069.4 4090.2 3549.6 3620.2 3652.8 3658.2 3661.0 542.6 554.6 555.8 561.0 578.2 662.0 666.2 684.3 692.9 707.9 9464.3 9895.9 9912.9 9942.6 9954.0 582.9 659.7 668.4 684.6 692.9 4465.2 4677.5 4687.5 4702.4 4832.3 94420.5 95175.0 96215.0 96460.5 99811.0 72319.3 72729.6 75989.0 81765.6 84649.6 68655.0 69474.7 70303.0 70659.0 72778.0 9083.2 10142.4 10413.8 10594.9 10727.7 44984.6 45471.5 46023.5 46365.5 47103.5 49623.0 60532.7 66673.3 68609.0 68840.3 12565.6 12591.5 12902.1 12999.9 13083.0 14045.8 14090.9 14137.2 14353.6 14681.5 11428.3 13021.2 13223.3 13756.3 13761.7 11888.5 12798.6 12950.9 13399.2 13694.9 12727.3 13113.9 13137.3 13388.3 13528.3 10493.0 10847.9 10930.7 10964.3 11011.1 9630.8 10077.0 10442.6 10450.3 10472.4 14:08:19 INFO - PROCESS | 1635 | -------- Summary: end -------- 14:08:19 INFO - PROCESS | 1635 | 14:08:19 INFO - TEST-INFO | 1635: exit 0 14:08:19 INFO - TEST-OK | dromaeo_css | took 1119055ms 14:08:19 INFO - TEST-START | kraken 14:08:19 INFO - operating with platform_type : mac_ 14:08:19 INFO - Initialising browser for kraken test... 14:08:19 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/tmpz_pi2z/profile http://localhost:49240/getInfo.html) 14:08:21 INFO - PROCESS | 1646 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 14:08:21 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 14:08:21 INFO - PROCESS | 1646 | colorDepth:24 14:08:21 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 14:08:21 INFO - PROCESS | 1646 | __metrics 14:08:22 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:08:22 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:08:22 INFO - TEST-INFO | 1646: exit 0 14:08:22 INFO - Browser initialized. 14:08:22 INFO - Running cycle 1/1 for kraken test... 14:08:22 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/tmpz_pi2z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:08:34 INFO - PROCESS | 1647 | RSS: Main: 237371392 14:08:34 INFO - PROCESS | 1647 | 14:08:37 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 14:08:38 INFO - PROCESS | 1647 | RSS: Main: 288980992 14:08:38 INFO - PROCESS | 1647 | 14:08:41 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 14:08:41 INFO - PROCESS | 1647 | RSS: Main: 290799616 14:08:41 INFO - PROCESS | 1647 | 14:08:45 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 14:08:45 INFO - PROCESS | 1647 | RSS: Main: 381063168 14:08:45 INFO - PROCESS | 1647 | 14:08:47 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 14:08:48 INFO - PROCESS | 1647 | RSS: Main: 284504064 14:08:48 INFO - PROCESS | 1647 | 14:08:50 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:08:51 INFO - PROCESS | 1647 | RSS: Main: 288071680 14:08:51 INFO - PROCESS | 1647 | 14:08:53 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 14:08:54 INFO - PROCESS | 1647 | RSS: Main: 330092544 14:08:54 INFO - PROCESS | 1647 | 14:08:57 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 14:08:58 INFO - PROCESS | 1647 | RSS: Main: 333008896 14:08:58 INFO - PROCESS | 1647 | 14:09:00 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 14:09:01 INFO - PROCESS | 1647 | RSS: Main: 331190272 14:09:01 INFO - PROCESS | 1647 | 14:09:03 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:09:03 INFO - PROCESS | 1647 | RSS: Main: 305635328 14:09:03 INFO - PROCESS | 1647 | 14:09:05 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:09:06 INFO - PROCESS | 1647 | RSS: Main: 308686848 14:09:06 INFO - PROCESS | 1647 | 14:09:08 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:09:09 INFO - PROCESS | 1647 | RSS: Main: 310751232 14:09:09 INFO - PROCESS | 1647 | 14:09:12 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:09:13 INFO - PROCESS | 1647 | RSS: Main: 328945664 14:09:13 INFO - PROCESS | 1647 | 14:09:16 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:09:16 INFO - PROCESS | 1647 | RSS: Main: 322723840 14:09:16 INFO - PROCESS | 1647 | 14:09:18 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 14:09:18 INFO - PROCESS | 1647 | RSS: Main: 367976448 14:09:18 INFO - PROCESS | 1647 | 14:09:18 INFO - PROCESS | 1647 | __start_tp_report 14:09:18 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 14:09:18 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 14:09:18 INFO - PROCESS | 1647 | |i|pagename|runs| 14:09:18 INFO - PROCESS | 1647 | |0;ai-astar;114;114;115;114;115;113;114;114;115;112 14:09:18 INFO - PROCESS | 1647 | |1;audio-beat-detection;143;112;110;157;144;142;119;113;133;113 14:09:18 INFO - PROCESS | 1647 | |2;audio-dft;185;186;183;185;185;182;182;184;185;189 14:09:18 INFO - PROCESS | 1647 | |3;audio-fft;80;60;60;88;62;59;60;60;66;66 14:09:18 INFO - PROCESS | 1647 | |4;audio-oscillator;93;71;86;69;70;70;85;69;69;85 14:09:18 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;88;88;88;88;89;87;88;88;88;88 14:09:18 INFO - PROCESS | 1647 | |6;imaging-darkroom;94;94;95;94;95;94;96;94;94;95 14:09:18 INFO - PROCESS | 1647 | |7;imaging-desaturate;89;84;85;86;87;90;86;87;85;87 14:09:18 INFO - PROCESS | 1647 | |8;json-parse-financial;62;61;61;60;59;61;59;59;54;58 14:09:18 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;64;68;79;74;71;66;68;68;67;69 14:09:18 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;101;112;109;108;90;90;89;89;89;89 14:09:18 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;148;142;144;144;143;144;142;143;185;156 14:09:18 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;176;175;176;173;174;175;174;227;184;174 14:09:18 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;69;69;68;67;68;65;67;65;67;66 14:09:18 INFO - PROCESS | 1647 | __end_tp_report 14:09:18 INFO - PROCESS | 1647 | __start_cc_report 14:09:18 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,2099 14:09:18 INFO - PROCESS | 1647 | __end_cc_report 14:09:18 INFO - PROCESS | 1647 | __startTimestamp1486764558713__endTimestamp 14:09:18 INFO - PROCESS | 1647 | 14:09:18 INFO - PROCESS | 1647 | ------- Summary: start ------- 14:09:18 INFO - PROCESS | 1647 | Number of tests: 14 14:09:18 INFO - PROCESS | 1647 | 14:09:18 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:0.94 (0.8%) stddev-sans-first:1.00 14:09:18 INFO - PROCESS | 1647 | Values: 114.0 114.0 115.0 114.0 115.0 113.0 114.0 114.0 115.0 112.0 14:09:18 INFO - PROCESS | 1647 | 14:09:18 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:137.50 stddev:17.16 (12.5%) stddev-sans-first:17.39 14:09:18 INFO - PROCESS | 1647 | Values: 143.0 112.0 110.0 157.0 144.0 142.0 119.0 113.0 133.0 113.0 14:09:18 INFO - PROCESS | 1647 | 14:09:18 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:184.60 Median:185.00 stddev:2.07 (1.1%) stddev-sans-first:2.19 14:09:18 INFO - PROCESS | 1647 | Values: 185.0 186.0 183.0 185.0 185.0 182.0 182.0 184.0 185.0 189.0 14:09:18 INFO - PROCESS | 1647 | 14:09:18 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:66.10 Median:64.00 stddev:9.94 (15.5%) stddev-sans-first:9.18 14:09:18 INFO - PROCESS | 1647 | Values: 80.0 60.0 60.0 88.0 62.0 59.0 60.0 60.0 66.0 66.0 14:09:18 INFO - PROCESS | 1647 | 14:09:18 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:78.00 stddev:9.37 (12.0%) stddev-sans-first:7.87 14:09:18 INFO - PROCESS | 1647 | Values: 93.0 71.0 86.0 69.0 70.0 70.0 85.0 69.0 69.0 85.0 14:09:18 INFO - PROCESS | 1647 | 14:09:18 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:88.00 Median:88.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 14:09:18 INFO - PROCESS | 1647 | Values: 88.0 88.0 88.0 88.0 89.0 87.0 88.0 88.0 88.0 88.0 14:09:18 INFO - PROCESS | 1647 | 14:09:18 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 14:09:18 INFO - PROCESS | 1647 | Values: 94.0 94.0 95.0 94.0 95.0 94.0 96.0 94.0 94.0 95.0 14:09:18 INFO - PROCESS | 1647 | 14:09:18 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:86.60 Median:87.00 stddev:1.84 (2.1%) stddev-sans-first:1.73 14:09:18 INFO - PROCESS | 1647 | Values: 89.0 84.0 85.0 86.0 87.0 90.0 86.0 87.0 85.0 87.0 14:09:18 INFO - PROCESS | 1647 | 14:09:18 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:60.50 stddev:2.27 (3.8%) stddev-sans-first:2.20 14:09:18 INFO - PROCESS | 1647 | Values: 62.0 61.0 61.0 60.0 59.0 61.0 59.0 59.0 54.0 58.0 14:09:18 INFO - PROCESS | 1647 | 14:09:18 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:68.50 stddev:4.33 (6.3%) stddev-sans-first:4.12 14:09:18 INFO - PROCESS | 1647 | Values: 64.0 68.0 79.0 74.0 71.0 66.0 68.0 68.0 67.0 69.0 14:09:18 INFO - PROCESS | 1647 | 14:09:18 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:96.60 Median:89.00 stddev:9.77 (11.0%) stddev-sans-first:10.23 14:09:18 INFO - PROCESS | 1647 | Values: 101.0 112.0 109.0 108.0 90.0 90.0 89.0 89.0 89.0 89.0 14:09:18 INFO - PROCESS | 1647 | 14:09:18 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:149.10 Median:144.00 stddev:13.30 (9.2%) stddev-sans-first:14.10 14:09:18 INFO - PROCESS | 1647 | Values: 148.0 142.0 144.0 144.0 143.0 144.0 142.0 143.0 185.0 156.0 14:09:18 INFO - PROCESS | 1647 | 14:09:18 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.80 Median:175.50 stddev:16.52 (9.4%) stddev-sans-first:17.44 14:09:18 INFO - PROCESS | 1647 | Values: 176.0 175.0 176.0 173.0 174.0 175.0 174.0 227.0 184.0 174.0 14:09:18 INFO - PROCESS | 1647 | 14:09:18 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.45 (2.1%) stddev-sans-first:1.36 14:09:18 INFO - PROCESS | 1647 | Values: 69.0 69.0 68.0 67.0 68.0 65.0 67.0 65.0 67.0 66.0 14:09:18 INFO - PROCESS | 1647 | -------- Summary: end -------- 14:09:18 INFO - PROCESS | 1647 | 14:09:19 INFO - TEST-INFO | 1647: exit 0 14:09:19 INFO - TEST-OK | kraken | took 59930ms 14:09:19 INFO - SUITE-END | took 1178s 14:09:19 INFO - Completed test suite (00:19:39) 14:09:19 INFO - javascript benchmark 14:09:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7200.4809046741275, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3339.215284408164, 3348.0625424881027, 3351.0617027232374, 3364.4448665970117, 3386.49202619607, 5432.972835135829, 5530.253415788868, 5606.915896261554, 5645.520130788883, 5686.4313568643165, 5323.281357016811, 5531.806386776464, 5580.693061881595, 5602.915956260659, 5607.411221821701, 4540.954590454086, 4913.017396520692, 5085.5423011929015, 5106.106431374513, 5204.609654275925, 5130.127878260686, 5206.505381988705, 5211.088059589557, 5213.1919552469235, 5216.6869987800665, 5171.405288391846, 5172.120739474299, 5210.036143313499, 5234.953009398117, 5237.554807841319, 5169.7156656383695, 5246.160614301732, 5257.369115706101, 5259.2899958505495, 5266.973665131688, 5090.083784918713, 5162.174052151638, 5192.740362981874, 5215.713135777531, 5247.029299579552, 5133.743312834381, 5384.40771515133, 5469.890602187934, 5520.337559492887, 5531.751071201766, 6174.629522228635, 6205.03821907605, 6261.373862613747, 6272.937270627281, 6286.4342209201395, 6192.845178870519, 6263.404976527223, 6272.8118156455375, 6289.968550157266, 6295.338989406138, 5547.1679248113105, 5846.7368968396095, 5863.3222830211525, 5866.882662346772, 5901.970490147522, 6135.030575315113, 6175.567710260329, 6219.689015549205, 6283.403076707706, 6297.96851015742, 6092.398214864459, 6098.32918378978, 6099.551912188652, 6102.511799056065, 6116.327204007555, 6226.657533835682, 6231.0, 6240.968795155995, 6249.531285153632, 6262.655553944485, 5867.295924489089, 6003.609765365237, 6115.553609370865, 6125.111858780452, 6149.846253843601, 5853.0635098384055, 5986.73059712314, 5995.0, 6134.079888016833, 6164.815055548341, 4908.41099068107, 4943.604511639061, 4956.033573453142, 4981.501849815062, 4991.051700176955, 4431.977840110843, 4453.977730111329, 4498.640108791289, 4503.864884053483, 4506.684532082788, 5444.074507333763, 5502.0921547944145, 5509.889802203934, 5652.519535839418, 5676.886462270814, 6150.630962142286, 6170.950938340493, 6194.783182588588, 6267.623942563369, 6272.18461599989, 5620.57845661577, 5627.887442251132, 5645.2096706461125, 5645.322561292589, 5667.121596152603, 5213.973930130401, 5388.568914486832, 5389.056915039931, 5392.164214546751, 5399.83800485986, 6155.569110162335, 6182.258129024546, 6213.565050446426, 6247.0, 6251.499880009679, 6231.345708700521, 6238.75044998195, 6251.874962500634, 6255.624662520263, 6261.499080073492, 6234.906476402948, 6236.6258024518675, 6239.500839932885, 6247.09417134522, 6252.531060170414, 5912.911306330322, 6000.489958353414, 6116.061877111602, 6117.1130186123655, 6123.173371594956, 5312.893742125213, 6255.499560035278, 6258.561900666909, 6264.342244064308, 6264.843378915563, 6048.848778780566, 6068.362821903813, 6080.300765412034, 6087.604305720114, 6089.360617135314, 5713.400092990176, 5832.50423713989, 5993.101034844808, 6015.909761353496, 6098.054801505774, 5914.378990205966, 5914.615549989237, 5929.673867937132, 5964.433378829004, 5965.552583556338, 5788.450097240755, 6084.421979911901, 6099.481544068626, 6116.449519543263, 6120.663363514871, 5704.0588302929555, 5742.741576629145, 5782.884342313214, 5783.94216057834, 5794.246747922743], "value": 5638.838266783073, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [442.7586965104018, 445.7036071012776, 505.345577477167, 510.8365323096608, 513.6276199755175, 25049.49901001979, 37838.67564635235, 39236.60763392365, 39264.41103383445, 41318.17363652725, 40034.79895603129, 40333.99165020876, 40377.0, 40379.394309085386, 40426.79786601063, 8912.420692654989, 9150.588223529958, 9157.542122893828, 9163.679271225508, 9188.816223675523, 7642.04474440695, 7868.0, 10609.522571484264, 10876.456177191109, 10904.0, 10692.305000174963, 10774.622888198915, 10795.08241799448, 10899.564017439332, 10916.617918372858, 7619.123800762928, 10693.091087257553, 10765.461726913623, 10774.40740759258, 10778.137748980063, 7726.536407815493, 10489.370637761758, 10806.837897431546, 10818.67543973682, 10866.782664346669, 38134.85595432114, 38418.231635367134, 38472.80763596164, 38507.807460962795, 38647.0, 3764.623537646241, 3781.8487260509546, 3796.088938654703, 3803.410471376941, 3883.961160388388, 28378.162980673565, 28879.278018049506, 29022.709772902213, 29442.411151776843, 29658.110256692333, 2552.642630031797, 3043.178341847689, 3077.1691643256418, 3095.5356696495483, 3143.104215298629, 333391.33304333565, 335379.32310338534, 336999.0, 337664.0, 337939.0, 47849.8655228612, 58530.414695853346, 58747.70626146842, 58824.82350352969, 58853.70573147107, 48895.75552122216, 51231.7438412813, 51243.23135152976, 51322.0, 51360.0, 14108.717825643429, 14679.266036698122, 14708.779368309484, 15095.849041509664, 15135.318910649048, 11399.259048161843, 11466.140039497071, 11487.195896287347, 11490.655280341603, 11497.310161390344, 16210.35158593643, 16304.103274319788, 16321.939073960155, 16348.264328105026, 16373.181340932906, 5910.581460449461, 5942.64344139353, 7130.3939165170505, 7138.179109402381, 7165.7850264492145, 730.5908691132983, 770.1220608506308, 785.1638005524098, 828.492144297373, 829.8464784014976, 28622.713772862004, 28772.42455150885, 28816.982811203434, 29369.853150734536, 29389.559156612668, 1008.5108722269694, 1011.3982180602529, 1019.2304809868501, 1031.5512751952924, 1159.4898244772273, 11353.659390218307, 14170.433182672577, 14822.88828337879, 15086.755075882586, 15188.46840360582, 212686.0, 214737.0, 214980.0, 215043.0, 216238.0, 56032.439675603535, 56250.87498250012, 56281.0, 56390.71804640951, 56473.0, 1320.108926474645, 1357.9049466537247, 1358.7418390505773, 1360.4422186903323, 1361.6800051987577, 25032.49805011705, 25733.099341522957, 27958.72041279561, 28992.565111522923, 29057.85471072631, 47450.52549474461, 47909.0, 48497.03005939932, 48518.02963940772, 51462.48537514577, 423801.0, 502339.0, 516015.0, 516301.0, 517779.0, 21313.467163321042, 21862.45343866416, 21950.121995120015, 23929.64105538453, 23945.76054239505, 37664.0, 40128.598714012485, 40193.1961360777, 40497.79751101226, 40601.1879762409, 27148.592771108055, 32610.53252603686, 33046.0, 33901.32197356089, 34167.0, 27555.448891021668, 32716.345673086882, 33063.008109756745, 33535.49696754502, 34082.636694532936, 32547.674523254464, 33123.66876331302, 33172.1706957328, 33349.33301334008, 33501.16247093842, 27635.447291053664, 29500.0, 29605.407891842475, 30210.800804187555, 30578.0, 22477.662835057814, 22536.66195007109, 22731.318060458212, 22758.886205568866, 22773.31680049601], "value": 17863.65469800137, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.86589230200224, 390.61524398467486, 401.36584196968784, 410.2861021822027, 415.61347946409825, 11244.212905096647, 18770.624587508242, 20284.985750712443, 20783.584328313424, 21062.57874842502, 21180.682289765668, 21782.673259901116, 21986.0, 22079.779202207974, 22457.877106144708, 6426.485881129498, 6460.0, 6575.638339891304, 6666.866662666768, 6686.398224159825, 6505.284418713938, 6626.436752876011, 6642.269350371455, 7267.164276108236, 7652.961735191344, 7760.262775036391, 7768.961155194216, 7774.222577742209, 7788.4937479063965, 7788.6105694715325, 7241.203467618558, 7575.621218939059, 7639.7394429918995, 7736.535807851547, 7761.805954851117, 6843.315668433167, 7153.105861767279, 7201.89197162043, 7299.744508942162, 7521.887171692429, 27242.863785681144, 27845.58231626527, 27872.0, 27902.302442438897, 28113.57829632557, 2732.412531305779, 2768.7231276872153, 2865.4842128416876, 2871.1673614651727, 2878.8992385266624, 15089.47186848466, 15857.207139643087, 15952.0, 16330.918345408198, 16956.660866782597, 1603.815561210464, 1873.7525693348034, 1912.407153782332, 1916.9808301916942, 1940.0, 148561.7715734265, 154746.0, 155251.0, 157564.0, 157591.2120439402, 17613.55966100832, 18627.720584191247, 21682.24112156067, 22052.0, 22053.779462205493, 30496.237594060327, 37200.81399592985, 37349.253014939546, 38203.42694859579, 38928.22143557113, 8370.455920365279, 8931.464112153291, 10101.242406819518, 10240.334378265388, 10278.280520363653, 7811.0, 7986.880196796937, 8011.839763204704, 8291.95854020726, 8316.584170791437, 8443.831123377498, 10009.599616015423, 10372.0, 10483.318584291997, 10492.685219443429, 3666.385813071144, 3695.1685870678884, 3868.0, 3954.959338291527, 3978.482797236341, 800.983980320402, 806.7902345390123, 823.6664151018847, 824.4352618456377, 852.6376290076693, 19158.425247242605, 20194.09126589307, 20989.055492502568, 22072.44818879541, 22203.555928881655, 1001.464216644092, 1020.2552136939927, 1025.5333823110466, 1068.6420049283422, 1074.215822449616, 10666.0, 10898.07366373867, 10940.343579385262, 10964.342139471657, 11002.779944401067, 704269.0, 706150.0, 712355.0, 726658.0, 728204.0, 105628.0, 132061.0, 146756.0, 150092.0, 158301.0, 1019.1388276906002, 1036.9688909332733, 1055.1137044882337, 1058.8676415448224, 1060.7931453366518, 17589.20848561792, 18445.90777046106, 19155.808441915404, 19195.904020479808, 19255.711164332268, 36501.45247821338, 49484.25773613471, 52682.73658631682, 55062.0, 56316.49366087471, 63716.0, 81947.0, 83476.58261708895, 84607.57696211725, 87391.0, 7868.544319300948, 7929.920700792918, 8183.508989460652, 8322.833543329221, 8335.416520843726, 11181.776364472827, 12207.38963051826, 12659.11386202957, 12664.6833829155, 12702.745945081231, 10744.46277686097, 10800.567977281135, 10934.781304374028, 11024.724381890517, 11077.390743509184, 10617.522211500656, 10726.570937162425, 10820.04612541558, 10878.0, 10949.56201751921, 11191.384473854016, 11287.661370158909, 11478.483468244116, 11592.536298547964, 11604.245724027911, 7758.418118641237, 7947.721829735931, 8042.798930026796, 8251.752447426587, 8400.83198336042, 9634.759131021781, 9903.95048024784, 10641.840372394576, 10904.236703430684, 10988.175886808362], "value": 11093.348445801757, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1402.614281072705, 1424.7577911755006, 1426.1514398932632, 1427.9928600356998, 1437.5615437291626, 8144.307733842623, 8281.254687078177, 8529.744107676772, 8535.57322133894, 8548.65805367786, 7994.840103197933, 8349.123342049088, 8350.206730360605, 8444.113368096354, 8480.533570653612, 2236.955260894777, 2274.624686926655, 2276.601594720917, 2278.943026424344, 2285.5771682238756, 1981.564055907698, 2229.8885055747146, 2283.600369935263, 2290.3129061281634, 2291.163725240284, 2011.3463124484529, 2200.7909248621354, 2278.020451205981, 2283.4405570635217, 2288.5194109236995, 2170.9891450542805, 2189.2884812436023, 2192.1341070277153, 2195.4182141732454, 2196.3850121965797, 1883.896385698786, 2218.9778102219093, 2272.47733021406, 2272.522770218256, 2276.920307789236, 8332.916670833274, 8405.663773449054, 8413.621387037598, 8423.241908228227, 8435.662573497053, 5042.268871013719, 5181.740912954375, 5182.274481572583, 5197.298364720752, 5198.350206224222, 3240.627327857303, 3337.3801565770996, 3418.102952861161, 3428.9657103428895, 3489.5114683944266, 951.6431338248157, 1155.9364234967074, 1227.245244174835, 1238.052889539503, 1241.6150993192139, 10789.97495237951, 10827.24209305349, 10881.129509639131, 10894.509747061322, 10907.236493445462, 3413.6415676354122, 4382.8466003690355, 4458.9331160032625, 4470.485894122153, 4490.348899409567, 8785.604647790864, 8793.428427152214, 8807.515586642668, 8808.515531645693, 8819.162179592928, 5097.821576244888, 5110.693358398508, 5112.258722485293, 5115.309433226466, 5123.0, 4502.257127573979, 4549.6805926281, 4631.62946964242, 4748.7863046163, 4768.833090841804, 3448.2241495663275, 3495.965040349615, 3505.369033573981, 3527.6119626841028, 3537.451694987281, 1048.7063622185647, 1131.7114135895458, 1137.5790957345835, 1141.7431078007548, 1143.8684551276542, 719.3238355945394, 725.3073314984177, 799.2526987266808, 833.7373727275889, 883.3463237204422, 5388.245645609618, 5394.865128371822, 5650.85872853182, 5728.198052272685, 5896.7641294348605, 886.9246114080246, 926.9756918604979, 935.1350001248953, 941.3316545252948, 987.6740675577186, 3643.9453408198897, 3647.6717095461004, 3776.0, 3814.790186539767, 3834.5206849143856, 7840.9215907841335, 9520.8571871422, 10047.09576138151, 10094.747631309276, 10178.0, 10006.299559030944, 10120.038596333337, 10129.949350253202, 10142.137918277029, 10143.934886836923, 7301.379382752525, 7698.307152356315, 7773.028371453568, 7796.5322080674205, 7821.765347039598, 5242.962918552769, 5247.921281180709, 5459.890802184013, 5489.560835133259, 5836.358000620014, 7065.470089743187, 8848.778780530538, 9347.158755711747, 9356.391834530734, 9375.10936461035, 9057.18485336323, 9090.181883630505, 9375.531223438664, 9498.810023799348, 9509.66716164931, 7027.964860175666, 7186.964065179641, 7244.492885497964, 7248.891266630899, 7258.673359698721, 7721.0, 7736.2650548197835, 7753.844923101619, 7806.92193078062, 7896.052473703192, 5562.72186390687, 5948.791792287249, 7093.538919970186, 7162.283771622796, 7163.677634506564, 5501.9174712380145, 6710.966445167938, 6737.629430381376, 6960.303969602999, 7005.754798582229, 5549.472800083986, 6147.770445910746, 6181.876362472815, 6279.748810047547, 6351.301356850835, 4701.177293973609, 4732.692374995614, 4896.290037944407, 4912.508749125059, 5007.549320561167, 4707.19977603815, 4751.786169622306, 4806.399200099988, 4810.230363141881, 5075.6193285502995], "value": 4295.066770106763, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.1246882793017, 354.62941226418394, 363.31152466076776, 368.491481755178, 371.8865745947488, 4257.361395790633, 4570.725756454611, 5122.487751224876, 5181.0, 5197.636165468419, 4155.646770024551, 4998.400191976959, 5108.310378098956, 5143.0, 5223.753785872073, 4085.7957102144924, 4092.3452247640384, 4107.034846810997, 4118.546959834416, 4126.360414135814, 3404.948925766103, 3899.298126337258, 4113.300738874398, 4125.133721918401, 4140.523839758436, 3544.5746510418785, 4017.899552511196, 4035.899102522431, 4036.9394459083137, 4079.6124368184974, 4032.778197199153, 4038.909494436515, 4051.270771261172, 4053.3919912013434, 4055.3575801800316, 3016.6078409806805, 3147.5436061770915, 3449.292894956528, 3584.602005217967, 3602.1354874830113, 4414.823407063714, 4818.180909245437, 4942.555170034678, 4947.317911909932, 5001.549860512571, 4640.582347588699, 4695.178343789823, 4699.530046995307, 4703.764811759398, 4707.975570504682, 5160.922586161173, 5459.617826752129, 5468.894475626912, 5487.807926722546, 5544.445555444423, 3285.895643669014, 3810.314143454177, 3908.9119595519505, 3992.6207010333974, 3992.840286388541, 4552.56750608695, 5576.462709467223, 5608.6634801911605, 5657.3494048184575, 5664.49019588239, 3863.5363756349416, 3983.92032159361, 4035.7174997750462, 4056.452378928866, 4083.9795801020805, 3825.024618722208, 3933.9213215735526, 4100.302948498763, 4141.97929010353, 4152.069287781196, 3971.702122340836, 4190.20386126635, 4483.708558943658, 4618.168729628632, 4629.916537558112, 4473.955260447419, 5388.234588989743, 5392.676439413648, 5455.727213639302, 5479.0, 1152.6168597682815, 1164.5923926625612, 1285.8778416050461, 1288.9484420623257, 1327.5220920468623, 836.2897873847874, 895.0646574329841, 938.5776400619749, 943.919766819828, 950.9096635819586, 4250.853319073848, 4685.8594242172785, 4692.967547139624, 4889.168841296988, 4960.998595849531, 4973.626977976666, 5124.333836601292, 5138.640295179302, 5379.246905433242, 5441.5374693151525, 4585.968157164678, 4761.857144285677, 4780.593649539828, 4791.736454495036, 4818.68678535894, 2278.7037685101163, 2494.862782546941, 2575.8794924207655, 2652.713433984516, 2755.8622068896875, 4073.857414990461, 4629.791659375336, 4696.7651617419, 5073.365829271341, 5298.735063246822, 5339.652922560022, 5412.864678383072, 5424.321959755031, 5450.065226844493, 5480.657238976397, 5193.428722840485, 5307.938412317552, 5319.4414586467865, 5429.457054294539, 5492.890142197134, 4111.814968326492, 5292.5501332387175, 5392.865178370572, 5641.323041235078, 5688.269630577429, 5357.678539287655, 5645.491905728504, 5658.632188907708, 5670.432956704297, 5676.17695434168, 5634.563186387445, 5897.557683173865, 5897.938371093244, 5905.291365036223, 5979.684469416721, 3204.983975080203, 3330.6336303007133, 3766.924661506809, 3795.8671446500343, 3832.865849695247, 4730.668853180245, 5592.7762889483965, 5624.578156638187, 5641.9435805641415, 5731.914021289767, 4854.878628034327, 4993.725345106054, 5036.834161310525, 5359.802480982778, 5514.187764240186, 4543.931841022321, 5299.258103865385, 5485.122380419273, 5517.751701173537, 5539.695316757456, 4407.347244783206, 5063.974680126576, 5209.739513024258, 5262.552683021986, 5334.813281535127, 4539.773011349485, 5082.517160869711, 5398.569379114616, 5401.972990135024, 5480.205370221375, 4837.71800472882, 4882.95117048825, 5342.6260161788305, 5344.839654810362, 5359.758810853443], "value": 3982.4427587287905, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.6705065094078, 698.5319835710077, 702.9683664235109, 751.4138971602152, 838.5597561280327, 13480.730385392286, 14560.199189044599, 15853.445129420472, 16457.177141142925, 16647.1676416179, 14837.85162148381, 15025.774613380781, 15232.619184520392, 15259.618509537268, 15441.922790386032, 799.2447137455092, 867.1718508824058, 868.583080121542, 871.5947084605657, 872.7687162901836, 842.6839935024366, 873.0614589316478, 882.1090698394604, 882.9205371516563, 884.9159329863653, 923.0077666508497, 923.0999775219175, 924.5146298193436, 926.1988380051241, 927.5640448988964, 919.0809190809191, 920.1396694091046, 921.9858156028382, 922.179260458186, 922.3267015078997, 688.6591137387026, 688.6625553478759, 689.7482418917109, 690.3131384272681, 691.7647999680133, 14313.42746290147, 14544.854551454457, 14576.489822856256, 14580.416783328761, 14638.41446342145, 13307.225063938631, 13357.732845343136, 13558.796618050737, 13630.0, 13684.384202710802, 11284.887151128465, 11545.134114941413, 11551.76896462066, 11567.826482602768, 12081.335526546036, 3590.263995880838, 3592.5329707138167, 3669.3028324618235, 3671.0822294426393, 3764.0966168119726, 96072.0, 98547.52178717325, 98979.50510247475, 99037.0, 99260.02219933414, 9245.982941876387, 9780.728505294266, 10404.0, 10435.0, 10708.946455267675, 18551.90724046371, 21208.25771098004, 21553.0, 21846.0, 21916.0, 7236.565806051653, 7241.818954526179, 7259.4918355715645, 7270.200277969419, 7471.402287816962, 4010.5451819341724, 4045.8179381927885, 4048.6558642515715, 4069.3895915612893, 4090.202410529918, 3549.5563054618174, 3620.2216523447587, 3652.7990960496895, 3658.158623516606, 3660.9633903660624, 542.620165883875, 554.5563549160655, 555.7776889244254, 560.9719514024282, 578.2222910185877, 661.9966900165468, 666.1506579111672, 684.2815044203666, 692.9203141638675, 707.9221285658573, 9464.337496375325, 9895.861975872724, 9912.851307230398, 9942.552585133686, 9953.954834742393, 582.909649004405, 659.6932426421737, 668.4084585142184, 684.6405637040593, 692.8510370270316, 4465.196264672325, 4677.46209185948, 4687.484376718558, 4702.388689470347, 4832.299316599144, 94420.52789736008, 95175.0, 96215.03784962201, 96460.51769741246, 99811.0, 72319.27680723126, 72729.6363518179, 75989.0, 81765.59117204495, 84649.57675211584, 68654.97017544841, 69474.65262673654, 70303.0, 70659.0, 72778.0, 9083.227925626132, 10142.442165680959, 10413.77865983194, 10594.947025264824, 10727.731806704895, 44984.550154499346, 45471.54528454673, 46023.539764603265, 46365.53634463612, 47103.52896470991, 49623.00753984972, 60532.69733651303, 66673.33326666865, 68609.0, 68840.31159688339, 12565.560205392767, 12591.496340146292, 12902.096853220184, 12999.870001299865, 13083.0, 14045.789313160516, 14090.929545352208, 14137.151770893779, 14353.569392918229, 14681.48614798477, 11428.314301141958, 13021.218726876039, 13223.296439194219, 13756.312184390941, 13761.655958601115, 11888.524459021888, 12798.61604151877, 12950.935245323713, 13399.196048237138, 13694.931525342708, 12727.2999984998, 13113.934430327787, 13137.34313284351, 13388.330583470983, 13528.323583820573, 10493.0, 10847.858021995362, 10930.6723415181, 10964.342139471657, 11011.064059554707, 9630.807383852423, 10076.97690692804, 10442.582296708351, 10450.320729152581, 10472.424016678851], "value": 7290.857942433114, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1461.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 115.0, 113.0, 114.0, 114.0, 115.0, 112.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 112.0, 110.0, 157.0, 144.0, 142.0, 119.0, 113.0, 133.0, 113.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 183.0, 185.0, 185.0, 182.0, 182.0, 184.0, 185.0, 189.0], "value": 184.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 60.0, 88.0, 62.0, 59.0, 60.0, 60.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 71.0, 86.0, 69.0, 70.0, 70.0, 85.0, 69.0, 69.0, 85.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 88.0, 89.0, 87.0, 88.0, 88.0, 88.0, 88.0], "value": 88.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 96.0, 94.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 85.0, 86.0, 87.0, 90.0, 86.0, 87.0, 85.0, 87.0], "value": 86.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 60.0, 59.0, 61.0, 59.0, 59.0, 54.0, 58.0], "value": 59.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 79.0, 74.0, 71.0, 66.0, 68.0, 68.0, 67.0, 69.0], "value": 69.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 109.0, 108.0, 90.0, 90.0, 89.0, 89.0, 89.0, 89.0], "value": 96.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 142.0, 144.0, 144.0, 143.0, 144.0, 142.0, 143.0, 185.0, 156.0], "value": 149.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 175.0, 176.0, 173.0, 174.0, 175.0, 174.0, 227.0, 184.0, 174.0], "value": 180.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 67.0, 68.0, 65.0, 67.0, 65.0, 67.0, 66.0], "value": 67.1, "unit": "score"}]}]} 14:09:19 INFO - Return code: 0 14:09:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:09:20 ERROR - # TBPL SUCCESS # 14:09:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:09:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:09:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:09:20 INFO - 2017-02-10 14:09:20.019 screenresolution[1651:9725] starting screenresolution argv=screenresolution get 14:09:20 INFO - 2017-02-10 14:09:20.021 screenresolution[1651:9725] Display 0: 1600x1200x32@60 14:09:20 INFO - 2017-02-10 14:09:20.028 screenresolution[1652:9728] starting screenresolution argv=screenresolution list 14:09:20 INFO - Available Modes on Display 0 14:09:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:09:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:09:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:09:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:09:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:09:20 INFO - Intel Iris: 14:09:20 INFO - Chipset Model: Intel Iris 14:09:20 INFO - Type: GPU 14:09:20 INFO - Bus: Built-In 14:09:20 INFO - VRAM (Dynamic, Max): 1536 MB 14:09:20 INFO - Vendor: Intel (0x8086) 14:09:20 INFO - Device ID: 0x0a2e 14:09:20 INFO - Revision ID: 0x0009 14:09:20 INFO - Displays: 14:09:20 INFO - Display: 14:09:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:09:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:09:20 INFO - Display Serial Number: 1600x1200 60 14:09:20 INFO - Main Display: Yes 14:09:20 INFO - Mirror: Off 14:09:20 INFO - Online: Yes 14:09:20 INFO - Rotation: Supported 14:09:20 INFO - Return code: 0 14:09:20 INFO - Running post-action listener: _resource_record_post_action 14:09:20 INFO - [mozharness: 2017-02-10 22:09:20.268523Z] Finished run-tests step (success) 14:09:20 INFO - Running post-run listener: _resource_record_post_run 14:09:20 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 36631552; Write bytes: 553939456; Read time: 390; Write time: 1944 14:09:20 INFO - TinderboxPrint: CPU usage
53.6% 14:09:20 INFO - TinderboxPrint: I/O read bytes / time
36,631,552 / 390 14:09:20 INFO - TinderboxPrint: I/O write bytes / time
553,939,456 / 1,944 14:09:20 INFO - TinderboxPrint: CPU idle
2,231.7 (46.4%) 14:09:20 INFO - TinderboxPrint: CPU system
957.5 (19.9%) 14:09:20 INFO - TinderboxPrint: CPU user
1,620.5 (33.7%) 14:09:20 INFO - TinderboxPrint: Swap in / out
289,402,880 / 0 14:09:20 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 242899456; Write bytes: 235233280; Read time: 17831; Write time: 422 14:09:20 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 34735104; Write bytes: 299364864; Read time: 367; Write time: 1475 14:09:20 INFO - Running post-run listener: _upload_blobber_files 14:09:20 INFO - Blob upload gear active. 14:09:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:09:20 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 14:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:09:21 INFO - (blobuploader) - INFO - Open directory for files ... 14:09:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:09:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:09:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:22 INFO - (blobuploader) - INFO - Done attempting. 14:09:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:09:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:09:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:23 INFO - (blobuploader) - INFO - Done attempting. 14:09:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:09:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:09:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:24 INFO - (blobuploader) - INFO - Done attempting. 14:09:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:09:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:09:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:26 INFO - (blobuploader) - INFO - Done attempting. 14:09:26 INFO - (blobuploader) - INFO - Iteration through files over. 14:09:26 INFO - Return code: 0 14:09:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:09:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:09:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3eda56c0c06848bcb1ccc556403e62d4f9a0b00ecf33f8b69540ede53644ef15cf0d8f2a421b9d5b4831a13d9e6307cdd35f5fa3f215977d84d596922fc6f0c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/404453addfe316f04bf6d5e48fcaec146ea3616686194a4efe6a22eebe15ff518c7d62259c4f901330618607f019b19339b7da90826a7f954aac5d33f108dcc4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d146d0dd154008af37ad8adff6fe3adfd93a8bfc8b5cc1f48b53d1fdb58ecfee64c6a09632a4027beed7d01940ffd604cd691d18bc3b58b14392b4bb1fdd231e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27d115326c8411fd0bb5e929848f0d4ae3cde1211d84be45fae2964e13a55ab67c52270a5dd5b7f30474bd1a662d8b9d03fc927953f6997d47575ca369db3e33"} 14:09:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:09:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:09:26 INFO - Contents: 14:09:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3eda56c0c06848bcb1ccc556403e62d4f9a0b00ecf33f8b69540ede53644ef15cf0d8f2a421b9d5b4831a13d9e6307cdd35f5fa3f215977d84d596922fc6f0c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/404453addfe316f04bf6d5e48fcaec146ea3616686194a4efe6a22eebe15ff518c7d62259c4f901330618607f019b19339b7da90826a7f954aac5d33f108dcc4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d146d0dd154008af37ad8adff6fe3adfd93a8bfc8b5cc1f48b53d1fdb58ecfee64c6a09632a4027beed7d01940ffd604cd691d18bc3b58b14392b4bb1fdd231e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27d115326c8411fd0bb5e929848f0d4ae3cde1211d84be45fae2964e13a55ab67c52270a5dd5b7f30474bd1a662d8b9d03fc927953f6997d47575ca369db3e33"} 14:09:26 INFO - Running post-run listener: copy_logs_to_upload_dir 14:09:26 INFO - Copying logs to upload dir... 14:09:26 INFO - mkdir: /builds/slave/test/build/upload/logs 14:09:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.191472 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-02-10 14:09:26.812631) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 14:09:26.815944) ========= 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.c28hXDojkw/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.vkI0Da9UfR/Listeners TMPDIR=/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3eda56c0c06848bcb1ccc556403e62d4f9a0b00ecf33f8b69540ede53644ef15cf0d8f2a421b9d5b4831a13d9e6307cdd35f5fa3f215977d84d596922fc6f0c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/404453addfe316f04bf6d5e48fcaec146ea3616686194a4efe6a22eebe15ff518c7d62259c4f901330618607f019b19339b7da90826a7f954aac5d33f108dcc4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d146d0dd154008af37ad8adff6fe3adfd93a8bfc8b5cc1f48b53d1fdb58ecfee64c6a09632a4027beed7d01940ffd604cd691d18bc3b58b14392b4bb1fdd231e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27d115326c8411fd0bb5e929848f0d4ae3cde1211d84be45fae2964e13a55ab67c52270a5dd5b7f30474bd1a662d8b9d03fc927953f6997d47575ca369db3e33"} build_url:https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010923 build_url: 'https://queue.taskcluster.net/v1/task/LexJSiSSRwum_2sdKSVxBg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3eda56c0c06848bcb1ccc556403e62d4f9a0b00ecf33f8b69540ede53644ef15cf0d8f2a421b9d5b4831a13d9e6307cdd35f5fa3f215977d84d596922fc6f0c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/404453addfe316f04bf6d5e48fcaec146ea3616686194a4efe6a22eebe15ff518c7d62259c4f901330618607f019b19339b7da90826a7f954aac5d33f108dcc4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d146d0dd154008af37ad8adff6fe3adfd93a8bfc8b5cc1f48b53d1fdb58ecfee64c6a09632a4027beed7d01940ffd604cd691d18bc3b58b14392b4bb1fdd231e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27d115326c8411fd0bb5e929848f0d4ae3cde1211d84be45fae2964e13a55ab67c52270a5dd5b7f30474bd1a662d8b9d03fc927953f6997d47575ca369db3e33"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-10 14:09:26.850752) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:09:26.851153) ========= 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.c28hXDojkw/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.vkI0Da9UfR/Listeners TMPDIR=/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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.005132 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-10 14:09:26.900970) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 14:09:26.901369) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-10 14:09:26.901802) ========= ========= Total master_lag: 3.84 =========