builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0066 starttime: 1478777086.52 results: success (0) buildid: 20161110004022 builduid: 28c9567a20854b7fa13ed9f327e623a9 revision: 9c1ca21cf9c30f6056e9b4cef7280829a2b60ca7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-10 03:24:46.519057) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-10 03:24:46.519572) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-10 03:24:46.519912) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-10 03:24:46.545519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 03:24:46.545902) ========= 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.3G2S4BedBK/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.gUvOIfVO6b/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-10 03:24:46-- 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% 16.2M=0.001s 2016-11-10 03:24:46 (16.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140652 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 03:24:46.710141) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 03:24:46.710500) ========= 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.3G2S4BedBK/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.gUvOIfVO6b/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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.025524 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 03:24:46.758588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-10 03:24:46.758969) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9c1ca21cf9c30f6056e9b4cef7280829a2b60ca7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9c1ca21cf9c30f6056e9b4cef7280829a2b60ca7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3G2S4BedBK/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.gUvOIfVO6b/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-10 03:24:46,844 truncating revision to first 12 chars 2016-11-10 03:24:46,845 Setting DEBUG logging. 2016-11-10 03:24:46,845 attempt 1/10 2016-11-10 03:24:46,845 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9c1ca21cf9c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-10 03:24:48,083 unpacking tar archive at: mozilla-aurora-9c1ca21cf9c3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.505510 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-10 03:24:48.287073) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-10 03:24:48.287443) ========= script_repo_revision: 9c1ca21cf9c30f6056e9b4cef7280829a2b60ca7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-10 03:24:48.287906) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-10 03:24:48.288216) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-10 03:24:48.307423) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-10 03:24:48.308118) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3G2S4BedBK/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.gUvOIfVO6b/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 03:24:48 INFO - MultiFileLogger online at 20161110 03:24:48 in /builds/slave/test 03:24:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:24:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:24:48 INFO - {'append_to_log': False, 03:24:48 INFO - 'base_work_dir': '/builds/slave/test', 03:24:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:24:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:24:48 INFO - 'branch': 'Mozilla-Aurora', 03:24:48 INFO - 'buildbot_json_path': 'buildprops.json', 03:24:48 INFO - 'config_files': ('talos/mac_config.py',), 03:24:48 INFO - 'default_actions': ('clobber', 03:24:48 INFO - 'read-buildbot-config', 03:24:48 INFO - 'download-and-extract', 03:24:48 INFO - 'populate-webroot', 03:24:48 INFO - 'create-virtualenv', 03:24:48 INFO - 'install', 03:24:48 INFO - 'run-tests'), 03:24:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:24:48 INFO - 'download_minidump_stackwalk': True, 03:24:48 INFO - 'download_symbols': 'ondemand', 03:24:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:24:48 INFO - 'tooltool.py': '/tools/tooltool.py', 03:24:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:24:48 INFO - '/tools/misc-python/virtualenv.py')}, 03:24:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:24:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:24:48 INFO - 'installer_path': 'installer.exe', 03:24:48 INFO - 'log_level': 'info', 03:24:48 INFO - 'log_name': 'talos', 03:24:48 INFO - 'log_to_console': True, 03:24:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:24:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:24:48 INFO - 'opt_config_files': (), 03:24:48 INFO - 'pip_index': False, 03:24:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:24:48 INFO - 'cmd': ('bash', 03:24:48 INFO - '-c', 03:24:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:24:48 INFO - 'enabled': True, 03:24:48 INFO - 'halt_on_failure': False, 03:24:48 INFO - 'name': 'check_screen_resolution'},), 03:24:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:24:48 INFO - 'cmd': ('bash', 03:24:48 INFO - '-c', 03:24:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:24:48 INFO - 'enabled': True, 03:24:48 INFO - 'halt_on_failure': False, 03:24:48 INFO - 'name': 'check_screen_resolution'},), 03:24:48 INFO - 'run_cmd_checks_enabled': True, 03:24:48 INFO - 'sps_profile': False, 03:24:48 INFO - 'sps_profile_interval': 0, 03:24:48 INFO - 'suite': 'dromaeojs', 03:24:48 INFO - 'system_bits': '32', 03:24:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:24:48 INFO - 'title': 't-yosemite-r7-0066', 03:24:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:24:48 INFO - 'use_talos_json': True, 03:24:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:24:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:24:48 INFO - 'work_dir': 'build'} 03:24:48 INFO - [mozharness: 2016-11-10 11:24:48.512719Z] Running clobber step. 03:24:48 INFO - Running pre-action listener: _resource_record_pre_action 03:24:48 INFO - Running main action method: clobber 03:24:48 INFO - rmtree: /builds/slave/test/build 03:24:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:24:50 INFO - Running post-action listener: _resource_record_post_action 03:24:50 INFO - [mozharness: 2016-11-10 11:24:50.778018Z] Finished clobber step (success) 03:24:50 INFO - [mozharness: 2016-11-10 11:24:50.778140Z] Running read-buildbot-config step. 03:24:50 INFO - Running pre-action listener: _resource_record_pre_action 03:24:50 INFO - Running main action method: read_buildbot_config 03:24:50 INFO - Using buildbot properties: 03:24:50 INFO - { 03:24:50 INFO - "project": "", 03:24:50 INFO - "product": "firefox", 03:24:50 INFO - "script_repo_revision": "production", 03:24:50 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:24:50 INFO - "repository": "", 03:24:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:24:50 INFO - "buildid": "20161110004022", 03:24:50 INFO - "stage_platform": "macosx64", 03:24:50 INFO - "basedir": "/builds/slave/test", 03:24:50 INFO - "nightly_build": "True", 03:24:50 INFO - "buildnumber": 13, 03:24:50 INFO - "slavename": "t-yosemite-r7-0066", 03:24:50 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:24:50 INFO - "platform": "yosemite_r7", 03:24:50 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:24:50 INFO - "branch": "mozilla-aurora", 03:24:50 INFO - "repo_path": "releases/mozilla-aurora", 03:24:50 INFO - "revision": "9c1ca21cf9c30f6056e9b4cef7280829a2b60ca7", 03:24:50 INFO - "pgo_build": "False", 03:24:50 INFO - "builduid": "28c9567a20854b7fa13ed9f327e623a9", 03:24:50 INFO - "slavebuilddir": "test" 03:24:50 INFO - } 03:24:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:24:50 INFO - Running post-action listener: _resource_record_post_action 03:24:50 INFO - [mozharness: 2016-11-10 11:24:50.781542Z] Finished read-buildbot-config step (success) 03:24:50 INFO - [mozharness: 2016-11-10 11:24:50.781682Z] Running download-and-extract step. 03:24:50 INFO - Running pre-action listener: _resource_record_pre_action 03:24:50 INFO - Running main action method: download_and_extract 03:24:50 INFO - mkdir: /builds/slave/test/build/tests 03:24:50 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')]} 03:24:50 INFO - trying https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:24:50 INFO - Downloading https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:24:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 03:24:52 INFO - Downloaded 1199 bytes. 03:24:52 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:24:52 INFO - Using the following test package requirements: 03:24:52 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:24:52 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:24:52 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:24:52 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:24:52 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:24:52 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:24:52 INFO - u'jsshell-mac.zip'], 03:24:52 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:24:52 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:24:52 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:24:52 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:24:52 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:24:52 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:24:52 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:24:52 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:24:52 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:24:52 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:24:52 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:24:52 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:24:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:24:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:24:52 INFO - Fetch https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:24:52 INFO - Expected file size: 16423472 03:24:59 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:24:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:24:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:24:59 INFO - Fetch https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:25:00 INFO - Expected file size: 16423472 03:25:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:25:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:25:06 INFO - Fetch https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:25:07 INFO - Expected file size: 14414089 03:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:07 INFO - trying https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:25:07 INFO - Downloading https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:25:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 03:25:10 INFO - Downloaded 115620734 bytes. 03:25:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:25:10 INFO - mkdir: /builds/slave/test/properties 03:25:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:25:10 INFO - Writing to file /builds/slave/test/properties/build_url 03:25:10 INFO - Contents: 03:25:10 INFO - build_url:https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:25:11 INFO - Running post-action listener: _resource_record_post_action 03:25:11 INFO - Running post-action listener: set_extra_try_arguments 03:25:11 INFO - [mozharness: 2016-11-10 11:25:11.431644Z] Finished download-and-extract step (success) 03:25:11 INFO - [mozharness: 2016-11-10 11:25:11.431765Z] Running populate-webroot step. 03:25:11 INFO - Running pre-action listener: _resource_record_pre_action 03:25:11 INFO - Running main action method: populate_webroot 03:25:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:25:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:25:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:25:11 INFO - '--tppagecycles', 03:25:11 INFO - '7'], 03:25:11 INFO - 'tests': ['tsvgm']}}, 03:25:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:25:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:25:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:25:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:25:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:11 INFO - 'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:11 INFO - 'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['damp', 'tps']}, 03:25:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:11 INFO - 'tests': ['damp', 'tps']}, 03:25:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['dromaeo_dom']}, 03:25:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:25:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['basic_compositor_video']}, 03:25:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:25:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['a11yr', 03:25:11 INFO - 'ts_paint', 03:25:11 INFO - 'tpaint', 03:25:11 INFO - 'sessionrestore', 03:25:11 INFO - 'sessionrestore_no_auto_restore', 03:25:11 INFO - 'tabpaint']}, 03:25:11 INFO - 'other-e10s': {'tests': ['a11yr', 03:25:11 INFO - 'ts_paint', 03:25:11 INFO - 'tpaint', 03:25:11 INFO - 'sessionrestore', 03:25:11 INFO - 'sessionrestore_no_auto_restore', 03:25:11 INFO - 'tabpaint']}, 03:25:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:25:11 INFO - 'ts_paint', 03:25:11 INFO - 'tpaint', 03:25:11 INFO - 'sessionrestore', 03:25:11 INFO - 'sessionrestore_no_auto_restore', 03:25:11 INFO - 'tabpaint']}, 03:25:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:25:11 INFO - 'ts_paint', 03:25:11 INFO - 'tpaint', 03:25:11 INFO - 'sessionrestore', 03:25:11 INFO - 'sessionrestore_no_auto_restore', 03:25:11 INFO - 'tabpaint']}, 03:25:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['a11yr', 03:25:11 INFO - 'ts_paint', 03:25:11 INFO - 'tpaint', 03:25:11 INFO - 'sessionrestore', 03:25:11 INFO - 'sessionrestore_no_auto_restore', 03:25:11 INFO - 'tabpaint']}, 03:25:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['a11yr', 03:25:11 INFO - 'ts_paint', 03:25:11 INFO - 'tpaint', 03:25:11 INFO - 'sessionrestore', 03:25:11 INFO - 'sessionrestore_no_auto_restore', 03:25:11 INFO - 'tabpaint']}, 03:25:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['tsvgx', 03:25:11 INFO - 'tsvgr_opacity', 03:25:11 INFO - 'tart', 03:25:11 INFO - 'tscrollx', 03:25:11 INFO - 'cart']}, 03:25:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:25:11 INFO - 'tsvgr_opacity', 03:25:11 INFO - 'tart', 03:25:11 INFO - 'tscrollx', 03:25:11 INFO - 'cart']}, 03:25:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:11 INFO - 'talos_options': ['--disable-e10s'], 03:25:11 INFO - 'tests': ['tp5o']}, 03:25:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:11 INFO - 'tests': ['tp5o']}, 03:25:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:11 INFO - 'talos_options': ['--disable-e10s', 03:25:11 INFO - '--xperf_path', 03:25:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:11 INFO - 'tests': ['tp5n']}, 03:25:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:11 INFO - 'talos_options': ['--xperf_path', 03:25:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:11 INFO - 'tests': ['tp5n']}}, 03:25:11 INFO - 'talos.zip': {'path': '', 03:25:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:25:11 INFO - Running post-action listener: _resource_record_post_action 03:25:11 INFO - [mozharness: 2016-11-10 11:25:11.450559Z] Finished populate-webroot step (success) 03:25:11 INFO - [mozharness: 2016-11-10 11:25:11.450666Z] Running create-virtualenv step. 03:25:11 INFO - Running pre-action listener: _resource_record_pre_action 03:25:11 INFO - Running main action method: create_virtualenv 03:25:11 INFO - Creating virtualenv /builds/slave/test/build/venv 03:25:11 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 03:25:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:25:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:25:11 INFO - Using real prefix '/tools/python27' 03:25:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:25:12 INFO - Installing distribute.............................................................................................................................................................................................done. 03:25:15 INFO - Installing pip.................done. 03:25:15 INFO - Return code: 0 03:25:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:25:15 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')]} 03:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:15 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')]} 03:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:15 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 0x10d2cc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d242570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f15ceeb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e0d30>, '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 0x10cf46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0d8b20>, '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.3G2S4BedBK/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.gUvOIfVO6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 03:25:15 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 03:25:15 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 03:25:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3G2S4BedBK/Render', 03:25:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:15 INFO - 'HOME': '/Users/cltbld', 03:25:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:15 INFO - 'LOGNAME': 'cltbld', 03:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:15 INFO - 'MOZ_NO_REMOTE': '1', 03:25:15 INFO - 'NO_EM_RESTART': '1', 03:25:15 INFO - 'PAGER': '/bin/cat', 03:25:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:15 INFO - 'PWD': '/builds/slave/test', 03:25:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:15 INFO - 'SHELL': '/bin/bash', 03:25:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gUvOIfVO6b/Listeners', 03:25:15 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 03:25:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:15 INFO - 'USER': 'cltbld', 03:25:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:15 INFO - 'XPC_FLAGS': '0x0', 03:25:15 INFO - 'XPC_SERVICE_NAME': '0', 03:25:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:15 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 03:25:15 INFO - Cleaning up... 03:25:15 INFO - Return code: 0 03:25:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:25:15 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')]} 03:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:15 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')]} 03:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:15 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 0x10d2cc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d242570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f15ceeb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e0d30>, '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 0x10cf46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0d8b20>, '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.3G2S4BedBK/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.gUvOIfVO6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 03:25:15 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 03:25:15 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 03:25:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3G2S4BedBK/Render', 03:25:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:15 INFO - 'HOME': '/Users/cltbld', 03:25:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:15 INFO - 'LOGNAME': 'cltbld', 03:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:15 INFO - 'MOZ_NO_REMOTE': '1', 03:25:15 INFO - 'NO_EM_RESTART': '1', 03:25:15 INFO - 'PAGER': '/bin/cat', 03:25:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:15 INFO - 'PWD': '/builds/slave/test', 03:25:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:15 INFO - 'SHELL': '/bin/bash', 03:25:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gUvOIfVO6b/Listeners', 03:25:15 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 03:25:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:15 INFO - 'USER': 'cltbld', 03:25:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:15 INFO - 'XPC_FLAGS': '0x0', 03:25:15 INFO - 'XPC_SERVICE_NAME': '0', 03:25:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:15 INFO - Downloading/unpacking psutil>=3.1.1 03:25:15 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 03:25:15 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 03:25:15 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 03:25:15 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 03:25:15 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 03:25:15 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 03:25:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:25:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:18 INFO - Installing collected packages: psutil 03:25:18 INFO - Running setup.py install for psutil 03:25:18 INFO - building 'psutil._psutil_osx' extension 03:25:18 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 03:25:19 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 03:25:19 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 03:25:19 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 03:25:19 INFO - building 'psutil._psutil_posix' extension 03:25:19 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 03:25:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:25:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:25:19 INFO - ^ 03:25:19 INFO - 1 warning generated. 03:25:19 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 03:25:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:19 INFO - Successfully installed psutil 03:25:19 INFO - Cleaning up... 03:25:19 INFO - Return code: 0 03:25:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:25:19 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')]} 03:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:19 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')]} 03:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:19 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 0x10d2cc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d242570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f15ceeb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e0d30>, '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 0x10cf46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0d8b20>, '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.3G2S4BedBK/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.gUvOIfVO6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 03:25:19 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 03:25:19 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 03:25:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3G2S4BedBK/Render', 03:25:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:19 INFO - 'HOME': '/Users/cltbld', 03:25:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:19 INFO - 'LOGNAME': 'cltbld', 03:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:19 INFO - 'MOZ_NO_REMOTE': '1', 03:25:19 INFO - 'NO_EM_RESTART': '1', 03:25:19 INFO - 'PAGER': '/bin/cat', 03:25:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:19 INFO - 'PWD': '/builds/slave/test', 03:25:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:19 INFO - 'SHELL': '/bin/bash', 03:25:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gUvOIfVO6b/Listeners', 03:25:19 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 03:25:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:19 INFO - 'USER': 'cltbld', 03:25:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:19 INFO - 'XPC_FLAGS': '0x0', 03:25:19 INFO - 'XPC_SERVICE_NAME': '0', 03:25:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:25:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:25:22 INFO - Installing collected packages: mozsystemmonitor 03:25:22 INFO - Running setup.py install for mozsystemmonitor 03:25:23 INFO - Successfully installed mozsystemmonitor 03:25:23 INFO - Cleaning up... 03:25:23 INFO - Return code: 0 03:25:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:23 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 0x10d2cc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d242570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f15ceeb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e0d30>, '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 0x10cf46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0d8b20>, '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.3G2S4BedBK/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.gUvOIfVO6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 03:25:23 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 03:25:23 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 03:25:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3G2S4BedBK/Render', 03:25:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:23 INFO - 'HOME': '/Users/cltbld', 03:25:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:23 INFO - 'LOGNAME': 'cltbld', 03:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:23 INFO - 'MOZ_NO_REMOTE': '1', 03:25:23 INFO - 'NO_EM_RESTART': '1', 03:25:23 INFO - 'PAGER': '/bin/cat', 03:25:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:23 INFO - 'PWD': '/builds/slave/test', 03:25:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:23 INFO - 'SHELL': '/bin/bash', 03:25:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gUvOIfVO6b/Listeners', 03:25:23 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 03:25:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:23 INFO - 'USER': 'cltbld', 03:25:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:23 INFO - 'XPC_FLAGS': '0x0', 03:25:23 INFO - 'XPC_SERVICE_NAME': '0', 03:25:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:23 INFO - Downloading/unpacking jsonschema==2.5.1 03:25:23 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 03:25:23 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 03:25:23 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 03:25:23 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 03:25:23 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 03:25:23 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 03:25:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:25:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:25:25 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 03:25:25 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 03:25:25 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 03:25:25 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 03:25:25 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 03:25:25 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 03:25:26 INFO - Downloading functools32-3.2.3-2.tar.gz 03:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:25:26 INFO - warning: no files found matching '*.txt' 03:25:26 INFO - no previously-included directories found matching 'build' 03:25:26 INFO - no previously-included directories found matching 'dist' 03:25:26 INFO - no previously-included directories found matching '.git*' 03:25:26 INFO - Installing collected packages: jsonschema, functools32 03:25:26 INFO - Running setup.py install for functools32 03:25:26 INFO - warning: no files found matching '*.txt' 03:25:26 INFO - no previously-included directories found matching 'build' 03:25:26 INFO - no previously-included directories found matching 'dist' 03:25:26 INFO - no previously-included directories found matching '.git*' 03:25:26 INFO - Successfully installed jsonschema functools32 03:25:26 INFO - Cleaning up... 03:25:26 INFO - Return code: 0 03:25:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:25:26 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')]} 03:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:26 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')]} 03:25:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:26 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 0x10d2cc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d242570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f15ceeb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e0d30>, '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 0x10cf46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0d8b20>, '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.3G2S4BedBK/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.gUvOIfVO6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 03:25:26 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 03:25:26 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 03:25:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3G2S4BedBK/Render', 03:25:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:26 INFO - 'HOME': '/Users/cltbld', 03:25:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:26 INFO - 'LOGNAME': 'cltbld', 03:25:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:26 INFO - 'MOZ_NO_REMOTE': '1', 03:25:26 INFO - 'NO_EM_RESTART': '1', 03:25:26 INFO - 'PAGER': '/bin/cat', 03:25:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:26 INFO - 'PWD': '/builds/slave/test', 03:25:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:26 INFO - 'SHELL': '/bin/bash', 03:25:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gUvOIfVO6b/Listeners', 03:25:26 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 03:25:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:26 INFO - 'USER': 'cltbld', 03:25:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:26 INFO - 'XPC_FLAGS': '0x0', 03:25:26 INFO - 'XPC_SERVICE_NAME': '0', 03:25:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:25:26 INFO - Cleaning up... 03:25:26 INFO - Return code: 0 03:25:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:25:26 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')]} 03:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:26 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')]} 03:25:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:26 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 0x10d2cc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d242570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f15ceeb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e0d30>, '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 0x10cf46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0d8b20>, '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.3G2S4BedBK/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.gUvOIfVO6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 03:25:26 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 03:25:26 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 03:25:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3G2S4BedBK/Render', 03:25:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:26 INFO - 'HOME': '/Users/cltbld', 03:25:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:26 INFO - 'LOGNAME': 'cltbld', 03:25:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:26 INFO - 'MOZ_NO_REMOTE': '1', 03:25:26 INFO - 'NO_EM_RESTART': '1', 03:25:26 INFO - 'PAGER': '/bin/cat', 03:25:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:26 INFO - 'PWD': '/builds/slave/test', 03:25:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:26 INFO - 'SHELL': '/bin/bash', 03:25:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gUvOIfVO6b/Listeners', 03:25:26 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 03:25:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:26 INFO - 'USER': 'cltbld', 03:25:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:26 INFO - 'XPC_FLAGS': '0x0', 03:25:26 INFO - 'XPC_SERVICE_NAME': '0', 03:25:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:27 INFO - Downloading/unpacking blobuploader==1.2.4 03:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:29 INFO - Downloading blobuploader-1.2.4.tar.gz 03:25:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:25:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:25:29 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 03:25:29 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 03:25:29 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 03:25:29 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 03:25:29 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 03:25:29 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 03:25:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:25:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:30 INFO - Downloading docopt-0.6.1.tar.gz 03:25:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:25:30 INFO - Installing collected packages: blobuploader, requests, docopt 03:25:30 INFO - Running setup.py install for blobuploader 03:25:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:25:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:25:31 INFO - Running setup.py install for requests 03:25:31 INFO - Running setup.py install for docopt 03:25:31 INFO - Successfully installed blobuploader requests docopt 03:25:31 INFO - Cleaning up... 03:25:31 INFO - Return code: 0 03:25:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:31 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 0x10d2cc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d242570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f15ceeb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e0d30>, '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 0x10cf46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0d8b20>, '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.3G2S4BedBK/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.gUvOIfVO6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 03:25:31 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 03:25:31 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 03:25:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3G2S4BedBK/Render', 03:25:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:31 INFO - 'HOME': '/Users/cltbld', 03:25:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:31 INFO - 'LOGNAME': 'cltbld', 03:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:31 INFO - 'MOZ_NO_REMOTE': '1', 03:25:31 INFO - 'NO_EM_RESTART': '1', 03:25:31 INFO - 'PAGER': '/bin/cat', 03:25:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:31 INFO - 'PWD': '/builds/slave/test', 03:25:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:31 INFO - 'SHELL': '/bin/bash', 03:25:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gUvOIfVO6b/Listeners', 03:25:31 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 03:25:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:31 INFO - 'USER': 'cltbld', 03:25:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:31 INFO - 'XPC_FLAGS': '0x0', 03:25:31 INFO - 'XPC_SERVICE_NAME': '0', 03:25:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:32 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-SsMM88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:32 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-EUG3Hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:32 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-Qq3qg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:32 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-WBXZV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:32 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-q0V8vS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:32 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-jtQuGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:32 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-tWnCUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:32 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-VhCSIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:32 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-t1BPM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:32 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-8CC8LX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:25:33 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-3EOk9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:25:33 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-qotOjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:25:33 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-Rygx8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:25:33 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-MBNTLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:33 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-nz4N4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:25:33 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-4r3nlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:25:33 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-kFut92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:25:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:25:33 INFO - Running setup.py install for manifestparser 03:25:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:25:33 INFO - Running setup.py install for mozcrash 03:25:34 INFO - Running setup.py install for mozdebug 03:25:34 INFO - Running setup.py install for mozdevice 03:25:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:25:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:25:34 INFO - Running setup.py install for mozfile 03:25:34 INFO - Running setup.py install for mozhttpd 03:25:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:25:34 INFO - Running setup.py install for mozinfo 03:25:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:25:34 INFO - Running setup.py install for mozInstall 03:25:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:25:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:25:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:25:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:25:34 INFO - Running setup.py install for mozleak 03:25:35 INFO - Running setup.py install for mozlog 03:25:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:25:35 INFO - Running setup.py install for moznetwork 03:25:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:25:35 INFO - Running setup.py install for mozprocess 03:25:35 INFO - Running setup.py install for mozprofile 03:25:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:25:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:25:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:25:35 INFO - Running setup.py install for mozrunner 03:25:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:25:35 INFO - Running setup.py install for mozscreenshot 03:25:36 INFO - Running setup.py install for moztest 03:25:36 INFO - Running setup.py install for mozversion 03:25:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:25:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:25:36 INFO - Cleaning up... 03:25:36 INFO - Return code: 0 03:25:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:36 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')]} 03:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:36 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')]} 03:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:36 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 0x10d2cc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d242570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f15ceeb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e0d30>, '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 0x10cf46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0d8b20>, '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.3G2S4BedBK/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.gUvOIfVO6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 03:25:36 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 03:25:36 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 03:25:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3G2S4BedBK/Render', 03:25:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:36 INFO - 'HOME': '/Users/cltbld', 03:25:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:36 INFO - 'LOGNAME': 'cltbld', 03:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:36 INFO - 'MOZ_NO_REMOTE': '1', 03:25:36 INFO - 'NO_EM_RESTART': '1', 03:25:36 INFO - 'PAGER': '/bin/cat', 03:25:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:36 INFO - 'PWD': '/builds/slave/test', 03:25:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:36 INFO - 'SHELL': '/bin/bash', 03:25:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gUvOIfVO6b/Listeners', 03:25:36 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 03:25:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:36 INFO - 'USER': 'cltbld', 03:25:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:36 INFO - 'XPC_FLAGS': '0x0', 03:25:36 INFO - 'XPC_SERVICE_NAME': '0', 03:25:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:36 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-bAPhvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:36 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)) 03:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:36 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-nLVhJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:36 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-cgCjEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:37 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)) 03:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:37 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-AkISQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:37 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-eSYPO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:37 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)) 03:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:37 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-qwAFOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:37 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)) 03:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:37 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-En7MjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:37 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)) 03:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:37 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-qI0S0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:37 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)) 03:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:37 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-5QClmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:37 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)) 03:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:37 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-X7dyBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:25:37 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)) 03:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:25:37 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-JlCUWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:25:37 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)) 03:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:25:37 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-XXX8wF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:25:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:25:37 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-YGxLc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:25:38 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)) 03:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:25:38 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-HcPUus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:38 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-CP0BuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:38 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)) 03:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:25:38 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-XZONlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:25:38 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-RkWmaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:25:38 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)) 03:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:25:38 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)) 03:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:25:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:41 INFO - Downloading blessings-1.6.tar.gz 03:25:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:25:41 INFO - Installing collected packages: blessings 03:25:41 INFO - Running setup.py install for blessings 03:25:41 INFO - Successfully installed blessings 03:25:41 INFO - Cleaning up... 03:25:41 INFO - Return code: 0 03:25:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:25:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:25:41 INFO - Reading from file tmpfile_stdout 03:25:41 INFO - Current package versions: 03:25:41 INFO - blessings == 1.6 03:25:41 INFO - blobuploader == 1.2.4 03:25:41 INFO - docopt == 0.6.1 03:25:41 INFO - functools32 == 3.2.3-2 03:25:41 INFO - jsonschema == 2.5.1 03:25:41 INFO - manifestparser == 1.1 03:25:41 INFO - mozInstall == 1.12 03:25:41 INFO - mozcrash == 0.17 03:25:41 INFO - mozdebug == 0.1 03:25:41 INFO - mozdevice == 0.48 03:25:41 INFO - mozfile == 1.2 03:25:41 INFO - mozhttpd == 0.7 03:25:41 INFO - mozinfo == 0.9 03:25:41 INFO - mozleak == 0.1 03:25:41 INFO - mozlog == 3.4 03:25:41 INFO - moznetwork == 0.27 03:25:41 INFO - mozprocess == 0.23 03:25:41 INFO - mozprofile == 0.28 03:25:41 INFO - mozrunner == 6.12 03:25:41 INFO - mozscreenshot == 0.1 03:25:41 INFO - mozsystemmonitor == 0.3 03:25:41 INFO - moztest == 0.7 03:25:41 INFO - mozversion == 1.4 03:25:41 INFO - psutil == 3.1.1 03:25:41 INFO - requests == 1.2.3 03:25:41 INFO - wsgiref == 0.1.2 03:25:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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')]} 03:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:41 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 0x10d2cc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d242570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f15ceeb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e0d30>, '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 0x10cf46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0d8b20>, '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.3G2S4BedBK/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.gUvOIfVO6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 03:25:41 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 03:25:41 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 03:25:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3G2S4BedBK/Render', 03:25:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:41 INFO - 'HOME': '/Users/cltbld', 03:25:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:41 INFO - 'LOGNAME': 'cltbld', 03:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:41 INFO - 'MOZ_NO_REMOTE': '1', 03:25:41 INFO - 'NO_EM_RESTART': '1', 03:25:41 INFO - 'PAGER': '/bin/cat', 03:25:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:41 INFO - 'PWD': '/builds/slave/test', 03:25:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:41 INFO - 'SHELL': '/bin/bash', 03:25:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gUvOIfVO6b/Listeners', 03:25:41 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 03:25:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:41 INFO - 'USER': 'cltbld', 03:25:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:41 INFO - 'XPC_FLAGS': '0x0', 03:25:41 INFO - 'XPC_SERVICE_NAME': '0', 03:25:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:41 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)) 03:25:41 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)) 03:25:41 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)) 03:25:41 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)) 03:25:41 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)) 03:25:41 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)) 03:25:41 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)) 03:25:41 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)) 03:25:41 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)) 03:25:41 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)) 03:25:41 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)) 03:25:41 INFO - Cleaning up... 03:25:41 INFO - Return code: 0 03:25:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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')]} 03:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d2cc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d242570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97f15ceeb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0e0d30>, '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 0x10cf46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0d8b20>, '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.3G2S4BedBK/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.gUvOIfVO6b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 03:25:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:25:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3G2S4BedBK/Render', 03:25:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:41 INFO - 'HOME': '/Users/cltbld', 03:25:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:41 INFO - 'LOGNAME': 'cltbld', 03:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:41 INFO - 'MOZ_NO_REMOTE': '1', 03:25:41 INFO - 'NO_EM_RESTART': '1', 03:25:41 INFO - 'PAGER': '/bin/cat', 03:25:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:41 INFO - 'PWD': '/builds/slave/test', 03:25:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:41 INFO - 'SHELL': '/bin/bash', 03:25:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gUvOIfVO6b/Listeners', 03:25:41 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 03:25:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:41 INFO - 'USER': 'cltbld', 03:25:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:41 INFO - 'XPC_FLAGS': '0x0', 03:25:41 INFO - 'XPC_SERVICE_NAME': '0', 03:25:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:25:42 INFO - Cleaning up... 03:25:42 INFO - Return code: 0 03:25:42 INFO - Running post-action listener: _resource_record_post_action 03:25:42 INFO - Running post-action listener: _start_resource_monitoring 03:25:42 INFO - Starting resource monitoring. 03:25:42 INFO - [mozharness: 2016-11-10 11:25:42.273743Z] Finished create-virtualenv step (success) 03:25:42 INFO - [mozharness: 2016-11-10 11:25:42.274684Z] Running install step. 03:25:42 INFO - Running pre-action listener: _resource_record_pre_action 03:25:42 INFO - Running main action method: install 03:25:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:25:42 INFO - Reading from file tmpfile_stdout 03:25:42 INFO - Detecting whether we're running mozinstall >=1.0... 03:25:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:25:42 INFO - Reading from file tmpfile_stdout 03:25:42 INFO - Output received: 03:25:42 INFO - Usage: mozinstall [options] installer 03:25:42 INFO - Options: 03:25:42 INFO - -h, --help show this help message and exit 03:25:42 INFO - -d DEST, --destination=DEST 03:25:42 INFO - Directory to install application into. [default: 03:25:42 INFO - "/builds/slave/test"] 03:25:42 INFO - --app=APP Application being installed. [default: firefox] 03:25:42 INFO - mkdir: /builds/slave/test/build/application 03:25:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:26:15 INFO - Reading from file tmpfile_stdout 03:26:15 INFO - Output received: 03:26:15 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:26:15 INFO - Running post-action listener: _resource_record_post_action 03:26:15 INFO - [mozharness: 2016-11-10 11:26:15.604476Z] Finished install step (success) 03:26:15 INFO - [mozharness: 2016-11-10 11:26:15.604610Z] Running run-tests step. 03:26:15 INFO - Running pre-action listener: _resource_record_pre_action 03:26:15 INFO - Running main action method: run_tests 03:26:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:26:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:26:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:26:15 INFO - 2016-11-10 03:26:15.618 screenresolution[1641:7567] starting screenresolution argv=screenresolution get 03:26:15 INFO - 2016-11-10 03:26:15.621 screenresolution[1641:7567] Display 0: 1600x1200x32@60 03:26:15 INFO - 2016-11-10 03:26:15.627 screenresolution[1642:7570] starting screenresolution argv=screenresolution list 03:26:15 INFO - Available Modes on Display 0 03:26:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:26:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:26:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:26:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:26:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:26:15 INFO - Intel Iris: 03:26:15 INFO - Chipset Model: Intel Iris 03:26:15 INFO - Type: GPU 03:26:15 INFO - Bus: Built-In 03:26:15 INFO - VRAM (Dynamic, Max): 1536 MB 03:26:15 INFO - Vendor: Intel (0x8086) 03:26:15 INFO - Device ID: 0x0a2e 03:26:15 INFO - Revision ID: 0x0009 03:26:15 INFO - Displays: 03:26:15 INFO - Display: 03:26:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:26:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:26:15 INFO - Display Serial Number: 1600x1200 60 03:26:15 INFO - Main Display: Yes 03:26:15 INFO - Mirror: Off 03:26:15 INFO - Online: Yes 03:26:15 INFO - Rotation: Supported 03:26:15 INFO - Return code: 0 03:26:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:26:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:26:15 INFO - Python 2.7.3 03:26:15 INFO - Return code: 0 03:26:15 INFO - grabbing minidump binary from tooltool 03:26:15 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')]} 03:26:15 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 0x10d0e0d30>, '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 0x10cf46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0d8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:26:15 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 03:26:15 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 03:26:15 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 03:26:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:26:15 INFO - Return code: 0 03:26:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:26:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:26:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:26:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:26:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:26:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--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 03:26:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0066 --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 03:26:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3G2S4BedBK/Render', 03:26:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:15 INFO - 'HOME': '/Users/cltbld', 03:26:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:15 INFO - 'LOGNAME': 'cltbld', 03:26:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:15 INFO - 'MOZ_NO_REMOTE': '1', 03:26:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:15 INFO - 'NO_EM_RESTART': '1', 03:26:15 INFO - 'PAGER': '/bin/cat', 03:26:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:15 INFO - 'PWD': '/builds/slave/test', 03:26:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:15 INFO - 'SHELL': '/bin/bash', 03:26:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gUvOIfVO6b/Listeners', 03:26:15 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 03:26:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:15 INFO - 'USER': 'cltbld', 03:26:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:15 INFO - 'XPC_FLAGS': '0x0', 03:26:15 INFO - 'XPC_SERVICE_NAME': '0', 03:26:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--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 03:26:16 INFO - mozversion application_buildid: 20161110004022 03:26:16 INFO - mozversion application_changeset: 9c1ca21cf9c30f6056e9b4cef7280829a2b60ca7 03:26:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:26:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:26:16 INFO - mozversion application_name: Firefox 03:26:16 INFO - mozversion application_remotingname: firefox-dev 03:26:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:26:16 INFO - mozversion application_vendor: Mozilla 03:26:16 INFO - mozversion application_version: 51.0a2 03:26:16 INFO - mozversion platform_buildid: 20161110004022 03:26:16 INFO - mozversion platform_changeset: 9c1ca21cf9c30f6056e9b4cef7280829a2b60ca7 03:26:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:26:16 INFO - mozversion platform_version: 51.0a2 03:26:16 INFO - using testdate: 1478777176 03:26:16 INFO - actual date: 1478777176 03:26:16 INFO - starting webserver on 'localhost:49273' 03:26:16 INFO - SUITE-START | Running 2 tests 03:26:16 INFO - TEST-START | dromaeo_css 03:26:16 INFO - operating with platform_type : mac_ 03:26:16 INFO - Initialising browser for dromaeo_css test... 03:26:16 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/tmp0Ltinz/profile http://localhost:49273/getInfo.html) 03:26:18 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 03:26:18 INFO - PROCESS | 1652 | colorDepth:24 03:26:18 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 03:26:18 INFO - PROCESS | 1652 | __metrics 03:26:19 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:26:19 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:26:19 INFO - TEST-INFO | 1652: exit 0 03:26:19 INFO - Browser initialized. 03:26:19 INFO - Running cycle 1/1 for dromaeo_css test... 03:26:19 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/tmp0Ltinz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:31 INFO - PROCESS | 1655 | RSS: Main: 220491776 03:26:31 INFO - PROCESS | 1655 | 03:27:23 INFO - PROCESS | 1655 | 1478777243035 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:29:35 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 03:29:36 INFO - PROCESS | 1655 | RSS: Main: 370548736 03:29:36 INFO - PROCESS | 1655 | 03:32:39 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 03:32:40 INFO - PROCESS | 1655 | RSS: Main: 351576064 03:32:40 INFO - PROCESS | 1655 | 03:35:42 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 03:35:43 INFO - PROCESS | 1655 | RSS: Main: 315953152 03:35:43 INFO - PROCESS | 1655 | 03:38:45 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 03:38:46 INFO - PROCESS | 1655 | RSS: Main: 342212608 03:38:46 INFO - PROCESS | 1655 | 03:41:49 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 03:41:50 INFO - PROCESS | 1655 | RSS: Main: 318959616 03:41:50 INFO - PROCESS | 1655 | 03:44:53 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 03:44:53 INFO - PROCESS | 1655 | RSS: Main: 401899520 03:44:53 INFO - PROCESS | 1655 | 03:44:53 INFO - PROCESS | 1655 | __start_tp_report 03:44:53 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 03:44:53 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 03:44:53 INFO - PROCESS | 1655 | |i|pagename|runs| 03:44:53 INFO - PROCESS | 1655 | |0;dojo.html;3161.099086760273;3259.820709860957;3280.3111346617225;3325.1853295942483;3327.48423994281;4710.152172608929;5632.070708333125;5634.04221282382;5719.771209151629;5720.513756330712;5635.070213414781;5712.628679135853;5725.427457254273;5731.283589551306;5765.423457654232;5167.966406718652;5192.221166824987;5209.374875014984;5209.426963034063;5241.135212689902;4273.230818452677;5151.6908985460805;5165.9225111623355;5191.402988656315;5312.335958005249;5178.818741344054;5181.455947125554;5186.118359878829;5242.292290540785;5244.947550524503;5213.9478605214035;5237.528622424;5282.366116066097;5282.867928301785;5335.893282134336;5088.2622019807295;5130.204818253177;5225.059489291926;5225.817096401608;5234.81678141267;5574.358948720908;5599.4120617335;5628.971855140739;5649.887002259973;5663.603547751659;6139.2325959255095;6194.442500175006;6194.5354098442795;6240.719167637467;6245.3442388549;5517.806876759334;6267.498600112026;6312.3372045934975;6321.747130114836;6335.619862808247;5616.129499927477;5654.858628534237;5682.40334764852;5685.232493613392;5737.483626473554;6247.718852651551;6298.685065746694;6323.810285691437;6327.746890124436;6332.240131184288;5116.334876466036;6109.083637454418;6129.049997250433;6147.170132032118;6148.846278843064;6088.4215999479975;6089.056196289582;6124.686092398479;6268.749250029948;6281.937180628135;5290.391604965478;6128.3258841527395;6154.692265386713;6200;6208.9689551551955;6198.473129783929;6229.719662615103;6234.657093859791;6237.09562113491;6251.999680051261;4811.831585894477;4822.373091498153;4877.341558889575;4887.706737595685;4890.510948905081;4373.518912919576;4373.75944323059;4430.401895744098;4430.756308403004;4456.9331460028125;5769.711514424262;5788.7684492620665;5794.768209271582;5801.680907550125;5813.04084825999;6313;6316.147320111818;6318.7472501100365;6325.746970121236;6338.207724034496;5575.776968921279;5715.228444159985;5724.77100915967;5789.131630255495;5797.304323481125;5336.279602253724;5389.083855744533;5397.568194544427;5404.945950540523;5467.835964921059;5367.597430192829;6347.841303967253;6352.618842869442;6380.7128679209545;6386.010168423994;6302.65335406557;6311.756803821196;6320.399562041599;6344.048392741126;6368.235811702625;6317.810465686037;6333.018382150774;6363.681815909279;6373.3945275198785;6379.362063793584;5499.5426212053035;6185.969070154621;6218.968905155445;6223.097650840512;6233.252009758677;5385.353757549119;6143.047827586731;6288.748450061947;6297.055441683784;6313.589616674902;5899.852503687443;5945.078512830518;5953.672548009901;5983.581149319506;6091.573589848668;6034.63792172471;6081.6351018939;6084.543659225487;6115.113308570143;6131.141640170469;5881.882362352814;5884.293884733859;5891.764329426775;5897.292324921037;5910.468057874812;5839.124131380327;5872.265966754156;6019;6035.879282414415;6107.450329470369;5776.277965254343;5807.593468457168;5827.446392592697;5872.941270587239;5959.0763431668165 03:44:53 INFO - PROCESS | 1655 | |1;ext.html;473.5241082711874;518.9377274727034;523.552362729866;531.5720844719999;532.419662567801;30057.84971075144;41193.7641870744;41803.79098104509;41827.74516764494;43985.56014439854;42786.93032674184;43296.783516082454;43703;43728.56271437285;43929.34105988413;9705.708828735149;9878.456684882329;9897.95051024744;9917.851232231522;9931.503424828767;9661.130498255156;9709.17472014876;9723.46520941348;9734.805303893918;9749.171320437772;8856.822863542726;9171.174594286513;9695.563699633498;9767.120959113678;9809.313348065638;9644.951775241148;9681.757956051084;9728.027197280215;9732.026797320283;9741.756456088584;9742;9798.853017204749;9804.852927206097;9822.65620703272;9836.31145819793;41069.794651026554;41470;41497.37753933663;41593.58406415927;41601.791991040154;3316.1046517440154;3318.303156337172;3374.578177727784;3383.1711230748624;3407.795532268072;29759.25601859949;30739.231519211975;31676.524852127237;32436.513452298233;32539.51190732141;2824.8587570621594;3036.316828713544;3206.246532064963;3208.0856955767495;3208.9197770055703;548889;549140;551957;552421;552660;33669.15827104342;34259.65740342614;63394.68302658457;63988.68005660035;64065.67967160227;35273.823630881685;35810.283794323965;35931.64068359335;35942.28115437729;35963.640363596554;15006;15176.165310908005;15189.16459594733;15211.326754057045;15215.011024283385;12922.741545169043;13000.674983125498;13012.958963282914;13021.218726876417;13039.282839443731;7797.844043119106;7816.7264145754625;7819.257170568787;7894.368450523944;7895.842083158304;2855.400365923138;3215.13191438315;3233.143217047484;3256.8371581421306;3258.804471731704;895.789489469974;910.7131253655077;982.0817535604233;992.4144754594823;1000.9749756256152;29648.703512965025;30460.238494037825;30473;30810.69189308078;31313.373732525222;915.3135148638521;1070.6787963610886;1077.7144056824948;1099.5931505343074;1112.57165991094;15113.47102851417;15469.917105802711;15743;15829.366825327088;15851.286692098884;590451.0477447585;591910;593156;593193;593772;57084;57710;57774.133387999216;57816.42183578195;57969;1251.561953316332;1267.7781388257204;1355.0920883008212;1376.3737499437732;1392.7144935288445;29822.850885745433;30420.485901472686;31229.219269518442;31492;31860.36279274448;48703.51296487131;48991.02017959692;49249.01501970012;49279.01441971212;49339;534944;535736;538128;543119;544085;27008.59487107734;27623.86188069127;27637.065405422232;28377.574336384558;28452.85773571119;46828.7658561705;47095.764521177174;47564.2865357013;47576.286355705386;47905;39413.605863941;39706.60293397029;39797;40105.598944010184;41629.375559366024;35053.824730876186;37932.81033594815;39259.214815704094;39911;41194;38936.41595376128;39244.41133382944;39427;39491.2101757969;39627.80186099051;33007.50488742623;35062;35608.82195589005;35820.64179358173;36410.72562460301;25776.09783657563;26176.952921882912;26296.948122075668;26398.47393809889;26438.603420948315 03:44:53 INFO - PROCESS | 1655 | |2;jquery.html;337.29168745634166;351.4412084785191;375.4818350676066;376.6873494999151;399.31517447577414;14938.477153299636;15170.696586068287;16063.518094457171;20518.589628207428;21003.789962100374;16956.660866782688;19988.700169497468;20116.698249526267;20993.47516312093;21204;5712.11462223356;5879.706014699269;5936.851578710545;5977.1034344848185;5984.640921544721;4124.422580838685;4211.241976444238;5788.5658575606785;5839.328477225131;5848.385919478457;4230.407742915994;4297.871063868089;6252.562320637558;6563.770268040619;6567.343265673442;5453.590980676465;6272.529560282997;6363.172787537614;6540.247871494791;6598.208215014205;5673;5673.886522269531;5678.4605462480995;5686.488216060575;5690.971545142289;25009.749902500924;25878.6118208227;26251.73748262512;26265.949362025494;26543.203703888914;1980.9504762381055;2192.4628466025765;2196.428928478591;2254.3349711834885;2294.655801629769;14327.35526901292;15489.302981365865;15647.687046259125;15988.198831803547;16386.098764567945;1745.7119575270065;1823.927042918295;1843.6725557598509;1867.617138486607;1913.8660293779442;116251.2562311566;118751.4062429691;120716.79283207143;120893;122626.77373226243;9245.861312080324;9259.537023148816;10496.370217786805;10905.709800941733;11527.13546484017;14037.438502459992;14051;14059.71880562383;14069.85930140706;14111.082779619497;8529.914700853036;8820.558972051373;8822.735317940473;8922.330825188137;8955.552222388855;8916.420432671855;8937.508437036025;8943;9105.81788364229;9132.99537050924;6523.249826269945;6631.834204144839;6645.501587380966;6645.634490103091;6647.235567909753;1680.2525373611552;1808.5117018404958;1839.6320735852883;1840.3006857394373;1843.216632930999;802.297989259398;845.7674139611534;862.1809281182901;886.4371124335964;950.2398081534744;21273.574528509344;22731;22843.885780570992;22908;22992.65511017336;982.268210183418;997.8154041502345;1000.9949950250202;1017.0998666180484;1047.162270183865;9426.717198484057;10837.349759014485;11050.171237157245;11353.375564343874;11728.589499367652;456555;518790;593859;620149;621696;122822;124296.37851810864;125908.1113783294;126331.10503342457;127570.36214818867;946.6970569417721;995.0348162282575;1014.974625634365;1020.357174979758;1020.3877673396051;18872;19403;20113.865236205507;20371.59256814885;20453.59092818165;54523;59845.70077149587;60543.69728151331;61079.69460152671;63004;80669.59665201636;83316;84767;85815.570922145;87266.56366718125;6231.376862313732;7173.569585824867;7467.402607791255;7643.273888980761;8000.159983201913;11016.17378696585;12939.288339141061;13116.081874269092;13173;13530.985176111633;5481.671099734029;10823.103682674388;10901.073408760345;11092.611758588411;11297.26567773092;11297.26567773092;11310.038646715122;11484.36835973996;11544.59593914209;11907.761844762883;10045.899541004497;11188.384638844942;11233.213675042669;11355.489002995051;11800.76398472043;7233.529820561646;7363.852722945619;7411.518251313647;7640.73257435987;7726.961365193138;8655.485290074337;9472.384295021076;11322.32066076038;11577.305361677989;11691.590794322157 03:44:53 INFO - PROCESS | 1655 | |3;mootools.html;1504.6088017115553;1519.490970524874;1694.127524324973;1851.953701157471;1858.0523932794272;8568.10034946331;9138.314626403013;9152.633894644207;9168.404053736502;9171.128742769442;7960.482568633035;8202.91797082029;8205.343572514199;8655.783605409868;8905.15401036902;2380.809535237181;2425.2724182745196;2428.174420696963;2428.405040765015;2431.756824317572;2376.227725989052;2401.387646150229;2418.9879050604723;2419.745926677691;2425.34515680767;2098.3495116513855;2173.0655817998254;2332.3352844439337;2400.687910571632;2405.7353691093967;2389.0921449848947;2397.6883005209297;2422.079609748302;2425.0299880047946;2425.1027119965547;2407.7110746710505;2408.6266628672583;2413.6500207469994;2414.5653782319177;2418.9758102418928;9033.412828166149;9120.498372589505;9124.224440922464;9132.269418446509;9139.177474027369;5297.682139071668;5417.6207665463435;5487.670739755627;5494.340679118492;5502.752376143083;3472.322897035079;3580.7135429165605;3706.703463722896;3709.3848836570155;3713.053171441265;1049.082053203447;1079.0558261521169;1083.4474418046852;1101.0971003776906;1102.8731695855;12030.578929737418;12125.029997600172;12150.210236334698;12150.5747298845;12160.878391216063;4698.976505117521;4776.902629212729;4796.880077998078;4918.409790825124;4919;10287.897121028844;10289;10292.794144117226;10293.845592316122;10300.124489418333;5440.537554307849;5462.317210348707;5471.8084867029465;5476.014317422822;5478.01395748769;4259.9574004260185;4772.427308722976;4915.361003069578;4948.282499037619;4991.80032798684;3526.3652542542077;3630.2739452109686;3805.1818858945458;3847.8653247136776;3879.631435013669;1032.1175395037285;1150.045462266317;1161.4483120517855;1164.0047759165961;1164.7728692904802;719.8560287942432;868.8696695495727;904.2088172848757;911.2662013958126;979.0063085967748;5673.120666296731;5832.4252451837765;5864.67744274069;6181.227346581677;6239.0953311770445;855.422589751915;858.3733874271817;891.6923661336829;934.3693007220099;951.6241084771476;3814.5231846019246;3982.8008599570485;4002.1795531915886;4088.4259560069586;4120.526139493936;10525.157987360994;10625.5218515167;10679.83980240297;10807.297525660806;10828;10373.84439233412;10794.78410431787;10819.350838949687;10837.403942783065;10855.131589472823;8183.713570025139;8410.579471026424;8437.40938134337;8439;8455;5971.731272092853;5999.310079340931;6038.154658347747;6047.425494578008;6257.874842503215;9996.350237234556;10058.19534437258;10183.694489165337;10380.896191038295;10402.219833512669;9049.728508144766;9198.804155459748;10109.64616238428;10380.948095259475;10513.526891290063;7354.264573542603;7484.32641062307;7486.588237646982;7502.099748030271;7507.399408047234;8005.039395272604;8085.312748416215;8100.594970251582;8114.472559283628;8121.106678265504;7243.637818108968;7318.817029574303;7359.227281135618;7433.442491813027;7467.290607392289;7162.7493037743425;7170.856582868418;7210.098737657793;7340.302671246223;7371.778846634609;6799.89800153008;6812.693428795617;6881.931180688129;6894.655267236518;6897.7240910365035;4962.478939711278;4977.726225057657;4990.600751939909;5002.349694539686;5014.197728363444;4913.557779799835;4939.308496810521;4946.629002824874;5165.509276618865;5174.7153906535505 03:44:53 INFO - PROCESS | 1655 | |4;prototype.html;291.4186198533925;296.53888203843024;305.5371112764163;310.94589342130166;312.3721320146508;4380.671449641273;4641.700323909311;5260.263563101164;5346.786128554858;5370.516653501184;4154.67898243489;4554.2713165893465;4777.259524773657;5239.423663397023;5242.8165014224505;3550.5739311282555;4041.4746083009168;4072.266991941442;4133.511935703144;4151.501819781631;3885.9028524286978;4030.415589739486;4164.500259968808;4171.8539851105215;4174.206900688874;3963.5838236985132;4054.97972510137;4090.5704900985415;4090.9386359204636;4115.625187346377;4068.938965915484;4080.3063479208604;4084.244414783275;4099.672026237894;4102.220578090169;2993.3863557970562;3581.871710411212;3595.7123430125525;3597.165445622751;3597.964020359789;4098.8360465581345;4811.302361157647;5204.245384419276;5213.653855764883;5235.345581802275;3919.510061242345;4108.732932359417;4713.575778179946;4736.478987311393;4774.236122220428;5647.463490968393;5660.801871934504;5662.319492329977;5700.429957004308;5711.001724094884;3250.447423937936;3654.963450365489;3870.8645197417954;3956.140613911457;3970.563238043813;4730.645201609893;5544.445555444423;5649.971750141223;5704.77180912763;5762.838935399225;3249.94376827532;3440.522823567028;3793.506844110303;3993.241284156059;4039.949613100615;3361.798292102482;4066.6949978751713;4073.2260870434525;4079.2453396121814;4085.1616772452517;3933.449317095609;4608.364030769028;4686.601638860667;4695.9337891327705;4715.434147902205;4850.684705494132;4880.829170978998;4974.37820272466;5624.578156638268;5670.829875103754;1158.6096683979258;1212.1878341511208;1273.8789814967563;1306.3337697774205;1361.4962463888426;737.8524295140993;739.5451797144717;796.4783067091065;803.5299349880269;845.5434065604628;3813.389857622767;4387.003913219478;4429.889252768707;4436.600705936481;4452.910941781146;4272.829086836492;4708.270218116198;4810.979388656772;4832.299316599074;4844.709317440965;3816.5610954740005;4395.7142785718825;4395.802188901507;4446.444194475691;4448.488423831301;2215.9335219943428;2353.482233908537;2517.3958250019864;2523.5962246040544;2562.7309132540813;4120.104751814199;4484.730916144977;4657.254839225708;4732.390987064415;5039.4708555601865;4680.602148817388;4921.557059864629;4935.555799978019;4943.4809345018975;4961.7271050092595;4990.6257030722845;5426.945730542723;6021.9051045289625;6038.547108966757;6123.040626999317;5171.707073231692;5517;5703.321357724161;5824.912626310524;5828.329742079715;4705.823544113971;5059.620528460454;5401.756920938488;5817.76728930838;5836.665333866487;4268.658507319469;5028.9245661315845;5970.671613061323;6002.909956350571;6046.818595442144;3139.1681204480374;3209.630892447305;3446.8965931022108;3955.1891862168764;3964.088259700343;5857.765689372377;5880.735366908414;5895.616784908967;5906.350301466921;5956.629975105837;5012.674176178537;5046.823361182341;5108.719020453911;5331.466853314792;5643.943560564342;4771.974025584516;4912.901741965212;4955.40535135786;5691.174779657009;5698.230738850202;5519.227308176778;5529.4470552945995;5552.472515111058;5567.24211157459;5571;4948.876278092933;5362.3268061378085;5438.021156191923;5505.862353441196;5697.57268204878;4687.08601822655;5522.6134170607675;5542.168674698827;5572.8823047241785;5579.386267510652 03:44:53 INFO - PROCESS | 1655 | |5;yui.html;592.6501421862316;707.1655446573045;743.1713639292191;768.2663056780775;801.9839603207938;14012.929935350321;14594.48919287825;15278.618034549141;15408.383664653415;15471.381144754196;13616.659583510393;13998.51005214815;14006;14024.439022439115;14029.719405611882;670.2426258328082;825.8224481736411;842.2798507276283;843.0768308701962;844.341413697314;689.1661090081008;692.7298353642084;693.3794254142565;694.1565997313263;828.8549503836834;882.1222883231194;891.6210610490548;903.1690844423147;904.3443503460005;905.9909400906006;898.2993265253048;899.5996781432265;901.0944001278673;901.1709227510673;901.1709227510673;514.3776031002492;530.1755769777993;631.0912286307748;658.0195508692015;659.5383231737754;14628.561143165722;15078.472253471185;15100.5469835904;15115.622109447242;15136.621584460367;13382.263975481344;13402.932985335108;13570.864291357058;13583.932080339633;13944.790828137586;10731.35611863283;11012.39431831249;11290.548378064868;11294.09647228228;11608.883911160865;4294;4360.694751367406;4363.847265345697;4372.1692878353015;4418.911621767546;115899;118930;120042.19936700957;120766;123059;10003.399796012263;10389.9480502597;10443.530041148166;10565.943405659373;10600.151987840954;19589.412317630493;19641.214351425784;19680.015999199983;19739.013049347475;19749.506262343555;6733.562318449285;6830.248672646005;7305.123385193704;7425.220351863085;7449.925500745032;4000.079981604247;4059.4519739835337;4080.9387859182134;4205.137946720914;4290.442242508517;2834.2772592988654;3179.8410079495934;3288.901332960015;3292.4073666739737;3293.522439246296;644.320242144542;650.9934900651027;658.723336198788;659.8782070480203;667.8196886840623;547.3814589513823;554.6588847858619;556.1768582497925;584.8215845072183;594.9672767997802;8601.569921504026;8642.78393040179;8870.15733505316;8873.112688731075;9052.81894362109;554.9028919938994;585.2830282903409;586.5659412035149;587.7648940423779;615.2893408113636;3833.674137698271;4176.4570605821045;4200.394005137054;4264.189803937304;4313.892152696208;131181;134011;156514;180074.19925800836;181712;140498.78503644906;141189;144784;145673;150439;121510;126037;131410.99999999808;132530;134476;8398.916010839814;8404.789880252798;8439.198276163756;8484;8772.78068048304;54107.45892541182;56537;62329.37670623236;65028;68196.6590167046;95118.52440738029;95773;100743;106013;108313.45843270734;12996.335751171177;13226.669333266746;13235.735285294433;13733.587992360246;13963.379325492766;12419.875801241871;14106.365213565208;14733;15124.016938898936;15624.375024998873;12993.350332483527;13404.262765547988;13418.731625367633;13862.86137138656;14178.858211417753;11102.888971110186;13325.400356984153;14033.859661403256;14246.786298205743;14926.925365373103;13336.599902002956;13813.309334533435;13956.79064814049;14541.709165816836;14596.12423254608;11180.552777888794;11248.775024499628;11642.24325418879;11986.700332491757;12008.339541325311;9913.801723965624;11604.76790464169;11660.591879284184;11809.350485723024;11910.34493102853 03:44:53 INFO - PROCESS | 1655 | __end_tp_report 03:44:53 INFO - PROCESS | 1655 | __start_cc_report 03:44:53 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1438 03:44:53 INFO - PROCESS | 1655 | __end_cc_report 03:44:53 INFO - PROCESS | 1655 | __startTimestamp1478778293546__endTimestamp 03:44:53 INFO - PROCESS | 1655 | 03:44:53 INFO - PROCESS | 1655 | ------- Summary: start ------- 03:44:53 INFO - PROCESS | 1655 | Number of tests: 6 03:44:53 INFO - PROCESS | 1655 | 03:44:53 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5694.84 Median:5813.04 stddev:664.46 (11.4%) stddev-sans-first:636.08 03:44:53 INFO - PROCESS | 1655 | Values: 3161.1 3259.8 3280.3 3325.2 3327.5 4710.2 5632.1 5634.0 5719.8 5720.5 5635.1 5712.6 5725.4 5731.3 5765.4 5168.0 5192.2 5209.4 5209.4 5241.1 4273.2 5151.7 5165.9 5191.4 5312.3 5178.8 5181.5 5186.1 5242.3 5244.9 5213.9 5237.5 5282.4 5282.9 5335.9 5088.3 5130.2 5225.1 5225.8 5234.8 5574.4 5599.4 5629.0 5649.9 5663.6 6139.2 6194.4 6194.5 6240.7 6245.3 5517.8 6267.5 6312.3 6321.7 6335.6 5616.1 5654.9 5682.4 5685.2 5737.5 6247.7 6298.7 6323.8 6327.7 6332.2 5116.3 6109.1 6129.0 6147.2 6148.8 6088.4 6089.1 6124.7 6268.7 6281.9 5290.4 6128.3 6154.7 6200.0 6209.0 6198.5 6229.7 6234.7 6237.1 6252.0 4811.8 4822.4 4877.3 4887.7 4890.5 4373.5 4373.8 4430.4 4430.8 4456.9 5769.7 5788.8 5794.8 5801.7 5813.0 6313.0 6316.1 6318.7 6325.7 6338.2 5575.8 5715.2 5724.8 5789.1 5797.3 5336.3 5389.1 5397.6 5404.9 5467.8 5367.6 6347.8 6352.6 6380.7 6386.0 6302.7 6311.8 6320.4 6344.0 6368.2 6317.8 6333.0 6363.7 6373.4 6379.4 5499.5 6186.0 6219.0 6223.1 6233.3 5385.4 6143.0 6288.7 6297.1 6313.6 5899.9 5945.1 5953.7 5983.6 6091.6 6034.6 6081.6 6084.5 6115.1 6131.1 5881.9 5884.3 5891.8 5897.3 5910.5 5839.1 5872.3 6019.0 6035.9 6107.5 5776.3 5807.6 5827.4 5872.9 5959.1 03:44:53 INFO - PROCESS | 1655 | 03:44:53 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:68421.96 Median:40587.70 stddev:150021.07 (369.6%) stddev-sans-first:150355.17 03:44:53 INFO - PROCESS | 1655 | Values: 473.5 518.9 523.6 531.6 532.4 30057.8 41193.8 41803.8 41827.7 43985.6 42786.9 43296.8 43703.0 43728.6 43929.3 9705.7 9878.5 9898.0 9917.9 9931.5 9661.1 9709.2 9723.5 9734.8 9749.2 8856.8 9171.2 9695.6 9767.1 9809.3 9645.0 9681.8 9728.0 9732.0 9741.8 9742.0 9798.9 9804.9 9822.7 9836.3 41069.8 41470.0 41497.4 41593.6 41601.8 3316.1 3318.3 3374.6 3383.2 3407.8 29759.3 30739.2 31676.5 32436.5 32539.5 2824.9 3036.3 3206.2 3208.1 3208.9 548889.0 549140.0 551957.0 552421.0 552660.0 33669.2 34259.7 63394.7 63988.7 64065.7 35273.8 35810.3 35931.6 35942.3 35963.6 15006.0 15176.2 15189.2 15211.3 15215.0 12922.7 13000.7 13013.0 13021.2 13039.3 7797.8 7816.7 7819.3 7894.4 7895.8 2855.4 3215.1 3233.1 3256.8 3258.8 895.8 910.7 982.1 992.4 1001.0 29648.7 30460.2 30473.0 30810.7 31313.4 915.3 1070.7 1077.7 1099.6 1112.6 15113.5 15469.9 15743.0 15829.4 15851.3 590451.0 591910.0 593156.0 593193.0 593772.0 57084.0 57710.0 57774.1 57816.4 57969.0 1251.6 1267.8 1355.1 1376.4 1392.7 29822.9 30420.5 31229.2 31492.0 31860.4 48703.5 48991.0 49249.0 49279.0 49339.0 534944.0 535736.0 538128.0 543119.0 544085.0 27008.6 27623.9 27637.1 28377.6 28452.9 46828.8 47095.8 47564.3 47576.3 47905.0 39413.6 39706.6 39797.0 40105.6 41629.4 35053.8 37932.8 39259.2 39911.0 41194.0 38936.4 39244.4 39427.0 39491.2 39627.8 33007.5 35062.0 35608.8 35820.6 36410.7 25776.1 26177.0 26296.9 26398.5 26438.6 03:44:53 INFO - PROCESS | 1655 | 03:44:53 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:34469.13 Median:25444.18 stddev:94894.94 (373.0%) stddev-sans-first:95126.54 03:44:53 INFO - PROCESS | 1655 | Values: 337.3 351.4 375.5 376.7 399.3 14938.5 15170.7 16063.5 20518.6 21003.8 16956.7 19988.7 20116.7 20993.5 21204.0 5712.1 5879.7 5936.9 5977.1 5984.6 4124.4 4211.2 5788.6 5839.3 5848.4 4230.4 4297.9 6252.6 6563.8 6567.3 5453.6 6272.5 6363.2 6540.2 6598.2 5673.0 5673.9 5678.5 5686.5 5691.0 25009.7 25878.6 26251.7 26265.9 26543.2 1981.0 2192.5 2196.4 2254.3 2294.7 14327.4 15489.3 15647.7 15988.2 16386.1 1745.7 1823.9 1843.7 1867.6 1913.9 116251.3 118751.4 120716.8 120893.0 122626.8 9245.9 9259.5 10496.4 10905.7 11527.1 14037.4 14051.0 14059.7 14069.9 14111.1 8529.9 8820.6 8822.7 8922.3 8955.6 8916.4 8937.5 8943.0 9105.8 9133.0 6523.2 6631.8 6645.5 6645.6 6647.2 1680.3 1808.5 1839.6 1840.3 1843.2 802.3 845.8 862.2 886.4 950.2 21273.6 22731.0 22843.9 22908.0 22992.7 982.3 997.8 1001.0 1017.1 1047.2 9426.7 10837.3 11050.2 11353.4 11728.6 456555.0 518790.0 593859.0 620149.0 621696.0 122822.0 124296.4 125908.1 126331.1 127570.4 946.7 995.0 1015.0 1020.4 1020.4 18872.0 19403.0 20113.9 20371.6 20453.6 54523.0 59845.7 60543.7 61079.7 63004.0 80669.6 83316.0 84767.0 85815.6 87266.6 6231.4 7173.6 7467.4 7643.3 8000.2 11016.2 12939.3 13116.1 13173.0 13531.0 5481.7 10823.1 10901.1 11092.6 11297.3 11297.3 11310.0 11484.4 11544.6 11907.8 10045.9 11188.4 11233.2 11355.5 11800.8 7233.5 7363.9 7411.5 7640.7 7727.0 8655.5 9472.4 11322.3 11577.3 11691.6 03:44:53 INFO - PROCESS | 1655 | 03:44:53 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5760.50 Median:4929.15 stddev:3244.48 (65.8%) stddev-sans-first:3237.82 03:44:53 INFO - PROCESS | 1655 | Values: 1504.6 1519.5 1694.1 1852.0 1858.1 8568.1 9138.3 9152.6 9168.4 9171.1 7960.5 8202.9 8205.3 8655.8 8905.2 2380.8 2425.3 2428.2 2428.4 2431.8 2376.2 2401.4 2419.0 2419.7 2425.3 2098.3 2173.1 2332.3 2400.7 2405.7 2389.1 2397.7 2422.1 2425.0 2425.1 2407.7 2408.6 2413.7 2414.6 2419.0 9033.4 9120.5 9124.2 9132.3 9139.2 5297.7 5417.6 5487.7 5494.3 5502.8 3472.3 3580.7 3706.7 3709.4 3713.1 1049.1 1079.1 1083.4 1101.1 1102.9 12030.6 12125.0 12150.2 12150.6 12160.9 4699.0 4776.9 4796.9 4918.4 4919.0 10287.9 10289.0 10292.8 10293.8 10300.1 5440.5 5462.3 5471.8 5476.0 5478.0 4260.0 4772.4 4915.4 4948.3 4991.8 3526.4 3630.3 3805.2 3847.9 3879.6 1032.1 1150.0 1161.4 1164.0 1164.8 719.9 868.9 904.2 911.3 979.0 5673.1 5832.4 5864.7 6181.2 6239.1 855.4 858.4 891.7 934.4 951.6 3814.5 3982.8 4002.2 4088.4 4120.5 10525.2 10625.5 10679.8 10807.3 10828.0 10373.8 10794.8 10819.4 10837.4 10855.1 8183.7 8410.6 8437.4 8439.0 8455.0 5971.7 5999.3 6038.2 6047.4 6257.9 9996.4 10058.2 10183.7 10380.9 10402.2 9049.7 9198.8 10109.6 10380.9 10513.5 7354.3 7484.3 7486.6 7502.1 7507.4 8005.0 8085.3 8100.6 8114.5 8121.1 7243.6 7318.8 7359.2 7433.4 7467.3 7162.7 7170.9 7210.1 7340.3 7371.8 6799.9 6812.7 6881.9 6894.7 6897.7 4962.5 4977.7 4990.6 5002.3 5014.2 4913.6 4939.3 4946.6 5165.5 5174.7 03:44:53 INFO - PROCESS | 1655 | 03:44:53 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4362.45 Median:4714.50 stddev:1364.17 (28.9%) stddev-sans-first:1333.33 03:44:53 INFO - PROCESS | 1655 | Values: 291.4 296.5 305.5 310.9 312.4 4380.7 4641.7 5260.3 5346.8 5370.5 4154.7 4554.3 4777.3 5239.4 5242.8 3550.6 4041.5 4072.3 4133.5 4151.5 3885.9 4030.4 4164.5 4171.9 4174.2 3963.6 4055.0 4090.6 4090.9 4115.6 4068.9 4080.3 4084.2 4099.7 4102.2 2993.4 3581.9 3595.7 3597.2 3598.0 4098.8 4811.3 5204.2 5213.7 5235.3 3919.5 4108.7 4713.6 4736.5 4774.2 5647.5 5660.8 5662.3 5700.4 5711.0 3250.4 3655.0 3870.9 3956.1 3970.6 4730.6 5544.4 5650.0 5704.8 5762.8 3249.9 3440.5 3793.5 3993.2 4039.9 3361.8 4066.7 4073.2 4079.2 4085.2 3933.4 4608.4 4686.6 4695.9 4715.4 4850.7 4880.8 4974.4 5624.6 5670.8 1158.6 1212.2 1273.9 1306.3 1361.5 737.9 739.5 796.5 803.5 845.5 3813.4 4387.0 4429.9 4436.6 4452.9 4272.8 4708.3 4811.0 4832.3 4844.7 3816.6 4395.7 4395.8 4446.4 4448.5 2215.9 2353.5 2517.4 2523.6 2562.7 4120.1 4484.7 4657.3 4732.4 5039.5 4680.6 4921.6 4935.6 4943.5 4961.7 4990.6 5426.9 6021.9 6038.5 6123.0 5171.7 5517.0 5703.3 5824.9 5828.3 4705.8 5059.6 5401.8 5817.8 5836.7 4268.7 5028.9 5970.7 6002.9 6046.8 3139.2 3209.6 3446.9 3955.2 3964.1 5857.8 5880.7 5895.6 5906.4 5956.6 5012.7 5046.8 5108.7 5331.5 5643.9 4772.0 4912.9 4955.4 5691.2 5698.2 5519.2 5529.4 5552.5 5567.2 5571.0 4948.9 5362.3 5438.0 5505.9 5697.6 4687.1 5522.6 5542.2 5572.9 5579.4 03:44:53 INFO - PROCESS | 1655 | 03:44:53 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:26389.80 Median:19744.26 stddev:43866.72 (222.2%) stddev-sans-first:43947.02 03:44:53 INFO - PROCESS | 1655 | Values: 592.7 707.2 743.2 768.3 802.0 14012.9 14594.5 15278.6 15408.4 15471.4 13616.7 13998.5 14006.0 14024.4 14029.7 670.2 825.8 842.3 843.1 844.3 689.2 692.7 693.4 694.2 828.9 882.1 891.6 903.2 904.3 906.0 898.3 899.6 901.1 901.2 901.2 514.4 530.2 631.1 658.0 659.5 14628.6 15078.5 15100.5 15115.6 15136.6 13382.3 13402.9 13570.9 13583.9 13944.8 10731.4 11012.4 11290.5 11294.1 11608.9 4294.0 4360.7 4363.8 4372.2 4418.9 115899.0 118930.0 120042.2 120766.0 123059.0 10003.4 10389.9 10443.5 10565.9 10600.2 19589.4 19641.2 19680.0 19739.0 19749.5 6733.6 6830.2 7305.1 7425.2 7449.9 4000.1 4059.5 4080.9 4205.1 4290.4 2834.3 3179.8 3288.9 3292.4 3293.5 644.3 651.0 658.7 659.9 667.8 547.4 554.7 556.2 584.8 595.0 8601.6 8642.8 8870.2 8873.1 9052.8 554.9 585.3 586.6 587.8 615.3 3833.7 4176.5 4200.4 4264.2 4313.9 131181.0 134011.0 156514.0 180074.2 181712.0 140498.8 141189.0 144784.0 145673.0 150439.0 121510.0 126037.0 131411.0 132530.0 134476.0 8398.9 8404.8 8439.2 8484.0 8772.8 54107.5 56537.0 62329.4 65028.0 68196.7 95118.5 95773.0 100743.0 106013.0 108313.5 12996.3 13226.7 13235.7 13733.6 13963.4 12419.9 14106.4 14733.0 15124.0 15624.4 12993.4 13404.3 13418.7 13862.9 14178.9 11102.9 13325.4 14033.9 14246.8 14926.9 13336.6 13813.3 13956.8 14541.7 14596.1 11180.6 11248.8 11642.2 11986.7 12008.3 9913.8 11604.8 11660.6 11809.4 11910.3 03:44:53 INFO - PROCESS | 1655 | -------- Summary: end -------- 03:44:53 INFO - PROCESS | 1655 | 03:44:54 INFO - TEST-INFO | 1655: exit 0 03:44:54 INFO - TEST-OK | dromaeo_css | took 1117957ms 03:44:54 INFO - TEST-START | kraken 03:44:54 INFO - operating with platform_type : mac_ 03:44:54 INFO - Initialising browser for kraken test... 03:44:54 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/tmpa7DAOJ/profile http://localhost:49273/getInfo.html) 03:44:56 INFO - PROCESS | 1690 | __metrics Screen width/height:1600/1200 03:44:56 INFO - PROCESS | 1690 | colorDepth:24 03:44:56 INFO - PROCESS | 1690 | Browser inner width/height: 1024/689 03:44:56 INFO - PROCESS | 1690 | __metrics 03:44:56 INFO - PROCESS | 1690 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:44:56 INFO - PROCESS | 1690 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:44:57 INFO - TEST-INFO | 1690: exit 0 03:44:57 INFO - Browser initialized. 03:44:57 INFO - Running cycle 1/1 for kraken test... 03:44:57 INFO - TEST-INFO | started process 1692 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/tmpa7DAOJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:09 INFO - PROCESS | 1692 | RSS: Main: 220155904 03:45:09 INFO - PROCESS | 1692 | 03:45:12 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 03:45:12 INFO - PROCESS | 1692 | RSS: Main: 270221312 03:45:12 INFO - PROCESS | 1692 | 03:45:15 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 03:45:16 INFO - PROCESS | 1692 | RSS: Main: 280866816 03:45:16 INFO - PROCESS | 1692 | 03:45:19 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 03:45:19 INFO - PROCESS | 1692 | RSS: Main: 379314176 03:45:19 INFO - PROCESS | 1692 | 03:45:21 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 03:45:22 INFO - PROCESS | 1692 | RSS: Main: 279851008 03:45:22 INFO - PROCESS | 1692 | 03:45:24 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:45:25 INFO - PROCESS | 1692 | RSS: Main: 280760320 03:45:25 INFO - PROCESS | 1692 | 03:45:27 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 03:45:28 INFO - PROCESS | 1692 | RSS: Main: 318164992 03:45:28 INFO - PROCESS | 1692 | 03:45:31 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 03:45:32 INFO - PROCESS | 1692 | RSS: Main: 317784064 03:45:32 INFO - PROCESS | 1692 | 03:45:34 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 03:45:35 INFO - PROCESS | 1692 | RSS: Main: 315224064 03:45:35 INFO - PROCESS | 1692 | 03:45:36 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:45:37 INFO - PROCESS | 1692 | RSS: Main: 291577856 03:45:37 INFO - PROCESS | 1692 | 03:45:39 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:45:40 INFO - PROCESS | 1692 | RSS: Main: 297005056 03:45:40 INFO - PROCESS | 1692 | 03:45:42 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:45:42 INFO - PROCESS | 1692 | RSS: Main: 303947776 03:45:42 INFO - PROCESS | 1692 | 03:45:45 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:45:46 INFO - PROCESS | 1692 | RSS: Main: 318083072 03:45:46 INFO - PROCESS | 1692 | 03:45:49 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:45:50 INFO - PROCESS | 1692 | RSS: Main: 310652928 03:45:50 INFO - PROCESS | 1692 | 03:45:51 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 03:45:52 INFO - PROCESS | 1692 | RSS: Main: 354590720 03:45:52 INFO - PROCESS | 1692 | 03:45:52 INFO - PROCESS | 1692 | __start_tp_report 03:45:52 INFO - PROCESS | 1692 | _x_x_mozilla_page_load 03:45:52 INFO - PROCESS | 1692 | _x_x_mozilla_page_load_details 03:45:52 INFO - PROCESS | 1692 | |i|pagename|runs| 03:45:52 INFO - PROCESS | 1692 | |0;ai-astar;114;116;115;114;113;115;115;114;114;115 03:45:52 INFO - PROCESS | 1692 | |1;audio-beat-detection;141;110;106;139;107;110;109;107;140;107 03:45:52 INFO - PROCESS | 1692 | |2;audio-dft;183;182;183;185;183;179;182;182;184;184 03:45:52 INFO - PROCESS | 1692 | |3;audio-fft;81;59;60;90;67;58;60;63;112;80 03:45:52 INFO - PROCESS | 1692 | |4;audio-oscillator;84;68;94;69;69;70;93;68;69;90 03:45:52 INFO - PROCESS | 1692 | |5;imaging-gaussian-blur;92;87;135;124;91;85;95;89;91;87 03:45:52 INFO - PROCESS | 1692 | |6;imaging-darkroom;98;96;96;95;94;96;95;96;95;96 03:45:52 INFO - PROCESS | 1692 | |7;imaging-desaturate;85;85;87;87;84;83;93;134;86;84 03:45:52 INFO - PROCESS | 1692 | |8;json-parse-financial;58;55;54;57;58;59;59;58;57;58 03:45:52 INFO - PROCESS | 1692 | |9;json-stringify-tinderbox;66;75;68;78;72;68;69;70;70;71 03:45:52 INFO - PROCESS | 1692 | |10;stanford-crypto-aes;84;85;83;85;85;95;100;102;81;88 03:45:52 INFO - PROCESS | 1692 | |11;stanford-crypto-ccm;141;137;137;137;137;138;136;139;170;135 03:45:52 INFO - PROCESS | 1692 | |12;stanford-crypto-pbkdf2;203;145;200;226;162;163;163;161;162;162 03:45:52 INFO - PROCESS | 1692 | |13;stanford-crypto-sha256-iterative;67;66;67;65;69;79;83;83;83;66 03:45:52 INFO - PROCESS | 1692 | __end_tp_report 03:45:52 INFO - PROCESS | 1692 | __start_cc_report 03:45:52 INFO - PROCESS | 1692 | _x_x_mozilla_cycle_collect,1968 03:45:52 INFO - PROCESS | 1692 | __end_cc_report 03:45:52 INFO - PROCESS | 1692 | __startTimestamp1478778352108__endTimestamp 03:45:52 INFO - PROCESS | 1692 | 03:45:52 INFO - PROCESS | 1692 | ------- Summary: start ------- 03:45:52 INFO - PROCESS | 1692 | Number of tests: 14 03:45:52 INFO - PROCESS | 1692 | 03:45:52 INFO - PROCESS | 1692 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 03:45:52 INFO - PROCESS | 1692 | Values: 114.0 116.0 115.0 114.0 113.0 115.0 115.0 114.0 114.0 115.0 03:45:52 INFO - PROCESS | 1692 | 03:45:52 INFO - PROCESS | 1692 | [#1] audio-beat-detection Cycles:10 Average:117.60 Median:110.00 stddev:15.52 (14.1%) stddev-sans-first:13.96 03:45:52 INFO - PROCESS | 1692 | Values: 141.0 110.0 106.0 139.0 107.0 110.0 109.0 107.0 140.0 107.0 03:45:52 INFO - PROCESS | 1692 | 03:45:52 INFO - PROCESS | 1692 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:1.64 (0.9%) stddev-sans-first:1.73 03:45:52 INFO - PROCESS | 1692 | Values: 183.0 182.0 183.0 185.0 183.0 179.0 182.0 182.0 184.0 184.0 03:45:52 INFO - PROCESS | 1692 | 03:45:52 INFO - PROCESS | 1692 | [#3] audio-fft Cycles:10 Average:73.00 Median:65.00 stddev:17.69 (27.2%) stddev-sans-first:18.53 03:45:52 INFO - PROCESS | 1692 | Values: 81.0 59.0 60.0 90.0 67.0 58.0 60.0 63.0 112.0 80.0 03:45:52 INFO - PROCESS | 1692 | 03:45:52 INFO - PROCESS | 1692 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:77.00 stddev:11.37 (14.8%) stddev-sans-first:11.81 03:45:52 INFO - PROCESS | 1692 | Values: 84.0 68.0 94.0 69.0 69.0 70.0 93.0 68.0 69.0 90.0 03:45:52 INFO - PROCESS | 1692 | 03:45:52 INFO - PROCESS | 1692 | [#5] imaging-gaussian-blur Cycles:10 Average:97.60 Median:90.00 stddev:17.25 (19.2%) stddev-sans-first:18.18 03:45:52 INFO - PROCESS | 1692 | Values: 92.0 87.0 135.0 124.0 91.0 85.0 95.0 89.0 91.0 87.0 03:45:52 INFO - PROCESS | 1692 | 03:45:52 INFO - PROCESS | 1692 | [#6] imaging-darkroom Cycles:10 Average:95.70 Median:96.00 stddev:1.06 (1.1%) stddev-sans-first:0.73 03:45:52 INFO - PROCESS | 1692 | Values: 98.0 96.0 96.0 95.0 94.0 96.0 95.0 96.0 95.0 96.0 03:45:52 INFO - PROCESS | 1692 | 03:45:52 INFO - PROCESS | 1692 | [#7] imaging-desaturate Cycles:10 Average:90.80 Median:85.50 stddev:15.43 (18.1%) stddev-sans-first:16.23 03:45:52 INFO - PROCESS | 1692 | Values: 85.0 85.0 87.0 87.0 84.0 83.0 93.0 134.0 86.0 84.0 03:45:52 INFO - PROCESS | 1692 | 03:45:52 INFO - PROCESS | 1692 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:58.00 stddev:1.64 (2.8%) stddev-sans-first:1.72 03:45:52 INFO - PROCESS | 1692 | Values: 58.0 55.0 54.0 57.0 58.0 59.0 59.0 58.0 57.0 58.0 03:45:52 INFO - PROCESS | 1692 | 03:45:52 INFO - PROCESS | 1692 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:70.50 stddev:3.56 (5.1%) stddev-sans-first:3.35 03:45:52 INFO - PROCESS | 1692 | Values: 66.0 75.0 68.0 78.0 72.0 68.0 69.0 70.0 70.0 71.0 03:45:52 INFO - PROCESS | 1692 | 03:45:52 INFO - PROCESS | 1692 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:85.00 stddev:7.45 (8.8%) stddev-sans-first:7.70 03:45:52 INFO - PROCESS | 1692 | Values: 84.0 85.0 83.0 85.0 85.0 95.0 100.0 102.0 81.0 88.0 03:45:52 INFO - PROCESS | 1692 | 03:45:52 INFO - PROCESS | 1692 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:137.50 stddev:10.42 (7.6%) stddev-sans-first:11.06 03:45:52 INFO - PROCESS | 1692 | Values: 141.0 137.0 137.0 137.0 137.0 138.0 136.0 139.0 170.0 135.0 03:45:52 INFO - PROCESS | 1692 | 03:45:52 INFO - PROCESS | 1692 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:163.00 stddev:25.60 (15.7%) stddev-sans-first:25.03 03:45:52 INFO - PROCESS | 1692 | Values: 203.0 145.0 200.0 226.0 162.0 163.0 163.0 161.0 162.0 162.0 03:45:52 INFO - PROCESS | 1692 | 03:45:52 INFO - PROCESS | 1692 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:74.00 stddev:8.07 (10.9%) stddev-sans-first:8.28 03:45:52 INFO - PROCESS | 1692 | Values: 67.0 66.0 67.0 65.0 69.0 79.0 83.0 83.0 83.0 66.0 03:45:52 INFO - PROCESS | 1692 | -------- Summary: end -------- 03:45:52 INFO - PROCESS | 1692 | 03:45:52 INFO - TEST-INFO | 1692: exit 0 03:45:52 INFO - TEST-OK | kraken | took 58814ms 03:45:52 INFO - SUITE-END | took 1176s 03:45:53 INFO - Completed test suite (00:19:37) 03:45:53 INFO - javascript benchmark 03:45:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3161.099086760273, 3259.820709860957, 3280.3111346617225, 3325.1853295942483, 3327.48423994281, 4710.152172608929, 5632.070708333125, 5634.04221282382, 5719.771209151629, 5720.513756330712, 5635.070213414781, 5712.628679135853, 5725.427457254273, 5731.283589551306, 5765.423457654232, 5167.966406718652, 5192.221166824987, 5209.374875014984, 5209.426963034063, 5241.135212689902, 4273.230818452677, 5151.6908985460805, 5165.9225111623355, 5191.402988656315, 5312.335958005249, 5178.818741344054, 5181.455947125554, 5186.118359878829, 5242.292290540785, 5244.947550524503, 5213.9478605214035, 5237.528622424, 5282.366116066097, 5282.867928301785, 5335.893282134336, 5088.2622019807295, 5130.204818253177, 5225.059489291926, 5225.817096401608, 5234.81678141267, 5574.358948720908, 5599.4120617335, 5628.971855140739, 5649.887002259973, 5663.603547751659, 6139.2325959255095, 6194.442500175006, 6194.5354098442795, 6240.719167637467, 6245.3442388549, 5517.806876759334, 6267.498600112026, 6312.3372045934975, 6321.747130114836, 6335.619862808247, 5616.129499927477, 5654.858628534237, 5682.40334764852, 5685.232493613392, 5737.483626473554, 6247.718852651551, 6298.685065746694, 6323.810285691437, 6327.746890124436, 6332.240131184288, 5116.334876466036, 6109.083637454418, 6129.049997250433, 6147.170132032118, 6148.846278843064, 6088.4215999479975, 6089.056196289582, 6124.686092398479, 6268.749250029948, 6281.937180628135, 5290.391604965478, 6128.3258841527395, 6154.692265386713, 6200.0, 6208.9689551551955, 6198.473129783929, 6229.719662615103, 6234.657093859791, 6237.09562113491, 6251.999680051261, 4811.831585894477, 4822.373091498153, 4877.341558889575, 4887.706737595685, 4890.510948905081, 4373.518912919576, 4373.75944323059, 4430.401895744098, 4430.756308403004, 4456.9331460028125, 5769.711514424262, 5788.7684492620665, 5794.768209271582, 5801.680907550125, 5813.04084825999, 6313.0, 6316.147320111818, 6318.7472501100365, 6325.746970121236, 6338.207724034496, 5575.776968921279, 5715.228444159985, 5724.77100915967, 5789.131630255495, 5797.304323481125, 5336.279602253724, 5389.083855744533, 5397.568194544427, 5404.945950540523, 5467.835964921059, 5367.597430192829, 6347.841303967253, 6352.618842869442, 6380.7128679209545, 6386.010168423994, 6302.65335406557, 6311.756803821196, 6320.399562041599, 6344.048392741126, 6368.235811702625, 6317.810465686037, 6333.018382150774, 6363.681815909279, 6373.3945275198785, 6379.362063793584, 5499.5426212053035, 6185.969070154621, 6218.968905155445, 6223.097650840512, 6233.252009758677, 5385.353757549119, 6143.047827586731, 6288.748450061947, 6297.055441683784, 6313.589616674902, 5899.852503687443, 5945.078512830518, 5953.672548009901, 5983.581149319506, 6091.573589848668, 6034.63792172471, 6081.6351018939, 6084.543659225487, 6115.113308570143, 6131.141640170469, 5881.882362352814, 5884.293884733859, 5891.764329426775, 5897.292324921037, 5910.468057874812, 5839.124131380327, 5872.265966754156, 6019.0, 6035.879282414415, 6107.450329470369, 5776.277965254343, 5807.593468457168, 5827.446392592697, 5872.941270587239, 5959.0763431668165], "value": 5652.117548669601, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.5241082711874, 518.9377274727034, 523.552362729866, 531.5720844719999, 532.419662567801, 30057.84971075144, 41193.7641870744, 41803.79098104509, 41827.74516764494, 43985.56014439854, 42786.93032674184, 43296.783516082454, 43703.0, 43728.56271437285, 43929.34105988413, 9705.708828735149, 9878.456684882329, 9897.95051024744, 9917.851232231522, 9931.503424828767, 9661.130498255156, 9709.17472014876, 9723.46520941348, 9734.805303893918, 9749.171320437772, 8856.822863542726, 9171.174594286513, 9695.563699633498, 9767.120959113678, 9809.313348065638, 9644.951775241148, 9681.757956051084, 9728.027197280215, 9732.026797320283, 9741.756456088584, 9742.0, 9798.853017204749, 9804.852927206097, 9822.65620703272, 9836.31145819793, 41069.794651026554, 41470.0, 41497.37753933663, 41593.58406415927, 41601.791991040154, 3316.1046517440154, 3318.303156337172, 3374.578177727784, 3383.1711230748624, 3407.795532268072, 29759.25601859949, 30739.231519211975, 31676.524852127237, 32436.513452298233, 32539.51190732141, 2824.8587570621594, 3036.316828713544, 3206.246532064963, 3208.0856955767495, 3208.9197770055703, 548889.0, 549140.0, 551957.0, 552421.0, 552660.0, 33669.15827104342, 34259.65740342614, 63394.68302658457, 63988.68005660035, 64065.67967160227, 35273.823630881685, 35810.283794323965, 35931.64068359335, 35942.28115437729, 35963.640363596554, 15006.0, 15176.165310908005, 15189.16459594733, 15211.326754057045, 15215.011024283385, 12922.741545169043, 13000.674983125498, 13012.958963282914, 13021.218726876417, 13039.282839443731, 7797.844043119106, 7816.7264145754625, 7819.257170568787, 7894.368450523944, 7895.842083158304, 2855.400365923138, 3215.13191438315, 3233.143217047484, 3256.8371581421306, 3258.804471731704, 895.789489469974, 910.7131253655077, 982.0817535604233, 992.4144754594823, 1000.9749756256152, 29648.703512965025, 30460.238494037825, 30473.0, 30810.69189308078, 31313.373732525222, 915.3135148638521, 1070.6787963610886, 1077.7144056824948, 1099.5931505343074, 1112.57165991094, 15113.47102851417, 15469.917105802711, 15743.0, 15829.366825327088, 15851.286692098884, 590451.0477447585, 591910.0, 593156.0, 593193.0, 593772.0, 57084.0, 57710.0, 57774.133387999216, 57816.42183578195, 57969.0, 1251.561953316332, 1267.7781388257204, 1355.0920883008212, 1376.3737499437732, 1392.7144935288445, 29822.850885745433, 30420.485901472686, 31229.219269518442, 31492.0, 31860.36279274448, 48703.51296487131, 48991.02017959692, 49249.01501970012, 49279.01441971212, 49339.0, 534944.0, 535736.0, 538128.0, 543119.0, 544085.0, 27008.59487107734, 27623.86188069127, 27637.065405422232, 28377.574336384558, 28452.85773571119, 46828.7658561705, 47095.764521177174, 47564.2865357013, 47576.286355705386, 47905.0, 39413.605863941, 39706.60293397029, 39797.0, 40105.598944010184, 41629.375559366024, 35053.824730876186, 37932.81033594815, 39259.214815704094, 39911.0, 41194.0, 38936.41595376128, 39244.41133382944, 39427.0, 39491.2101757969, 39627.80186099051, 33007.50488742623, 35062.0, 35608.82195589005, 35820.64179358173, 36410.72562460301, 25776.09783657563, 26176.952921882912, 26296.948122075668, 26398.47393809889, 26438.603420948315], "value": 18768.6147655928, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.29168745634166, 351.4412084785191, 375.4818350676066, 376.6873494999151, 399.31517447577414, 14938.477153299636, 15170.696586068287, 16063.518094457171, 20518.589628207428, 21003.789962100374, 16956.660866782688, 19988.700169497468, 20116.698249526267, 20993.47516312093, 21204.0, 5712.11462223356, 5879.706014699269, 5936.851578710545, 5977.1034344848185, 5984.640921544721, 4124.422580838685, 4211.241976444238, 5788.5658575606785, 5839.328477225131, 5848.385919478457, 4230.407742915994, 4297.871063868089, 6252.562320637558, 6563.770268040619, 6567.343265673442, 5453.590980676465, 6272.529560282997, 6363.172787537614, 6540.247871494791, 6598.208215014205, 5673.0, 5673.886522269531, 5678.4605462480995, 5686.488216060575, 5690.971545142289, 25009.749902500924, 25878.6118208227, 26251.73748262512, 26265.949362025494, 26543.203703888914, 1980.9504762381055, 2192.4628466025765, 2196.428928478591, 2254.3349711834885, 2294.655801629769, 14327.35526901292, 15489.302981365865, 15647.687046259125, 15988.198831803547, 16386.098764567945, 1745.7119575270065, 1823.927042918295, 1843.6725557598509, 1867.617138486607, 1913.8660293779442, 116251.2562311566, 118751.4062429691, 120716.79283207143, 120893.0, 122626.77373226243, 9245.861312080324, 9259.537023148816, 10496.370217786805, 10905.709800941733, 11527.13546484017, 14037.438502459992, 14051.0, 14059.71880562383, 14069.85930140706, 14111.082779619497, 8529.914700853036, 8820.558972051373, 8822.735317940473, 8922.330825188137, 8955.552222388855, 8916.420432671855, 8937.508437036025, 8943.0, 9105.81788364229, 9132.99537050924, 6523.249826269945, 6631.834204144839, 6645.501587380966, 6645.634490103091, 6647.235567909753, 1680.2525373611552, 1808.5117018404958, 1839.6320735852883, 1840.3006857394373, 1843.216632930999, 802.297989259398, 845.7674139611534, 862.1809281182901, 886.4371124335964, 950.2398081534744, 21273.574528509344, 22731.0, 22843.885780570992, 22908.0, 22992.65511017336, 982.268210183418, 997.8154041502345, 1000.9949950250202, 1017.0998666180484, 1047.162270183865, 9426.717198484057, 10837.349759014485, 11050.171237157245, 11353.375564343874, 11728.589499367652, 456555.0, 518790.0, 593859.0, 620149.0, 621696.0, 122822.0, 124296.37851810864, 125908.1113783294, 126331.10503342457, 127570.36214818867, 946.6970569417721, 995.0348162282575, 1014.974625634365, 1020.357174979758, 1020.3877673396051, 18872.0, 19403.0, 20113.865236205507, 20371.59256814885, 20453.59092818165, 54523.0, 59845.70077149587, 60543.69728151331, 61079.69460152671, 63004.0, 80669.59665201636, 83316.0, 84767.0, 85815.570922145, 87266.56366718125, 6231.376862313732, 7173.569585824867, 7467.402607791255, 7643.273888980761, 8000.159983201913, 11016.17378696585, 12939.288339141061, 13116.081874269092, 13173.0, 13530.985176111633, 5481.671099734029, 10823.103682674388, 10901.073408760345, 11092.611758588411, 11297.26567773092, 11297.26567773092, 11310.038646715122, 11484.36835973996, 11544.59593914209, 11907.761844762883, 10045.899541004497, 11188.384638844942, 11233.213675042669, 11355.489002995051, 11800.76398472043, 7233.529820561646, 7363.852722945619, 7411.518251313647, 7640.73257435987, 7726.961365193138, 8655.485290074337, 9472.384295021076, 11322.32066076038, 11577.305361677989, 11691.590794322157], "value": 9665.293978335945, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1504.6088017115553, 1519.490970524874, 1694.127524324973, 1851.953701157471, 1858.0523932794272, 8568.10034946331, 9138.314626403013, 9152.633894644207, 9168.404053736502, 9171.128742769442, 7960.482568633035, 8202.91797082029, 8205.343572514199, 8655.783605409868, 8905.15401036902, 2380.809535237181, 2425.2724182745196, 2428.174420696963, 2428.405040765015, 2431.756824317572, 2376.227725989052, 2401.387646150229, 2418.9879050604723, 2419.745926677691, 2425.34515680767, 2098.3495116513855, 2173.0655817998254, 2332.3352844439337, 2400.687910571632, 2405.7353691093967, 2389.0921449848947, 2397.6883005209297, 2422.079609748302, 2425.0299880047946, 2425.1027119965547, 2407.7110746710505, 2408.6266628672583, 2413.6500207469994, 2414.5653782319177, 2418.9758102418928, 9033.412828166149, 9120.498372589505, 9124.224440922464, 9132.269418446509, 9139.177474027369, 5297.682139071668, 5417.6207665463435, 5487.670739755627, 5494.340679118492, 5502.752376143083, 3472.322897035079, 3580.7135429165605, 3706.703463722896, 3709.3848836570155, 3713.053171441265, 1049.082053203447, 1079.0558261521169, 1083.4474418046852, 1101.0971003776906, 1102.8731695855, 12030.578929737418, 12125.029997600172, 12150.210236334698, 12150.5747298845, 12160.878391216063, 4698.976505117521, 4776.902629212729, 4796.880077998078, 4918.409790825124, 4919.0, 10287.897121028844, 10289.0, 10292.794144117226, 10293.845592316122, 10300.124489418333, 5440.537554307849, 5462.317210348707, 5471.8084867029465, 5476.014317422822, 5478.01395748769, 4259.9574004260185, 4772.427308722976, 4915.361003069578, 4948.282499037619, 4991.80032798684, 3526.3652542542077, 3630.2739452109686, 3805.1818858945458, 3847.8653247136776, 3879.631435013669, 1032.1175395037285, 1150.045462266317, 1161.4483120517855, 1164.0047759165961, 1164.7728692904802, 719.8560287942432, 868.8696695495727, 904.2088172848757, 911.2662013958126, 979.0063085967748, 5673.120666296731, 5832.4252451837765, 5864.67744274069, 6181.227346581677, 6239.0953311770445, 855.422589751915, 858.3733874271817, 891.6923661336829, 934.3693007220099, 951.6241084771476, 3814.5231846019246, 3982.8008599570485, 4002.1795531915886, 4088.4259560069586, 4120.526139493936, 10525.157987360994, 10625.5218515167, 10679.83980240297, 10807.297525660806, 10828.0, 10373.84439233412, 10794.78410431787, 10819.350838949687, 10837.403942783065, 10855.131589472823, 8183.713570025139, 8410.579471026424, 8437.40938134337, 8439.0, 8455.0, 5971.731272092853, 5999.310079340931, 6038.154658347747, 6047.425494578008, 6257.874842503215, 9996.350237234556, 10058.19534437258, 10183.694489165337, 10380.896191038295, 10402.219833512669, 9049.728508144766, 9198.804155459748, 10109.64616238428, 10380.948095259475, 10513.526891290063, 7354.264573542603, 7484.32641062307, 7486.588237646982, 7502.099748030271, 7507.399408047234, 8005.039395272604, 8085.312748416215, 8100.594970251582, 8114.472559283628, 8121.106678265504, 7243.637818108968, 7318.817029574303, 7359.227281135618, 7433.442491813027, 7467.290607392289, 7162.7493037743425, 7170.856582868418, 7210.098737657793, 7340.302671246223, 7371.778846634609, 6799.89800153008, 6812.693428795617, 6881.931180688129, 6894.655267236518, 6897.7240910365035, 4962.478939711278, 4977.726225057657, 4990.600751939909, 5002.349694539686, 5014.197728363444, 4913.557779799835, 4939.308496810521, 4946.629002824874, 5165.509276618865, 5174.7153906535505], "value": 4610.918877928286, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.4186198533925, 296.53888203843024, 305.5371112764163, 310.94589342130166, 312.3721320146508, 4380.671449641273, 4641.700323909311, 5260.263563101164, 5346.786128554858, 5370.516653501184, 4154.67898243489, 4554.2713165893465, 4777.259524773657, 5239.423663397023, 5242.8165014224505, 3550.5739311282555, 4041.4746083009168, 4072.266991941442, 4133.511935703144, 4151.501819781631, 3885.9028524286978, 4030.415589739486, 4164.500259968808, 4171.8539851105215, 4174.206900688874, 3963.5838236985132, 4054.97972510137, 4090.5704900985415, 4090.9386359204636, 4115.625187346377, 4068.938965915484, 4080.3063479208604, 4084.244414783275, 4099.672026237894, 4102.220578090169, 2993.3863557970562, 3581.871710411212, 3595.7123430125525, 3597.165445622751, 3597.964020359789, 4098.8360465581345, 4811.302361157647, 5204.245384419276, 5213.653855764883, 5235.345581802275, 3919.510061242345, 4108.732932359417, 4713.575778179946, 4736.478987311393, 4774.236122220428, 5647.463490968393, 5660.801871934504, 5662.319492329977, 5700.429957004308, 5711.001724094884, 3250.447423937936, 3654.963450365489, 3870.8645197417954, 3956.140613911457, 3970.563238043813, 4730.645201609893, 5544.445555444423, 5649.971750141223, 5704.77180912763, 5762.838935399225, 3249.94376827532, 3440.522823567028, 3793.506844110303, 3993.241284156059, 4039.949613100615, 3361.798292102482, 4066.6949978751713, 4073.2260870434525, 4079.2453396121814, 4085.1616772452517, 3933.449317095609, 4608.364030769028, 4686.601638860667, 4695.9337891327705, 4715.434147902205, 4850.684705494132, 4880.829170978998, 4974.37820272466, 5624.578156638268, 5670.829875103754, 1158.6096683979258, 1212.1878341511208, 1273.8789814967563, 1306.3337697774205, 1361.4962463888426, 737.8524295140993, 739.5451797144717, 796.4783067091065, 803.5299349880269, 845.5434065604628, 3813.389857622767, 4387.003913219478, 4429.889252768707, 4436.600705936481, 4452.910941781146, 4272.829086836492, 4708.270218116198, 4810.979388656772, 4832.299316599074, 4844.709317440965, 3816.5610954740005, 4395.7142785718825, 4395.802188901507, 4446.444194475691, 4448.488423831301, 2215.9335219943428, 2353.482233908537, 2517.3958250019864, 2523.5962246040544, 2562.7309132540813, 4120.104751814199, 4484.730916144977, 4657.254839225708, 4732.390987064415, 5039.4708555601865, 4680.602148817388, 4921.557059864629, 4935.555799978019, 4943.4809345018975, 4961.7271050092595, 4990.6257030722845, 5426.945730542723, 6021.9051045289625, 6038.547108966757, 6123.040626999317, 5171.707073231692, 5517.0, 5703.321357724161, 5824.912626310524, 5828.329742079715, 4705.823544113971, 5059.620528460454, 5401.756920938488, 5817.76728930838, 5836.665333866487, 4268.658507319469, 5028.9245661315845, 5970.671613061323, 6002.909956350571, 6046.818595442144, 3139.1681204480374, 3209.630892447305, 3446.8965931022108, 3955.1891862168764, 3964.088259700343, 5857.765689372377, 5880.735366908414, 5895.616784908967, 5906.350301466921, 5956.629975105837, 5012.674176178537, 5046.823361182341, 5108.719020453911, 5331.466853314792, 5643.943560564342, 4771.974025584516, 4912.901741965212, 4955.40535135786, 5691.174779657009, 5698.230738850202, 5519.227308176778, 5529.4470552945995, 5552.472515111058, 5567.24211157459, 5571.0, 4948.876278092933, 5362.3268061378085, 5438.021156191923, 5505.862353441196, 5697.57268204878, 4687.08601822655, 5522.6134170607675, 5542.168674698827, 5572.8823047241785, 5579.386267510652], "value": 3926.8982647709577, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.6501421862316, 707.1655446573045, 743.1713639292191, 768.2663056780775, 801.9839603207938, 14012.929935350321, 14594.48919287825, 15278.618034549141, 15408.383664653415, 15471.381144754196, 13616.659583510393, 13998.51005214815, 14006.0, 14024.439022439115, 14029.719405611882, 670.2426258328082, 825.8224481736411, 842.2798507276283, 843.0768308701962, 844.341413697314, 689.1661090081008, 692.7298353642084, 693.3794254142565, 694.1565997313263, 828.8549503836834, 882.1222883231194, 891.6210610490548, 903.1690844423147, 904.3443503460005, 905.9909400906006, 898.2993265253048, 899.5996781432265, 901.0944001278673, 901.1709227510673, 901.1709227510673, 514.3776031002492, 530.1755769777993, 631.0912286307748, 658.0195508692015, 659.5383231737754, 14628.561143165722, 15078.472253471185, 15100.5469835904, 15115.622109447242, 15136.621584460367, 13382.263975481344, 13402.932985335108, 13570.864291357058, 13583.932080339633, 13944.790828137586, 10731.35611863283, 11012.39431831249, 11290.548378064868, 11294.09647228228, 11608.883911160865, 4294.0, 4360.694751367406, 4363.847265345697, 4372.1692878353015, 4418.911621767546, 115899.0, 118930.0, 120042.19936700957, 120766.0, 123059.0, 10003.399796012263, 10389.9480502597, 10443.530041148166, 10565.943405659373, 10600.151987840954, 19589.412317630493, 19641.214351425784, 19680.015999199983, 19739.013049347475, 19749.506262343555, 6733.562318449285, 6830.248672646005, 7305.123385193704, 7425.220351863085, 7449.925500745032, 4000.079981604247, 4059.4519739835337, 4080.9387859182134, 4205.137946720914, 4290.442242508517, 2834.2772592988654, 3179.8410079495934, 3288.901332960015, 3292.4073666739737, 3293.522439246296, 644.320242144542, 650.9934900651027, 658.723336198788, 659.8782070480203, 667.8196886840623, 547.3814589513823, 554.6588847858619, 556.1768582497925, 584.8215845072183, 594.9672767997802, 8601.569921504026, 8642.78393040179, 8870.15733505316, 8873.112688731075, 9052.81894362109, 554.9028919938994, 585.2830282903409, 586.5659412035149, 587.7648940423779, 615.2893408113636, 3833.674137698271, 4176.4570605821045, 4200.394005137054, 4264.189803937304, 4313.892152696208, 131181.0, 134011.0, 156514.0, 180074.19925800836, 181712.0, 140498.78503644906, 141189.0, 144784.0, 145673.0, 150439.0, 121510.0, 126037.0, 131410.99999999808, 132530.0, 134476.0, 8398.916010839814, 8404.789880252798, 8439.198276163756, 8484.0, 8772.78068048304, 54107.45892541182, 56537.0, 62329.37670623236, 65028.0, 68196.6590167046, 95118.52440738029, 95773.0, 100743.0, 106013.0, 108313.45843270734, 12996.335751171177, 13226.669333266746, 13235.735285294433, 13733.587992360246, 13963.379325492766, 12419.875801241871, 14106.365213565208, 14733.0, 15124.016938898936, 15624.375024998873, 12993.350332483527, 13404.262765547988, 13418.731625367633, 13862.86137138656, 14178.858211417753, 11102.888971110186, 13325.400356984153, 14033.859661403256, 14246.786298205743, 14926.925365373103, 13336.599902002956, 13813.309334533435, 13956.79064814049, 14541.709165816836, 14596.12423254608, 11180.552777888794, 11248.775024499628, 11642.24325418879, 11986.700332491757, 12008.339541325311, 9913.801723965624, 11604.76790464169, 11660.591879284184, 11809.350485723024, 11910.34493102853], "value": 7692.607541421915, "unit": "score"}], "name": "dromaeo_css", "value": 7229.958719661794, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 115.0, 114.0, 113.0, 115.0, 115.0, 114.0, 114.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 110.0, 106.0, 139.0, 107.0, 110.0, 109.0, 107.0, 140.0, 107.0], "value": 117.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 183.0, 185.0, 183.0, 179.0, 182.0, 182.0, 184.0, 184.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 90.0, 67.0, 58.0, 60.0, 63.0, 112.0, 80.0], "value": 73.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 68.0, 94.0, 69.0, 69.0, 70.0, 93.0, 68.0, 69.0, 90.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 87.0, 135.0, 124.0, 91.0, 85.0, 95.0, 89.0, 91.0, 87.0], "value": 97.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 96.0, 95.0, 94.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 87.0, 87.0, 84.0, 83.0, 93.0, 134.0, 86.0, 84.0], "value": 90.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 54.0, 57.0, 58.0, 59.0, 59.0, 58.0, 57.0, 58.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 75.0, 68.0, 78.0, 72.0, 68.0, 69.0, 70.0, 70.0, 71.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 83.0, 85.0, 85.0, 95.0, 100.0, 102.0, 81.0, 88.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 137.0, 137.0, 137.0, 137.0, 138.0, 136.0, 139.0, 170.0, 135.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 145.0, 200.0, 226.0, 162.0, 163.0, 163.0, 161.0, 162.0, 162.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 65.0, 69.0, 79.0, 83.0, 83.0, 83.0, 66.0], "value": 72.8, "unit": "score"}], "name": "kraken", "value": 1454.3, "alertThreshold": 2.0}]} 03:45:53 INFO - Return code: 0 03:45:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:45:53 INFO - # TBPL SUCCESS # 03:45:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:45:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:45:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:45:53 INFO - 2016-11-10 03:45:53.444 screenresolution[1696:10089] starting screenresolution argv=screenresolution get 03:45:53 INFO - 2016-11-10 03:45:53.447 screenresolution[1696:10089] Display 0: 1600x1200x32@60 03:45:53 INFO - 2016-11-10 03:45:53.453 screenresolution[1697:10092] starting screenresolution argv=screenresolution list 03:45:53 INFO - Available Modes on Display 0 03:45:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:45:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:45:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:45:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:45:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:45:53 INFO - Intel Iris: 03:45:53 INFO - Chipset Model: Intel Iris 03:45:53 INFO - Type: GPU 03:45:53 INFO - Bus: Built-In 03:45:53 INFO - VRAM (Dynamic, Max): 1536 MB 03:45:53 INFO - Vendor: Intel (0x8086) 03:45:53 INFO - Device ID: 0x0a2e 03:45:53 INFO - Revision ID: 0x0009 03:45:53 INFO - Displays: 03:45:53 INFO - Display: 03:45:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:45:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:45:53 INFO - Display Serial Number: 1600x1200 60 03:45:53 INFO - Main Display: Yes 03:45:53 INFO - Mirror: Off 03:45:53 INFO - Online: Yes 03:45:53 INFO - Rotation: Supported 03:45:53 INFO - Return code: 0 03:45:53 INFO - Running post-action listener: _resource_record_post_action 03:45:53 INFO - [mozharness: 2016-11-10 11:45:53.689537Z] Finished run-tests step (success) 03:45:53 INFO - Running post-run listener: _resource_record_post_run 03:45:53 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 36873216; Write bytes: 663387136; Read time: 391; Write time: 2003 03:45:53 INFO - TinderboxPrint: CPU usage
53.5% 03:45:53 INFO - TinderboxPrint: I/O read bytes / time
36,873,216 / 391 03:45:53 INFO - TinderboxPrint: I/O write bytes / time
663,387,136 / 2,003 03:45:53 INFO - TinderboxPrint: CPU idle
2,249.5 (46.5%) 03:45:53 INFO - TinderboxPrint: CPU system
973.5 (20.1%) 03:45:53 INFO - TinderboxPrint: CPU user
1,618.7 (33.4%) 03:45:53 INFO - TinderboxPrint: Swap in / out
400,494,592 / 0 03:45:53 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 360878592; Write bytes: 357128192; Read time: 28396; Write time: 789 03:45:53 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 34800640; Write bytes: 294982656; Read time: 367; Write time: 1177 03:45:54 INFO - Running post-run listener: _upload_blobber_files 03:45:54 INFO - Blob upload gear active. 03:45:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:45:54 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 03:45:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:45:54 INFO - (blobuploader) - INFO - Open directory for files ... 03:45:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:45:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:45:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:55 INFO - (blobuploader) - INFO - Done attempting. 03:45:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:45:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:45:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:56 INFO - (blobuploader) - INFO - Done attempting. 03:45:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:45:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:45:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:59 INFO - (blobuploader) - INFO - Done attempting. 03:45:59 INFO - (blobuploader) - INFO - Iteration through files over. 03:45:59 INFO - Return code: 0 03:45:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:45:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:45:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bda258460ee786782e852dde82a24d938951bb13751afa6eb0cf6b581c28e4e6c03bc51ab2ee941a45bd79a01a671a911c12f2da5828a52f286e91ac50897bcc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bc18d38f6c368e4cba6f7879ac858cef9ef2e39607f9d0fd6a88d4c2bc1e3e0d6a35a78f8ff1e79835993a8f645241306b2a8cf23f56b9428735ca425957af8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ac306c2eded00efa47b5bbb59d5adcea251b4045abfa7145b050bb29ee81e197a118023c0e8a48074ed8a3cc267fc1b8c576b92a413a93ca7960df198fbf2bc"} 03:45:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:45:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:45:59 INFO - Contents: 03:45:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bda258460ee786782e852dde82a24d938951bb13751afa6eb0cf6b581c28e4e6c03bc51ab2ee941a45bd79a01a671a911c12f2da5828a52f286e91ac50897bcc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bc18d38f6c368e4cba6f7879ac858cef9ef2e39607f9d0fd6a88d4c2bc1e3e0d6a35a78f8ff1e79835993a8f645241306b2a8cf23f56b9428735ca425957af8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ac306c2eded00efa47b5bbb59d5adcea251b4045abfa7145b050bb29ee81e197a118023c0e8a48074ed8a3cc267fc1b8c576b92a413a93ca7960df198fbf2bc"} 03:45:59 INFO - Running post-run listener: copy_logs_to_upload_dir 03:45:59 INFO - Copying logs to upload dir... 03:45:59 INFO - mkdir: /builds/slave/test/build/upload/logs 03:45:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.847260 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-10 03:45:59.198182) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-10 03:45:59.201290) ========= 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.3G2S4BedBK/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.gUvOIfVO6b/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bda258460ee786782e852dde82a24d938951bb13751afa6eb0cf6b581c28e4e6c03bc51ab2ee941a45bd79a01a671a911c12f2da5828a52f286e91ac50897bcc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bc18d38f6c368e4cba6f7879ac858cef9ef2e39607f9d0fd6a88d4c2bc1e3e0d6a35a78f8ff1e79835993a8f645241306b2a8cf23f56b9428735ca425957af8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ac306c2eded00efa47b5bbb59d5adcea251b4045abfa7145b050bb29ee81e197a118023c0e8a48074ed8a3cc267fc1b8c576b92a413a93ca7960df198fbf2bc"} build_url:https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010686 build_url: 'https://queue.taskcluster.net/v1/task/MFGQikH9TwGJpkt4OrKWOA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bda258460ee786782e852dde82a24d938951bb13751afa6eb0cf6b581c28e4e6c03bc51ab2ee941a45bd79a01a671a911c12f2da5828a52f286e91ac50897bcc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bc18d38f6c368e4cba6f7879ac858cef9ef2e39607f9d0fd6a88d4c2bc1e3e0d6a35a78f8ff1e79835993a8f645241306b2a8cf23f56b9428735ca425957af8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ac306c2eded00efa47b5bbb59d5adcea251b4045abfa7145b050bb29ee81e197a118023c0e8a48074ed8a3cc267fc1b8c576b92a413a93ca7960df198fbf2bc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-10 03:45:59.234916) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 03:45:59.235271) ========= 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.3G2S4BedBK/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.gUvOIfVO6b/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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.005253 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-10 03:45:59.283956) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-10 03:45:59.284360) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-10 03:45:59.284763) ========= ========= Total master_lag: 0.18 =========