builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0138 starttime: 1477671643.19 results: success (0) buildid: 20161028073158 builduid: 5e504fac8e5e48059afcad9591e23394 revision: 059c6aa6f3fd9154ed065d915a69928df8a2a40b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 09:20:43.190986) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-28 09:20:43.191486) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 09:20:43.191767) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-28 09:20:43.269375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 09:20:43.269772) ========= 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.qRmIFeLvZh/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.DFORNh0xr8/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-28 09:20:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.1M=0.001s 2016-10-28 09:20:43 (15.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120762 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 09:20:43.423925) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-10-28 09:20:43.424230) ========= 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.qRmIFeLvZh/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.DFORNh0xr8/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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.027570 ========= master_lag: 3.41 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-10-28 09:20:46.865847) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-10-28 09:20:46.866276) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 059c6aa6f3fd9154ed065d915a69928df8a2a40b --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 059c6aa6f3fd9154ed065d915a69928df8a2a40b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qRmIFeLvZh/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.DFORNh0xr8/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-28 09:20:46,943 truncating revision to first 12 chars 2016-10-28 09:20:46,943 Setting DEBUG logging. 2016-10-28 09:20:46,944 attempt 1/10 2016-10-28 09:20:46,944 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/059c6aa6f3fd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-28 09:20:48,616 unpacking tar archive at: mozilla-aurora-059c6aa6f3fd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.944441 ========= master_lag: 1.26 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-10-28 09:20:50.071282) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 09:20:50.071642) ========= script_repo_revision: 059c6aa6f3fd9154ed065d915a69928df8a2a40b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-28 09:20:50.072031) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 09:20:50.072297) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-28 09:20:50.093532) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-28 09:20:50.093905) ========= /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.qRmIFeLvZh/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.DFORNh0xr8/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:20:50 INFO - MultiFileLogger online at 20161028 09:20:50 in /builds/slave/test 09:20:50 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 09:20:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:20:50 INFO - {'append_to_log': False, 09:20:50 INFO - 'base_work_dir': '/builds/slave/test', 09:20:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:20:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:20:50 INFO - 'branch': 'Mozilla-Aurora', 09:20:50 INFO - 'buildbot_json_path': 'buildprops.json', 09:20:50 INFO - 'config_files': ('talos/mac_config.py',), 09:20:50 INFO - 'default_actions': ('clobber', 09:20:50 INFO - 'read-buildbot-config', 09:20:50 INFO - 'download-and-extract', 09:20:50 INFO - 'populate-webroot', 09:20:50 INFO - 'create-virtualenv', 09:20:50 INFO - 'install', 09:20:50 INFO - 'run-tests'), 09:20:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:20:50 INFO - 'download_minidump_stackwalk': True, 09:20:50 INFO - 'download_symbols': 'ondemand', 09:20:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:20:50 INFO - 'tooltool.py': '/tools/tooltool.py', 09:20:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:20:50 INFO - '/tools/misc-python/virtualenv.py')}, 09:20:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:20:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:20:50 INFO - 'installer_path': 'installer.exe', 09:20:50 INFO - 'log_level': 'info', 09:20:50 INFO - 'log_name': 'talos', 09:20:50 INFO - 'log_to_console': True, 09:20:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:20:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:20:50 INFO - 'opt_config_files': (), 09:20:50 INFO - 'pip_index': False, 09:20:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:20:50 INFO - 'cmd': ('bash', 09:20:50 INFO - '-c', 09:20:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:20:50 INFO - 'enabled': True, 09:20:50 INFO - 'halt_on_failure': False, 09:20:50 INFO - 'name': 'check_screen_resolution'},), 09:20:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:20:50 INFO - 'cmd': ('bash', 09:20:50 INFO - '-c', 09:20:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:20:50 INFO - 'enabled': True, 09:20:50 INFO - 'halt_on_failure': False, 09:20:50 INFO - 'name': 'check_screen_resolution'},), 09:20:50 INFO - 'run_cmd_checks_enabled': True, 09:20:50 INFO - 'sps_profile': False, 09:20:50 INFO - 'sps_profile_interval': 0, 09:20:50 INFO - 'suite': 'dromaeojs', 09:20:50 INFO - 'system_bits': '32', 09:20:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:20:50 INFO - 'title': 't-yosemite-r7-0138', 09:20:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:20:50 INFO - 'use_talos_json': True, 09:20:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:20:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:20:50 INFO - 'work_dir': 'build'} 09:20:50 INFO - [mozharness: 2016-10-28 16:20:50.292087Z] Running clobber step. 09:20:50 INFO - Running pre-action listener: _resource_record_pre_action 09:20:50 INFO - Running main action method: clobber 09:20:50 INFO - rmtree: /builds/slave/test/build 09:20:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:20:52 INFO - Running post-action listener: _resource_record_post_action 09:20:52 INFO - [mozharness: 2016-10-28 16:20:52.464207Z] Finished clobber step (success) 09:20:52 INFO - [mozharness: 2016-10-28 16:20:52.464335Z] Running read-buildbot-config step. 09:20:52 INFO - Running pre-action listener: _resource_record_pre_action 09:20:52 INFO - Running main action method: read_buildbot_config 09:20:52 INFO - Using buildbot properties: 09:20:52 INFO - { 09:20:52 INFO - "project": "", 09:20:52 INFO - "product": "firefox", 09:20:52 INFO - "script_repo_revision": "production", 09:20:52 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:20:52 INFO - "repository": "", 09:20:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:20:52 INFO - "buildid": "20161028073158", 09:20:52 INFO - "pgo_build": "False", 09:20:52 INFO - "basedir": "/builds/slave/test", 09:20:52 INFO - "buildnumber": 6, 09:20:52 INFO - "slavename": "t-yosemite-r7-0138", 09:20:52 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 09:20:52 INFO - "platform": "yosemite_r7", 09:20:52 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:20:52 INFO - "branch": "mozilla-aurora", 09:20:52 INFO - "repo_path": "releases/mozilla-aurora", 09:20:52 INFO - "revision": "059c6aa6f3fd9154ed065d915a69928df8a2a40b", 09:20:52 INFO - "stage_platform": "macosx64", 09:20:52 INFO - "builduid": "5e504fac8e5e48059afcad9591e23394", 09:20:52 INFO - "slavebuilddir": "test" 09:20:52 INFO - } 09:20:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rs63FGYFQvaxNHf9B7dgxg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 09:20:52 INFO - Running post-action listener: _resource_record_post_action 09:20:52 INFO - [mozharness: 2016-10-28 16:20:52.467600Z] Finished read-buildbot-config step (success) 09:20:52 INFO - [mozharness: 2016-10-28 16:20:52.467753Z] Running download-and-extract step. 09:20:52 INFO - Running pre-action listener: _resource_record_pre_action 09:20:52 INFO - Running main action method: download_and_extract 09:20:52 INFO - mkdir: /builds/slave/test/build/tests 09:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:52 INFO - trying https://queue.taskcluster.net/v1/task/Rs63FGYFQvaxNHf9B7dgxg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 09:20:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Rs63FGYFQvaxNHf9B7dgxg/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 09:20:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rs63FGYFQvaxNHf9B7dgxg/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 09:20:53 INFO - Downloaded 1199 bytes. 09:20:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 09:20:53 INFO - Using the following test package requirements: 09:20:53 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 09:20:53 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:20:53 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 09:20:53 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:20:53 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 09:20:53 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:20:53 INFO - u'jsshell-mac.zip'], 09:20:53 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:20:53 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 09:20:53 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 09:20:53 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:20:53 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 09:20:53 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:20:53 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 09:20:53 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:20:53 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 09:20:53 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:20:53 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 09:20:53 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:20:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rs63FGYFQvaxNHf9B7dgxg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 09:20:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rs63FGYFQvaxNHf9B7dgxg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:20:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Rs63FGYFQvaxNHf9B7dgxg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 09:20:54 INFO - Expected file size: 16420907 09:21:00 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 09:21:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rs63FGYFQvaxNHf9B7dgxg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 09:21:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rs63FGYFQvaxNHf9B7dgxg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:21:00 INFO - Fetch https://queue.taskcluster.net/v1/task/Rs63FGYFQvaxNHf9B7dgxg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 09:21:01 INFO - Expected file size: 16420907 09:21:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rs63FGYFQvaxNHf9B7dgxg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 09:21:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rs63FGYFQvaxNHf9B7dgxg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:21:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Rs63FGYFQvaxNHf9B7dgxg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 09:21:09 INFO - Expected file size: 14414081 09:21:09 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')]} 09:21:09 INFO - trying https://queue.taskcluster.net/v1/task/Rs63FGYFQvaxNHf9B7dgxg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:21:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Rs63FGYFQvaxNHf9B7dgxg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 09:21:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rs63FGYFQvaxNHf9B7dgxg/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 09:21:12 INFO - Downloaded 115422709 bytes. 09:21:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rs63FGYFQvaxNHf9B7dgxg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:21:12 INFO - mkdir: /builds/slave/test/properties 09:21:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:21:12 INFO - Writing to file /builds/slave/test/properties/build_url 09:21:12 INFO - Contents: 09:21:12 INFO - build_url:https://queue.taskcluster.net/v1/task/Rs63FGYFQvaxNHf9B7dgxg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:21:13 INFO - Running post-action listener: _resource_record_post_action 09:21:13 INFO - Running post-action listener: set_extra_try_arguments 09:21:13 INFO - [mozharness: 2016-10-28 16:21:13.268362Z] Finished download-and-extract step (success) 09:21:13 INFO - [mozharness: 2016-10-28 16:21:13.268501Z] Running populate-webroot step. 09:21:13 INFO - Running pre-action listener: _resource_record_pre_action 09:21:13 INFO - Running main action method: populate_webroot 09:21:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:21:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:21:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:21:13 INFO - '--tppagecycles', 09:21:13 INFO - '7'], 09:21:13 INFO - 'tests': ['tsvgm']}}, 09:21:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:21:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:21:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:21:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:21:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:21:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:21:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:13 INFO - 'talos_options': ['--disable-e10s'], 09:21:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:13 INFO - 'talos_options': ['--disable-e10s'], 09:21:13 INFO - 'tests': ['damp', 'tps']}, 09:21:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:13 INFO - 'tests': ['damp', 'tps']}, 09:21:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:21:13 INFO - 'tests': ['dromaeo_dom']}, 09:21:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:21:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:21:13 INFO - 'tests': ['basic_compositor_video']}, 09:21:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:21:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:21:13 INFO - 'tests': ['a11yr', 09:21:13 INFO - 'ts_paint', 09:21:13 INFO - 'tpaint', 09:21:13 INFO - 'sessionrestore', 09:21:13 INFO - 'sessionrestore_no_auto_restore', 09:21:13 INFO - 'tabpaint']}, 09:21:13 INFO - 'other-e10s': {'tests': ['a11yr', 09:21:13 INFO - 'ts_paint', 09:21:13 INFO - 'tpaint', 09:21:13 INFO - 'sessionrestore', 09:21:13 INFO - 'sessionrestore_no_auto_restore', 09:21:13 INFO - 'tabpaint']}, 09:21:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:21:13 INFO - 'ts_paint', 09:21:13 INFO - 'tpaint', 09:21:13 INFO - 'sessionrestore', 09:21:13 INFO - 'sessionrestore_no_auto_restore', 09:21:13 INFO - 'tabpaint']}, 09:21:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:21:13 INFO - 'ts_paint', 09:21:13 INFO - 'tpaint', 09:21:13 INFO - 'sessionrestore', 09:21:13 INFO - 'sessionrestore_no_auto_restore', 09:21:13 INFO - 'tabpaint']}, 09:21:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:21:13 INFO - 'tests': ['a11yr', 09:21:13 INFO - 'ts_paint', 09:21:13 INFO - 'tpaint', 09:21:13 INFO - 'sessionrestore', 09:21:13 INFO - 'sessionrestore_no_auto_restore', 09:21:13 INFO - 'tabpaint']}, 09:21:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:21:13 INFO - 'tests': ['a11yr', 09:21:13 INFO - 'ts_paint', 09:21:13 INFO - 'tpaint', 09:21:13 INFO - 'sessionrestore', 09:21:13 INFO - 'sessionrestore_no_auto_restore', 09:21:13 INFO - 'tabpaint']}, 09:21:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:21:13 INFO - 'tests': ['tsvgx', 09:21:13 INFO - 'tsvgr_opacity', 09:21:13 INFO - 'tart', 09:21:13 INFO - 'tscrollx', 09:21:13 INFO - 'cart']}, 09:21:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:21:13 INFO - 'tsvgr_opacity', 09:21:13 INFO - 'tart', 09:21:13 INFO - 'tscrollx', 09:21:13 INFO - 'cart']}, 09:21:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:13 INFO - 'talos_options': ['--disable-e10s'], 09:21:13 INFO - 'tests': ['tp5o']}, 09:21:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:13 INFO - 'tests': ['tp5o']}, 09:21:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:13 INFO - 'talos_options': ['--disable-e10s', 09:21:13 INFO - '--xperf_path', 09:21:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:13 INFO - 'tests': ['tp5n']}, 09:21:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:13 INFO - 'talos_options': ['--xperf_path', 09:21:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:13 INFO - 'tests': ['tp5n']}}, 09:21:13 INFO - 'talos.zip': {'path': '', 09:21:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:21:13 INFO - Running post-action listener: _resource_record_post_action 09:21:13 INFO - [mozharness: 2016-10-28 16:21:13.287412Z] Finished populate-webroot step (success) 09:21:13 INFO - [mozharness: 2016-10-28 16:21:13.287544Z] Running create-virtualenv step. 09:21:13 INFO - Running pre-action listener: _resource_record_pre_action 09:21:13 INFO - Running main action method: create_virtualenv 09:21:13 INFO - Creating virtualenv /builds/slave/test/build/venv 09:21:13 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 09:21:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:21:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:21:13 INFO - Using real prefix '/tools/python27' 09:21:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:21:14 INFO - Installing distribute.............................................................................................................................................................................................done. 09:21:16 INFO - Installing pip.................done. 09:21:16 INFO - Return code: 0 09:21:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:16 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 0x10104c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe298466350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e60d30>, '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 0x100cc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e58b20>, '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.qRmIFeLvZh/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.DFORNh0xr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:21:16 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 09:21:16 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 09:21:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRmIFeLvZh/Render', 09:21:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:16 INFO - 'HOME': '/Users/cltbld', 09:21:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:16 INFO - 'LOGNAME': 'cltbld', 09:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:16 INFO - 'MOZ_NO_REMOTE': '1', 09:21:16 INFO - 'NO_EM_RESTART': '1', 09:21:16 INFO - 'PAGER': '/bin/cat', 09:21:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:16 INFO - 'PWD': '/builds/slave/test', 09:21:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:16 INFO - 'SHELL': '/bin/bash', 09:21:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFORNh0xr8/Listeners', 09:21:16 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:21:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:16 INFO - 'USER': 'cltbld', 09:21:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:16 INFO - 'XPC_FLAGS': '0x0', 09:21:16 INFO - 'XPC_SERVICE_NAME': '0', 09:21:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:17 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 09:21:17 INFO - Cleaning up... 09:21:17 INFO - Return code: 0 09:21:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10104c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe298466350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e60d30>, '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 0x100cc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e58b20>, '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.qRmIFeLvZh/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.DFORNh0xr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:21:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:21:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:21:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRmIFeLvZh/Render', 09:21:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:17 INFO - 'HOME': '/Users/cltbld', 09:21:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:17 INFO - 'LOGNAME': 'cltbld', 09:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:17 INFO - 'MOZ_NO_REMOTE': '1', 09:21:17 INFO - 'NO_EM_RESTART': '1', 09:21:17 INFO - 'PAGER': '/bin/cat', 09:21:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:17 INFO - 'PWD': '/builds/slave/test', 09:21:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:17 INFO - 'SHELL': '/bin/bash', 09:21:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFORNh0xr8/Listeners', 09:21:17 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:21:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:17 INFO - 'USER': 'cltbld', 09:21:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:17 INFO - 'XPC_FLAGS': '0x0', 09:21:17 INFO - 'XPC_SERVICE_NAME': '0', 09:21:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:17 INFO - Downloading/unpacking psutil>=3.1.1 09:21:17 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 09:21:17 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 09:21:17 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 09:21:17 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 09:21:17 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 09:21:17 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 09:21:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:21:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:20 INFO - Installing collected packages: psutil 09:21:20 INFO - Running setup.py install for psutil 09:21:21 INFO - building 'psutil._psutil_osx' extension 09:21:21 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 09:21:21 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 09:21:21 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 09:21:21 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 09:21:21 INFO - building 'psutil._psutil_posix' extension 09:21:21 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 09:21:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:21:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:21:21 INFO - ^ 09:21:21 INFO - 1 warning generated. 09:21:21 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 09:21:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:22 INFO - Successfully installed psutil 09:21:22 INFO - Cleaning up... 09:21:22 INFO - Return code: 0 09:21:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10104c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe298466350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e60d30>, '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 0x100cc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e58b20>, '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.qRmIFeLvZh/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.DFORNh0xr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:21:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:21:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRmIFeLvZh/Render', 09:21:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:22 INFO - 'HOME': '/Users/cltbld', 09:21:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:22 INFO - 'LOGNAME': 'cltbld', 09:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:22 INFO - 'MOZ_NO_REMOTE': '1', 09:21:22 INFO - 'NO_EM_RESTART': '1', 09:21:22 INFO - 'PAGER': '/bin/cat', 09:21:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:22 INFO - 'PWD': '/builds/slave/test', 09:21:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:22 INFO - 'SHELL': '/bin/bash', 09:21:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFORNh0xr8/Listeners', 09:21:22 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:21:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:22 INFO - 'USER': 'cltbld', 09:21:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:22 INFO - 'XPC_FLAGS': '0x0', 09:21:22 INFO - 'XPC_SERVICE_NAME': '0', 09:21:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:21:25 INFO - Installing collected packages: mozsystemmonitor 09:21:25 INFO - Running setup.py install for mozsystemmonitor 09:21:25 INFO - Successfully installed mozsystemmonitor 09:21:25 INFO - Cleaning up... 09:21:25 INFO - Return code: 0 09:21:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:21:25 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')]} 09:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:25 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')]} 09:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:25 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 0x10104c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe298466350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e60d30>, '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 0x100cc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e58b20>, '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.qRmIFeLvZh/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.DFORNh0xr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:21:25 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 09:21:25 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 09:21:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRmIFeLvZh/Render', 09:21:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:25 INFO - 'HOME': '/Users/cltbld', 09:21:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:25 INFO - 'LOGNAME': 'cltbld', 09:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:25 INFO - 'MOZ_NO_REMOTE': '1', 09:21:25 INFO - 'NO_EM_RESTART': '1', 09:21:25 INFO - 'PAGER': '/bin/cat', 09:21:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:25 INFO - 'PWD': '/builds/slave/test', 09:21:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:25 INFO - 'SHELL': '/bin/bash', 09:21:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFORNh0xr8/Listeners', 09:21:25 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:21:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:25 INFO - 'USER': 'cltbld', 09:21:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:25 INFO - 'XPC_FLAGS': '0x0', 09:21:25 INFO - 'XPC_SERVICE_NAME': '0', 09:21:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:25 INFO - Downloading/unpacking jsonschema==2.5.1 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:21:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21:28 INFO - Downloading functools32-3.2.3-2.tar.gz 09:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:21:28 INFO - warning: no files found matching '*.txt' 09:21:28 INFO - no previously-included directories found matching 'build' 09:21:28 INFO - no previously-included directories found matching 'dist' 09:21:28 INFO - no previously-included directories found matching '.git*' 09:21:28 INFO - Installing collected packages: jsonschema, functools32 09:21:28 INFO - Running setup.py install for functools32 09:21:28 INFO - warning: no files found matching '*.txt' 09:21:28 INFO - no previously-included directories found matching 'build' 09:21:28 INFO - no previously-included directories found matching 'dist' 09:21:28 INFO - no previously-included directories found matching '.git*' 09:21:28 INFO - Successfully installed jsonschema functools32 09:21:28 INFO - Cleaning up... 09:21:28 INFO - Return code: 0 09:21:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:21:28 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')]} 09:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:28 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')]} 09:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:28 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 0x10104c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe298466350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e60d30>, '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 0x100cc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e58b20>, '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.qRmIFeLvZh/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.DFORNh0xr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:21:28 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 09:21:28 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 09:21:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRmIFeLvZh/Render', 09:21:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:28 INFO - 'HOME': '/Users/cltbld', 09:21:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:28 INFO - 'LOGNAME': 'cltbld', 09:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:28 INFO - 'MOZ_NO_REMOTE': '1', 09:21:28 INFO - 'NO_EM_RESTART': '1', 09:21:28 INFO - 'PAGER': '/bin/cat', 09:21:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:28 INFO - 'PWD': '/builds/slave/test', 09:21:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:28 INFO - 'SHELL': '/bin/bash', 09:21:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFORNh0xr8/Listeners', 09:21:28 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:21:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:28 INFO - 'USER': 'cltbld', 09:21:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:28 INFO - 'XPC_FLAGS': '0x0', 09:21:28 INFO - 'XPC_SERVICE_NAME': '0', 09:21:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:21:29 INFO - Cleaning up... 09:21:29 INFO - Return code: 0 09:21:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:21:29 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')]} 09:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:29 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')]} 09:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:29 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 0x10104c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe298466350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e60d30>, '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 0x100cc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e58b20>, '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.qRmIFeLvZh/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.DFORNh0xr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:21:29 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 09:21:29 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 09:21:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRmIFeLvZh/Render', 09:21:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:29 INFO - 'HOME': '/Users/cltbld', 09:21:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:29 INFO - 'LOGNAME': 'cltbld', 09:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:29 INFO - 'MOZ_NO_REMOTE': '1', 09:21:29 INFO - 'NO_EM_RESTART': '1', 09:21:29 INFO - 'PAGER': '/bin/cat', 09:21:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:29 INFO - 'PWD': '/builds/slave/test', 09:21:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:29 INFO - 'SHELL': '/bin/bash', 09:21:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFORNh0xr8/Listeners', 09:21:29 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:21:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:29 INFO - 'USER': 'cltbld', 09:21:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:29 INFO - 'XPC_FLAGS': '0x0', 09:21:29 INFO - 'XPC_SERVICE_NAME': '0', 09:21:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:29 INFO - Downloading/unpacking blobuploader==1.2.4 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21:31 INFO - Downloading blobuploader-1.2.4.tar.gz 09:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:21:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:21:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:21:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:21:32 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 09:21:32 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 09:21:32 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 09:21:32 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 09:21:32 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 09:21:32 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 09:21:32 INFO - Downloading docopt-0.6.1.tar.gz 09:21:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:21:33 INFO - Installing collected packages: blobuploader, requests, docopt 09:21:33 INFO - Running setup.py install for blobuploader 09:21:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:21:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:21:33 INFO - Running setup.py install for requests 09:21:33 INFO - Running setup.py install for docopt 09:21:33 INFO - Successfully installed blobuploader requests docopt 09:21:33 INFO - Cleaning up... 09:21:33 INFO - Return code: 0 09:21:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:33 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 0x10104c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe298466350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e60d30>, '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 0x100cc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e58b20>, '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.qRmIFeLvZh/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.DFORNh0xr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:21:33 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 09:21:33 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 09:21:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRmIFeLvZh/Render', 09:21:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:33 INFO - 'HOME': '/Users/cltbld', 09:21:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:33 INFO - 'LOGNAME': 'cltbld', 09:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:33 INFO - 'MOZ_NO_REMOTE': '1', 09:21:33 INFO - 'NO_EM_RESTART': '1', 09:21:33 INFO - 'PAGER': '/bin/cat', 09:21:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:33 INFO - 'PWD': '/builds/slave/test', 09:21:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:33 INFO - 'SHELL': '/bin/bash', 09:21:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFORNh0xr8/Listeners', 09:21:33 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:21:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:33 INFO - 'USER': 'cltbld', 09:21:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:33 INFO - 'XPC_FLAGS': '0x0', 09:21:33 INFO - 'XPC_SERVICE_NAME': '0', 09:21:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:34 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-7RDqmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:34 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-NG3rct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:34 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-Roei42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:34 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-KG6cxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:34 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-nOLbWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:34 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-vhFAat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:34 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-GwTlll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:34 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-P_GLwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:35 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-Orex99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:35 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-b1aX3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:35 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-G0Di5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:35 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-t1K6Lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:35 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-zvQC9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:35 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-_6wTIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:35 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-9Ex7xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:35 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-eC2Tn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:35 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-Y9V5gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:21:35 INFO - Running setup.py install for manifestparser 09:21:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:21:36 INFO - Running setup.py install for mozcrash 09:21:36 INFO - Running setup.py install for mozdebug 09:21:36 INFO - Running setup.py install for mozdevice 09:21:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:21:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:21:36 INFO - Running setup.py install for mozfile 09:21:36 INFO - Running setup.py install for mozhttpd 09:21:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:21:36 INFO - Running setup.py install for mozinfo 09:21:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:21:37 INFO - Running setup.py install for mozInstall 09:21:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:21:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:21:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:21:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:21:37 INFO - Running setup.py install for mozleak 09:21:37 INFO - Running setup.py install for mozlog 09:21:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:21:37 INFO - Running setup.py install for moznetwork 09:21:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:21:37 INFO - Running setup.py install for mozprocess 09:21:37 INFO - Running setup.py install for mozprofile 09:21:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:21:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:21:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:21:37 INFO - Running setup.py install for mozrunner 09:21:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:21:38 INFO - Running setup.py install for mozscreenshot 09:21:38 INFO - Running setup.py install for moztest 09:21:38 INFO - Running setup.py install for mozversion 09:21:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:21:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:21:38 INFO - Cleaning up... 09:21:38 INFO - Return code: 0 09:21:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:38 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 0x10104c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe298466350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e60d30>, '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 0x100cc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e58b20>, '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.qRmIFeLvZh/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.DFORNh0xr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:21:38 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 09:21:38 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 09:21:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRmIFeLvZh/Render', 09:21:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:38 INFO - 'HOME': '/Users/cltbld', 09:21:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:38 INFO - 'LOGNAME': 'cltbld', 09:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:38 INFO - 'MOZ_NO_REMOTE': '1', 09:21:38 INFO - 'NO_EM_RESTART': '1', 09:21:38 INFO - 'PAGER': '/bin/cat', 09:21:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:38 INFO - 'PWD': '/builds/slave/test', 09:21:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:38 INFO - 'SHELL': '/bin/bash', 09:21:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFORNh0xr8/Listeners', 09:21:38 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:21:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:38 INFO - 'USER': 'cltbld', 09:21:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:38 INFO - 'XPC_FLAGS': '0x0', 09:21:38 INFO - 'XPC_SERVICE_NAME': '0', 09:21:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:38 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-AILm1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:38 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)) 09:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:38 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-CebMoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:39 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)) 09:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:39 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-DVzTiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:39 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)) 09:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:39 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-8CRMia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:39 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)) 09:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:39 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-0j0xS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:39 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)) 09:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:39 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-dsHYvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:39 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)) 09:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:39 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-dWwJVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:39 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)) 09:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:39 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-keLReV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:39 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)) 09:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:39 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-kgYGDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:39 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)) 09:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:39 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-mEXdaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:39 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)) 09:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:39 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-LxuNdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:39 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)) 09:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:40 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-tc_cc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:40 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)) 09:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:40 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-qTMWW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:40 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)) 09:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:40 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-JwEQzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:40 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)) 09:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:40 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-A82ctj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:40 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)) 09:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:40 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-3Q92Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:40 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)) 09:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:40 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-z597Ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:40 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)) 09:21:40 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)) 09:21:40 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)) 09:21:40 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)) 09:21:40 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)) 09:21:40 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)) 09:21:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:21:40 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 09:21:40 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 09:21:40 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 09:21:40 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 09:21:40 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 09:21:40 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 09:21:43 INFO - Downloading blessings-1.6.tar.gz 09:21:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:21:43 INFO - Installing collected packages: blessings 09:21:43 INFO - Running setup.py install for blessings 09:21:43 INFO - Successfully installed blessings 09:21:43 INFO - Cleaning up... 09:21:43 INFO - Return code: 0 09:21:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:21:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:44 INFO - Reading from file tmpfile_stdout 09:21:44 INFO - Current package versions: 09:21:44 INFO - blessings == 1.6 09:21:44 INFO - blobuploader == 1.2.4 09:21:44 INFO - docopt == 0.6.1 09:21:44 INFO - functools32 == 3.2.3-2 09:21:44 INFO - jsonschema == 2.5.1 09:21:44 INFO - manifestparser == 1.1 09:21:44 INFO - mozInstall == 1.12 09:21:44 INFO - mozcrash == 0.17 09:21:44 INFO - mozdebug == 0.1 09:21:44 INFO - mozdevice == 0.48 09:21:44 INFO - mozfile == 1.2 09:21:44 INFO - mozhttpd == 0.7 09:21:44 INFO - mozinfo == 0.9 09:21:44 INFO - mozleak == 0.1 09:21:44 INFO - mozlog == 3.4 09:21:44 INFO - moznetwork == 0.27 09:21:44 INFO - mozprocess == 0.23 09:21:44 INFO - mozprofile == 0.28 09:21:44 INFO - mozrunner == 6.12 09:21:44 INFO - mozscreenshot == 0.1 09:21:44 INFO - mozsystemmonitor == 0.3 09:21:44 INFO - moztest == 0.7 09:21:44 INFO - mozversion == 1.4 09:21:44 INFO - psutil == 3.1.1 09:21:44 INFO - requests == 1.2.3 09:21:44 INFO - wsgiref == 0.1.2 09:21:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:44 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')]} 09:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:44 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')]} 09:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:44 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 0x10104c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe298466350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e60d30>, '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 0x100cc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e58b20>, '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.qRmIFeLvZh/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.DFORNh0xr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:21:44 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 09:21:44 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 09:21:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRmIFeLvZh/Render', 09:21:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:44 INFO - 'HOME': '/Users/cltbld', 09:21:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:44 INFO - 'LOGNAME': 'cltbld', 09:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:44 INFO - 'MOZ_NO_REMOTE': '1', 09:21:44 INFO - 'NO_EM_RESTART': '1', 09:21:44 INFO - 'PAGER': '/bin/cat', 09:21:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:44 INFO - 'PWD': '/builds/slave/test', 09:21:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:44 INFO - 'SHELL': '/bin/bash', 09:21:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFORNh0xr8/Listeners', 09:21:44 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:21:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:44 INFO - 'USER': 'cltbld', 09:21:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:44 INFO - 'XPC_FLAGS': '0x0', 09:21:44 INFO - 'XPC_SERVICE_NAME': '0', 09:21:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:44 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)) 09:21:44 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)) 09:21:44 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)) 09:21:44 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)) 09:21:44 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)) 09:21:44 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)) 09:21:44 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)) 09:21:44 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)) 09:21:44 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)) 09:21:44 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)) 09:21:44 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)) 09:21:44 INFO - Cleaning up... 09:21:44 INFO - Return code: 0 09:21:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:21:44 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')]} 09:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:44 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')]} 09:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:44 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 0x10104c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe298466350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e60d30>, '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 0x100cc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e58b20>, '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.qRmIFeLvZh/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.DFORNh0xr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 09:21:44 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 09:21:44 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 09:21:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRmIFeLvZh/Render', 09:21:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:44 INFO - 'HOME': '/Users/cltbld', 09:21:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:44 INFO - 'LOGNAME': 'cltbld', 09:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:44 INFO - 'MOZ_NO_REMOTE': '1', 09:21:44 INFO - 'NO_EM_RESTART': '1', 09:21:44 INFO - 'PAGER': '/bin/cat', 09:21:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:44 INFO - 'PWD': '/builds/slave/test', 09:21:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:44 INFO - 'SHELL': '/bin/bash', 09:21:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFORNh0xr8/Listeners', 09:21:44 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:21:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:44 INFO - 'USER': 'cltbld', 09:21:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:44 INFO - 'XPC_FLAGS': '0x0', 09:21:44 INFO - 'XPC_SERVICE_NAME': '0', 09:21:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:21:45 INFO - Cleaning up... 09:21:45 INFO - Return code: 0 09:21:45 INFO - Running post-action listener: _resource_record_post_action 09:21:45 INFO - Running post-action listener: _start_resource_monitoring 09:21:45 INFO - Starting resource monitoring. 09:21:45 INFO - [mozharness: 2016-10-28 16:21:45.184419Z] Finished create-virtualenv step (success) 09:21:45 INFO - [mozharness: 2016-10-28 16:21:45.185381Z] Running install step. 09:21:45 INFO - Running pre-action listener: _resource_record_pre_action 09:21:45 INFO - Running main action method: install 09:21:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:45 INFO - Reading from file tmpfile_stdout 09:21:45 INFO - Detecting whether we're running mozinstall >=1.0... 09:21:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:21:45 INFO - Reading from file tmpfile_stdout 09:21:45 INFO - Output received: 09:21:45 INFO - Usage: mozinstall [options] installer 09:21:45 INFO - Options: 09:21:45 INFO - -h, --help show this help message and exit 09:21:45 INFO - -d DEST, --destination=DEST 09:21:45 INFO - Directory to install application into. [default: 09:21:45 INFO - "/builds/slave/test"] 09:21:45 INFO - --app=APP Application being installed. [default: firefox] 09:21:45 INFO - mkdir: /builds/slave/test/build/application 09:21:45 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'] 09:21:45 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 09:22:17 INFO - Reading from file tmpfile_stdout 09:22:17 INFO - Output received: 09:22:17 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:22:17 INFO - Running post-action listener: _resource_record_post_action 09:22:17 INFO - [mozharness: 2016-10-28 16:22:17.717995Z] Finished install step (success) 09:22:17 INFO - [mozharness: 2016-10-28 16:22:17.718156Z] Running run-tests step. 09:22:17 INFO - Running pre-action listener: _resource_record_pre_action 09:22:17 INFO - Running main action method: run_tests 09:22:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:22:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:22:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:22:17 INFO - 2016-10-28 09:22:17.732 screenresolution[1637:7663] starting screenresolution argv=screenresolution get 09:22:17 INFO - 2016-10-28 09:22:17.735 screenresolution[1637:7663] Display 0: 1600x1200x32@60 09:22:17 INFO - 2016-10-28 09:22:17.741 screenresolution[1638:7666] starting screenresolution argv=screenresolution list 09:22:17 INFO - Available Modes on Display 0 09:22:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:22:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:22:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:22:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:22:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:22:17 INFO - Intel Iris: 09:22:17 INFO - Chipset Model: Intel Iris 09:22:17 INFO - Type: GPU 09:22:17 INFO - Bus: Built-In 09:22:17 INFO - VRAM (Dynamic, Max): 1536 MB 09:22:17 INFO - Vendor: Intel (0x8086) 09:22:17 INFO - Device ID: 0x0a2e 09:22:17 INFO - Revision ID: 0x0009 09:22:17 INFO - Displays: 09:22:17 INFO - Display: 09:22:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:22:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:22:17 INFO - Display Serial Number: 1600x1200 60 09:22:17 INFO - Main Display: Yes 09:22:17 INFO - Mirror: Off 09:22:17 INFO - Online: Yes 09:22:17 INFO - Rotation: Supported 09:22:17 INFO - Return code: 0 09:22:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:22:17 INFO - Python 2.7.3 09:22:17 INFO - Return code: 0 09:22:17 INFO - grabbing minidump binary from tooltool 09:22:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:17 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 0x100e60d30>, '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 0x100cc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e58b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:22:17 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 09:22:17 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 09:22:17 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 09:22:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:22:18 INFO - Return code: 0 09:22:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:22:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:22:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:22:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:22:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:22:18 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/Rs63FGYFQvaxNHf9B7dgxg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0138', '--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 09:22:18 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/Rs63FGYFQvaxNHf9B7dgxg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0138 --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 09:22:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qRmIFeLvZh/Render', 09:22:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:22:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:22:18 INFO - 'HOME': '/Users/cltbld', 09:22:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:22:18 INFO - 'LOGNAME': 'cltbld', 09:22:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:22:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:18 INFO - 'MOZ_NO_REMOTE': '1', 09:22:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:22:18 INFO - 'NO_EM_RESTART': '1', 09:22:18 INFO - 'PAGER': '/bin/cat', 09:22:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:18 INFO - 'PWD': '/builds/slave/test', 09:22:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:22:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:22:18 INFO - 'SHELL': '/bin/bash', 09:22:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DFORNh0xr8/Listeners', 09:22:18 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 09:22:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:22:18 INFO - 'USER': 'cltbld', 09:22:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:22:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:18 INFO - 'XPC_FLAGS': '0x0', 09:22:18 INFO - 'XPC_SERVICE_NAME': '0', 09:22:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:22:18 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/Rs63FGYFQvaxNHf9B7dgxg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0138', '--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 09:22:18 INFO - mozversion application_buildid: 20161028073158 09:22:18 INFO - mozversion application_changeset: 059c6aa6f3fd9154ed065d915a69928df8a2a40b 09:22:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:22:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:22:18 INFO - mozversion application_name: Firefox 09:22:18 INFO - mozversion application_remotingname: firefox-dev 09:22:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:22:18 INFO - mozversion application_vendor: Mozilla 09:22:18 INFO - mozversion application_version: 51.0a2 09:22:18 INFO - mozversion platform_buildid: 20161028073158 09:22:18 INFO - mozversion platform_changeset: 059c6aa6f3fd9154ed065d915a69928df8a2a40b 09:22:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:22:18 INFO - mozversion platform_version: 51.0a2 09:22:18 INFO - using testdate: 1477671738 09:22:18 INFO - actual date: 1477671738 09:22:18 INFO - starting webserver on 'localhost:49272' 09:22:18 INFO - SUITE-START | Running 2 tests 09:22:18 INFO - TEST-START | dromaeo_css 09:22:18 INFO - operating with platform_type : mac_ 09:22:18 INFO - Initialising browser for dromaeo_css test... 09:22:18 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpGg7O_O/profile http://localhost:49272/getInfo.html) 09:22:20 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 09:22:20 INFO - PROCESS | 1648 | colorDepth:24 09:22:20 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 09:22:20 INFO - PROCESS | 1648 | __metrics 09:22:21 INFO - PROCESS | 1648 | 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" 09:22:21 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:22:21 INFO - TEST-INFO | 1648: exit 0 09:22:21 INFO - Browser initialized. 09:22:21 INFO - Running cycle 1/1 for dromaeo_css test... 09:22:21 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpGg7O_O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:22:33 INFO - PROCESS | 1650 | RSS: Main: 219906048 09:22:33 INFO - PROCESS | 1650 | 09:23:24 INFO - PROCESS | 1650 | 1477671804885 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] 09:25:36 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 09:25:38 INFO - PROCESS | 1650 | RSS: Main: 369614848 09:25:38 INFO - PROCESS | 1650 | 09:28:41 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 09:28:42 INFO - PROCESS | 1650 | RSS: Main: 350216192 09:28:42 INFO - PROCESS | 1650 | 09:31:44 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 09:31:44 INFO - PROCESS | 1650 | RSS: Main: 320815104 09:31:44 INFO - PROCESS | 1650 | 09:34:47 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 09:34:47 INFO - PROCESS | 1650 | RSS: Main: 341778432 09:34:47 INFO - PROCESS | 1650 | 09:37:51 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 09:37:51 INFO - PROCESS | 1650 | RSS: Main: 312139776 09:37:51 INFO - PROCESS | 1650 | 09:40:54 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 09:40:55 INFO - PROCESS | 1650 | RSS: Main: 440864768 09:40:55 INFO - PROCESS | 1650 | 09:40:55 INFO - PROCESS | 1650 | __start_tp_report 09:40:55 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 09:40:55 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 09:40:55 INFO - PROCESS | 1650 | |i|pagename|runs| 09:40:55 INFO - PROCESS | 1650 | |0;dojo.html;3314.1880239341363;3322.485014822702;3359.1434184283003;3382.1206486313567;3393.151712071982;5601.103823388259;5687.971560142204;5696.743646535905;5702.515286200678;5706.429357064297;5637.718114094299;5693.743781529831;5724.484796368326;5724.971375143129;5725;5174.249733788598;5185.766640501177;5195.610329225323;5241.449647786984;5269.8155564555245;5137.998090372379;5159.7678104485385;5306.628536002481;5314.096603577382;5346.572274218072;5121.692698438087;5187.325647665798;5191.740412979355;5195.532402083812;5202.401723801754;5187.584993200554;5210.76551555181;5226.8693282667855;5276.076686579833;5276.3932147802725;5141.048905952411;5171.276021357013;5212.244224587452;5219.164933610604;5258.55302299305;5549.139883318052;5576.247206627135;5588.524975377098;5614.85962850932;5616.66300022;6141.516692814271;6173.81478555644;6187.412195841388;6207.658578778165;6208.87582248357;6260.248770147566;6340.080688300217;6356.555041147121;6366.267879193906;6367.6497792621385;5163.199704045879;5499;5642.689652069134;5692.544596432275;5808.2449281593545;4915.778789954461;6200.3799620037635;6319.273283572448;6327.209098862642;6375.840603984938;5752.654840709571;5917.881642367214;6159.476444502178;6181.96909015452;6193.938060619426;6126.172966649535;6143.051335359052;6146.832101900624;6158.753649853956;6294.8111556653375;6118.6782539406395;6238.344973777779;6244.594101383395;6250.15622890913;6259.530535209878;6189.071639254058;6270;6271.466925311308;6278.4035516625845;6289.0252010938375;4855.878603034882;4894;4938.333325001151;4959.727215003138;4976.427710813303;4417.757023363746;4433.268510695763;4433.955660443419;4438.977805110953;4457.5988161065015;4798.856034318976;5715.199872017921;5732.054211055212;5755.769769209269;5764.221830052973;6346.714397852108;6356.904646430307;6368.840778980562;6373.012183111625;6376.968115159488;5589.245451864028;5600.27196464457;5625.4374562544235;5645.915311270334;5698.715064246771;5356.384015838151;5372.489613486712;5384.273123128406;5394.217838413487;5433.701146436984;5607;6113.296970848321;6310.716017779211;6346.619202847844;6367.808965731036;6103.572749907464;6158.3841615838055;6333.303336633059;6337.271213810471;6340.9048864268;6222.844428889133;6279.120923070683;6286.27707813589;6305.274893387135;6318.115463835159;5187.429382767968;6178;6185.041318595625;6228.626282423069;6233.688315584293;6245.750169993331;6293.087502312231;6297.559170857996;6324.146240257691;6345.524085693499;5957.463828255478;5987.790427335022;5993.730282137401;6009.158717779427;6142.477889379453;6104.753717956914;6127.571070025056;6128.228138398679;6139.461473530676;6148.047052706837;5873.177755114202;5896.852578685395;5909.054551271776;5914.2311499504785;5939.940600594112;5057.924131138109;5253.369595648393;5963.165156878127;6057.273127224761;6126.969365153324;4950.480199578992;5883.911741323969;5956;6061.272647282354;6065.72704228302 09:40:55 INFO - PROCESS | 1650 | |1;ext.html;444.59319722453955;471.20836993850327;497.85313332566886;501.0555103629657;504.10772931910515;28008;31916.840415797888;31932.882349117786;31980.520292195608;39497.80251098748;41559.16881662365;42288;42306;42309.78845105778;42327;8446.83106337873;9882.802343953117;9887.209023278121;9893.505324733771;9893.554790034466;8810.471371717718;8975.910240897605;9724;9866.112049915506;9870.358426702278;10398.324108932895;11716.589919352824;11883.346415947119;12195.451204695766;12210;11971.94014029933;11987;12025.278483291031;12037;12039.398030098504;11680.357580333079;11770.470328835223;11772.705682357924;11776.528938842435;11784.646460606196;33460.330793384;39806.00484987869;39817.203655927005;39839;39848.80075599632;3413.5562376891094;3443.345764304774;3513.6837684608254;3560.43033114703;4006.9198616027807;30117.795288188667;31191.84404077965;31217.843910780302;31380;31638.36723265522;3172.984135079333;3182.80903145812;3244.626867910197;3250.6261779895376;3276.8197749123788;518064;519855;520968.9999999962;522052;522753;32435.51346729801;59923.400765991784;60252.39747602556;60327.69836150791;60392.69803650954;33570.32859342799;34857.302853942776;35044.47433288502;35105.82447087799;35152.76965306202;15065.397384104732;15220.771688424682;15236.390544378322;15245;15246.466373676869;12945.029122815826;13048;13050.021248406407;13054.54309099196;13081.869181308255;7174.3184397482155;7316;7323.7436689715605;7698.653560589675;7796.961015194887;3072.4008818280668;3099.5815564898903;3127.5152351385573;3180.3321302526265;3232;1003.8544411060501;1010.4038617215878;1028.8971102889652;1082.9224921203295;1093.5079214353573;29937.101886943427;30132.041417307806;30198.09405717832;30519.847400762854;30779.538306925413;973.4889183178747;990.5839547390113;1028.876534815827;1040.661784919904;1149.9880105507268;14908.329125189393;15331.463398781212;15364;15595.610109747347;15610.45363412275;702629;709470;710470;710604;711430;56911.430885690614;57293.42706572881;57318.426815731305;57336.853262934506;57467.71266143726;1165.196014749803;1166.6849950513483;1182.8817118288102;1212.678640160358;1367.2411811444745;27279.86360068187;29230.415391692473;30840.38319233558;31038.68961310358;31719.682803171672;48378.274325885846;48864;48945.51054489552;49023.754881225366;49036.509634903196;470803;473260;473515;473517;473643;26388.604170937066;26770;26882.865585671945;27079.72920270772;27085.1874443767;45980.54019459763;46595;46913.29630055484;47021;47100.29349559828;37896.01183443772;38426.42360364541;38664.42003369895;39336.803315983234;39996.600034000454;34863.47704784481;38308.425373619975;38672.22655546817;39457.40813887851;41300.793496032325;37498.25003499969;37963.810180948916;38011;38065.61934380621;38507.6149238504;32676;34044.97865064052;34923.47614785729;35004.249787510016;35031.7738879138;21622.027008784327;22048.33854984353;22116.889415552818;22135;22287.219947301768 09:40:55 INFO - PROCESS | 1650 | |2;jquery.html;353.09079121262755;373.3280095827511;379.1866446472317;386.07534953785694;404.77332693691534;15241;15642.452514162007;19581.902090489562;20630;20990.89504552479;19503.512412189702;19592.51018724529;20016.49958751032;20161.697574536392;20294.391168264974;5688.744006519696;6018.909716354258;6027.517798576104;6036.39636036395;6044.063170208625;3348.280119774248;3369.460886258199;3903.1998440319667;4375.409319741826;5859.209006784072;6583.9012414813815;6591.5715478493985;6686.331366863324;6687.866242675143;6711.161104861892;6421.8715625687455;6621.635810030446;6681.365270299314;6683.298253683366;6689.8662026759675;5723.599348045638;5771.047777116771;5782.624129431573;5795.681237531934;5797.797077102324;24638.753612463825;25229.36926576832;25249.873750631312;25260;25630.487390252278;2283.372072680026;2300.505391340853;2324.1284518305633;2333.556624241389;2390.521895620883;13664.93167534156;14924.701505969928;15009.7748533771;15025.549233522903;15318.540443786704;1814.5846239932873;1850.2783914273443;1947.191915355126;1956.4228552577024;2011.265887950902;125889;130275.34862325722;133518;133801;135491;9205.263578913671;10276.280660353703;11088.55645774176;11214.607488737855;11483.42582870853;13053.738925221442;13268.203907765565;13271.203727776172;13281.339832520935;13763.793543096861;7481.438892083115;8391.664333426717;8509.404341696021;8519.318454523624;8597.613107410181;8274.338052955749;8534.01858786235;8555.358348123915;8699.521526315986;8742;4291.377750226262;4360.934585981213;4392.604665580113;4424.292113261863;4482.618977386894;1614.6286354138615;1870.6165236126833;1896.2509808625791;1904.114586717183;1913.158210387425;785.8780695253432;869.5000374784524;889.2441424788877;908.9681861134961;926.7266156483853;16690.666186676197;20197.697034544493;20750.377488675364;20782.79217207839;20881.89559052195;850.8128211793396;920.3511524375299;935.3686261773275;946.4652471353663;974.6004138303404;10159.52686860401;10871.782564348669;10911.290766100177;10945.124390048937;10959.862826748868;523369;613797.862021383;614016.6495837551;616050;619753;76250.85623715649;78482.21517784863;126376;129205;132470.67529324777;924.1728652855656;959.7312752429331;966.9033096690275;1006.5219020964983;1013.0629168019552;11741.76516469683;17877.28490860403;18252.543686407946;18821.153048112596;18847.717284241022;53043.408697737585;54577.181342280695;54813.518648134865;55988;57022;77454;78748;80176.79734803866;80442.59778701303;82466;7867.763967080997;7872.252136047066;8011.919880801117;8012.038555373392;8037.477563958324;12059.577914773292;12247.938760306142;12479.812802807783;12547.3098979557;12620;9725.173360264456;10377.221708371751;10764.784704306026;10812.945935270587;11093.278936869077;10659.89340106589;10668.679939601825;10714.624988125379;10840.295380800222;11027.558897644005;10726.624568140078;10860.348379097279;10888.346699198073;10895.564177432814;11231.775364492827;7772.7668169954995;7914.485558438683;8011.519308841488;8016.719414820686;8194.262516373556;10611.469426528489;10635.627753028606;10894.61868834587;10941.398223097805;10956.616518421817 09:40:55 INFO - PROCESS | 1650 | |3;mootools.html;1306.9019823513236;1540.1144342003347;1675.7151284281672;1852.8610354223435;1885.4532185666158;8601.741947741562;9037.322200834938;9054.773630659236;9066.773330666736;9087.77280567986;7953.204679532044;8165.795855103625;8176.345892328614;8251.95874020629;8825.205731484166;2096.413004358782;2135.8825264610477;2309.0648287443614;2376.1089591403224;2394.006487307774;2367.348979030763;2372.466195106096;2375.95248095038;2376.1564644551195;2376.4296568823443;2328.6390609455475;2382.7140743110763;2383.0825132324007;2386.2960426674085;2392.808575313971;2340.2277248507953;2349.400902769791;2363.1492662641435;2368.4197371643886;2369.7748713872156;2336.6027775278244;2359.7640235976437;2360.6695062691238;2377.2036367816804;2377.322463098009;8749.300055995569;8862.335324850663;8869;8881.467111973237;8895.73312800617;5273.3935597406025;5436.21174929633;5438.048341540215;5447.591430642718;5454.645448045864;3456.5333679953387;3556;3625.5649322081517;3630.3283892479976;3636.4363523653874;1025.733219473949;1067.4235912607182;1086.4459125845797;1089.2484185911696;1094.8686157661052;11782.587609433715;11828.467718952581;11850.64448066568;11867.643970680894;11886.989605883511;4486.528914463935;4646.4888862225125;4814.759262036884;4821.397325334333;4833.468318484964;10034.297599168134;10040.748981275381;10054.69835904924;10064.39613623185;10074;5380.461953804666;5385.246065550826;5386.192071189353;5389.407165211824;5400.270963419966;4765.451973023078;4867.318575399447;4882.658213925062;4907.2393778964315;4915.139850526144;3579.49887015818;3710.07248187953;3816.2939856126704;3896.941545876814;3898.3957486589625;1063.9361638301727;1171.7949358862336;1179.687382843547;1180.4451907603413;1188.8097904335266;770.8573913825848;874.9875286840241;904.895936967244;920.3419555018061;925.6019911438146;5747.971260143756;5757.625754325955;5863.120531920161;6111.633302001894;6137.447629713347;891.31814162166;968.1190116993503;972.0813830929703;973.5424350555228;1012.5392946209604;3842.8462861485787;3953.9802300988886;3959.148783011609;4025.396190571379;4073.653739432122;10452.477376131163;10859.83710244347;10869.076128529005;10873.619423320146;10876.184286178568;10766.300190487593;10800.351978881292;10805.83791243132;10806.945965270123;10833.241673082808;8092.757217283491;8214.383921205934;8240.62917168717;8244.958775206085;8266.462679925906;5803.506701930214;5841.386654401396;5976.850578735566;6069;6139.6009259398;9801.852972205565;9888.703338899844;10172.440515771408;10178.440185789852;10200.591976320864;10327.225458090523;10385.584576616851;10389.168866490814;10398.636047738293;10402.843957340494;7539.509931854412;7719.459637825523;7735.110462296908;7749.806254843674;7778;7378.889316660147;8071.717489887826;8293.377996650395;8417.28453081495;8544.658213671384;7449.962750186214;7500.887486687813;7525.661345239368;7585.0139481867;7589.468737188344;7389.445791565547;7444.73943411978;7461.365783908429;7467.701291948261;7496.812579685551;6952.965235173791;7015.263397343206;7110.1112360954885;7113.715451382094;7134.964325178341;5040.16837221869;5046.949530504795;5062.594992400525;5109.97800439921;5110.66780659256;4908;5018.774155162953;5070.771815268396;5126.026055049529;5219.1388420910125 09:40:55 INFO - PROCESS | 1650 | |4;prototype.html;261.44443058500684;269.4960424007107;269.5337066874308;295.8298978087599;309.71042075659244;4960.454350021495;5021.397432308119;5092.77082531286;5335.799445124845;5425.267588875506;4320.546342634026;5076.416212135606;5083.161278389061;5108.667936584119;5220.590440581041;4048.9835072870605;4058.533268674096;4063.0654949361665;4067.983004248938;4085.182963407323;3935.488386509764;3942.645161935425;4088.8160032798596;4112.670986321102;4124.298869192245;4009.338459154251;4033.616806403402;4039.333509970851;4059.7158198926086;4083.2854250506193;3845.4808600839087;3997.520297564282;4011.9799401002956;4033.757974521509;4040.1717647882115;3531.7351198659944;3538.150843797496;3542.982285088584;3543.6279190684863;3546.66306700863;4784.545468180518;4806.903861922777;5067.442581316052;5131.563817075553;5210.583153347723;4623.861284161447;4632.86101416958;4635.374224479686;4642.419697537808;4659;4606.733148384188;5467.289252397163;5530.644991976991;5558.388577256539;5577.721113944327;3491.0050635568996;3736.7384283100196;3746.363118269873;3925.7241396546237;3941.1329507508303;5804.2744656917885;5815.389384114692;5823.708814559255;5825.825225243249;5837.708114594253;3970.3250447424007;3979.2240513100246;3981.869699710641;3984.7011474139554;3993.3610622300293;3389.7627166098628;3851.2490064437166;3998.100427403869;4040.8585699500377;4063.5326937401987;4589.5639914208095;4600.332951721982;4602.4477062752685;4654.69592551689;4703.894584772575;4743.644226683013;5467.343918729698;5646.915296270559;5655.953648575027;5714.628549144292;1246.9625911222497;1280.7694614969396;1320.2870449957109;1346.5860846111739;1389.9166050037031;807.4186585658316;845.9915400846036;855.7047818502607;861.1001503428931;880.5949263338807;3697.131174174067;3867.883963481044;3954.406838974119;4345.34819777036;4518.938049558351;4065.9390109148385;4530.50822047879;4763.711900291651;4789.568938795455;4850.405033307164;4704.482506924235;4913.1893237615395;4996.225585034325;5173.8439551873325;5406.486383793534;2535.619657051457;2808.2838876086466;3045.822237100484;3059.3422414180613;3062.1579065757096;5693.405846363025;6010.819675409744;6097.725602347905;6126.23422072241;6144.754209831557;4861.173600487926;4901.975490122598;5926.851828704317;5929.555283353766;5953.702314884238;5357.999520268662;5360.571154307646;6028.788992385245;6064.181335519648;6066.574355026565;5096.668716533413;5383.569314454912;5494.670319780826;5826.746475073135;5848.385919478564;5751.482366587027;5754.913676294943;5757.251557297524;5797.188393624811;5864.912026319694;5729.54163666914;5939.940600593939;6057.333693293822;6089.086637004485;6101.847453813512;3853.2871418787613;3884.533855937306;3885.3977633466857;3888.1640447303967;3891.7698310401734;5049;5078.314427552233;5789.7998760470755;5793.102069179284;5800.738966746591;4492.573205545468;5464.180372943932;5610.747516361692;5648.350439699487;5657.9151312731165;4873.415190177201;5033.2701758245585;5615.859603509945;5703.287089113861;5710.115661831669;5232.26748255237;5276.604254680838;5492.780288788404;5576.442355764391;5597.776088956396;4804.927926081042;5655.321361436654;5681.0910254359105;5683;5719.914201287067;4508.729476231306;4593.724376537419;5456.972715136399;5558.749856256397;5609.74756135983 09:40:55 INFO - PROCESS | 1650 | |5;yui.html;776;796.358931060496;798.6006996501749;799.9960000199998;813.0365516862522;12080.758384832308;15939.282732277046;15953.521394358158;15988.880778345521;15992.600184995381;14030.228337441436;14409.135451872895;14634.195119268463;14911.105333679987;14927.402903883858;662.5660192573848;833.912439193885;844.1474111147754;844.6030365728097;845.8773477845708;672.8149758816315;682.4438082962395;817.9059408168077;835.3484282259817;844.2106630300658;878.4816957994782;879.577802654723;879.6041781198454;879.9780005499882;882.960266787996;693.7051753004953;875.7022612311813;875.8204568063563;876.8553188723853;878.3324673248313;523.3353640876104;524.3838489774499;524.5357858295398;524.5357858295436;637.6142433827561;14826.258687065603;15201.239938003166;15205;15205.163715995615;15218.01082929617;13658.931705341409;13770.24263665508;13939.721205575832;14019.43922243109;14106;12230.633081007583;12467.93766031164;12613.495460181583;12754.553590624377;12946.546870859569;4383.956160438387;4533.979854532737;4571.394365073032;4643.141018911479;4704.082703872747;112669;113168.43415782951;122270.38864805708;128370;133285;10652.201084918506;10862.945685271523;10984.441526401599;11162.274452160584;11332.490037948312;21293.46766330823;21443.57112857734;21566.676499852514;21624;21630.35108946734;7734.381249500027;7759.767206983686;7776.416768742254;7826.9433626459695;7922.841543169219;4285.528591854956;4301.182775272689;4301.440812694393;4361.890952726144;4457.598816106566;3393.253484233465;3513.5959364672876;3526.7354948378975;3527.0476971217627;3530.841112149908;580.3471095018105;628.3841835001632;711.6335087429977;712.1738783011785;714.4284572342106;530.8699368654627;614.4500671898626;615.9199304090439;673.71367168953;699.7515881861967;9084.8637270441;9240.95379523098;9557.665481708107;9749.512524373895;9779.217662586976;584.3455330030393;600.7747094839435;633.5944995203074;657.4871600151889;664.1100924760747;4479.977600111979;4744;4751.52484751529;4752.453467851172;4775.498572649891;136556;159504;165849;167911;172394;149359;150560.2471987633;151659;153664;154678.22660886848;88087;96430;101244;102330;105810.4709476463;7554.469252800373;8985;9669.323147379617;9682.273829462678;9894.554745036347;49430.75284623554;51504.74247628888;54828.35514934558;56683.86632267249;58646;80774.19225807901;93180.53409732907;93545.5322723382;96980.0301996971;97744;12977.156484828456;13064.608061758163;13178.011649126162;13182.143160694524;13431.395587198404;12482.313472759086;14389;14550.563483095524;14727.484538041117;15000.174990375634;11588.420578970849;11993.940030299793;13016.349182541024;13486;13949;11495.885041149815;13433.66415839612;13659.590212293648;14052.718945621235;14098.436062557794;13296.734065318833;13343.399547020214;13498.730025399633;13689.589312320646;14289.142651440947;10580.735481613021;10679.359238445719;10925.39910304909;11099.944500277446;11237.55049797999;10589.311694739818;11087.944560277147;11598.304101753922;11608.767824643628;11739.471723772622 09:40:55 INFO - PROCESS | 1650 | __end_tp_report 09:40:55 INFO - PROCESS | 1650 | __start_cc_report 09:40:55 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1523 09:40:55 INFO - PROCESS | 1650 | __end_cc_report 09:40:55 INFO - PROCESS | 1650 | __startTimestamp1477672855037__endTimestamp 09:40:55 INFO - PROCESS | 1650 | 09:40:55 INFO - PROCESS | 1650 | ------- Summary: start ------- 09:40:55 INFO - PROCESS | 1650 | Number of tests: 6 09:40:55 INFO - PROCESS | 1650 | 09:40:55 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5697.94 Median:5873.18 stddev:653.12 (11.1%) stddev-sans-first:627.78 09:40:55 INFO - PROCESS | 1650 | Values: 3314.2 3322.5 3359.1 3382.1 3393.2 5601.1 5688.0 5696.7 5702.5 5706.4 5637.7 5693.7 5724.5 5725.0 5725.0 5174.2 5185.8 5195.6 5241.4 5269.8 5138.0 5159.8 5306.6 5314.1 5346.6 5121.7 5187.3 5191.7 5195.5 5202.4 5187.6 5210.8 5226.9 5276.1 5276.4 5141.0 5171.3 5212.2 5219.2 5258.6 5549.1 5576.2 5588.5 5614.9 5616.7 6141.5 6173.8 6187.4 6207.7 6208.9 6260.2 6340.1 6356.6 6366.3 6367.6 5163.2 5499.0 5642.7 5692.5 5808.2 4915.8 6200.4 6319.3 6327.2 6375.8 5752.7 5917.9 6159.5 6182.0 6193.9 6126.2 6143.1 6146.8 6158.8 6294.8 6118.7 6238.3 6244.6 6250.2 6259.5 6189.1 6270.0 6271.5 6278.4 6289.0 4855.9 4894.0 4938.3 4959.7 4976.4 4417.8 4433.3 4434.0 4439.0 4457.6 4798.9 5715.2 5732.1 5755.8 5764.2 6346.7 6356.9 6368.8 6373.0 6377.0 5589.2 5600.3 5625.4 5645.9 5698.7 5356.4 5372.5 5384.3 5394.2 5433.7 5607.0 6113.3 6310.7 6346.6 6367.8 6103.6 6158.4 6333.3 6337.3 6340.9 6222.8 6279.1 6286.3 6305.3 6318.1 5187.4 6178.0 6185.0 6228.6 6233.7 6245.8 6293.1 6297.6 6324.1 6345.5 5957.5 5987.8 5993.7 6009.2 6142.5 6104.8 6127.6 6128.2 6139.5 6148.0 5873.2 5896.9 5909.1 5914.2 5939.9 5057.9 5253.4 5963.2 6057.3 6127.0 4950.5 5883.9 5956.0 6061.3 6065.7 09:40:55 INFO - PROCESS | 1650 | 09:40:55 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:68544.30 Median:34893.48 stddev:154609.22 (443.1%) stddev-sans-first:154958.39 09:40:55 INFO - PROCESS | 1650 | Values: 444.6 471.2 497.9 501.1 504.1 28008.0 31916.8 31932.9 31980.5 39497.8 41559.2 42288.0 42306.0 42309.8 42327.0 8446.8 9882.8 9887.2 9893.5 9893.6 8810.5 8975.9 9724.0 9866.1 9870.4 10398.3 11716.6 11883.3 12195.5 12210.0 11971.9 11987.0 12025.3 12037.0 12039.4 11680.4 11770.5 11772.7 11776.5 11784.6 33460.3 39806.0 39817.2 39839.0 39848.8 3413.6 3443.3 3513.7 3560.4 4006.9 30117.8 31191.8 31217.8 31380.0 31638.4 3173.0 3182.8 3244.6 3250.6 3276.8 518064.0 519855.0 520969.0 522052.0 522753.0 32435.5 59923.4 60252.4 60327.7 60392.7 33570.3 34857.3 35044.5 35105.8 35152.8 15065.4 15220.8 15236.4 15245.0 15246.5 12945.0 13048.0 13050.0 13054.5 13081.9 7174.3 7316.0 7323.7 7698.7 7797.0 3072.4 3099.6 3127.5 3180.3 3232.0 1003.9 1010.4 1028.9 1082.9 1093.5 29937.1 30132.0 30198.1 30519.8 30779.5 973.5 990.6 1028.9 1040.7 1150.0 14908.3 15331.5 15364.0 15595.6 15610.5 702629.0 709470.0 710470.0 710604.0 711430.0 56911.4 57293.4 57318.4 57336.9 57467.7 1165.2 1166.7 1182.9 1212.7 1367.2 27279.9 29230.4 30840.4 31038.7 31719.7 48378.3 48864.0 48945.5 49023.8 49036.5 470803.0 473260.0 473515.0 473517.0 473643.0 26388.6 26770.0 26882.9 27079.7 27085.2 45980.5 46595.0 46913.3 47021.0 47100.3 37896.0 38426.4 38664.4 39336.8 39996.6 34863.5 38308.4 38672.2 39457.4 41300.8 37498.3 37963.8 38011.0 38065.6 38507.6 32676.0 34045.0 34923.5 35004.2 35031.8 21622.0 22048.3 22116.9 22135.0 22287.2 09:40:55 INFO - PROCESS | 1650 | 09:40:55 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:34827.87 Median:25254.94 stddev:99947.53 (395.8%) stddev-sans-first:100194.39 09:40:55 INFO - PROCESS | 1650 | Values: 353.1 373.3 379.2 386.1 404.8 15241.0 15642.5 19581.9 20630.0 20990.9 19503.5 19592.5 20016.5 20161.7 20294.4 5688.7 6018.9 6027.5 6036.4 6044.1 3348.3 3369.5 3903.2 4375.4 5859.2 6583.9 6591.6 6686.3 6687.9 6711.2 6421.9 6621.6 6681.4 6683.3 6689.9 5723.6 5771.0 5782.6 5795.7 5797.8 24638.8 25229.4 25249.9 25260.0 25630.5 2283.4 2300.5 2324.1 2333.6 2390.5 13664.9 14924.7 15009.8 15025.5 15318.5 1814.6 1850.3 1947.2 1956.4 2011.3 125889.0 130275.3 133518.0 133801.0 135491.0 9205.3 10276.3 11088.6 11214.6 11483.4 13053.7 13268.2 13271.2 13281.3 13763.8 7481.4 8391.7 8509.4 8519.3 8597.6 8274.3 8534.0 8555.4 8699.5 8742.0 4291.4 4360.9 4392.6 4424.3 4482.6 1614.6 1870.6 1896.3 1904.1 1913.2 785.9 869.5 889.2 909.0 926.7 16690.7 20197.7 20750.4 20782.8 20881.9 850.8 920.4 935.4 946.5 974.6 10159.5 10871.8 10911.3 10945.1 10959.9 523369.0 613797.9 614016.6 616050.0 619753.0 76250.9 78482.2 126376.0 129205.0 132470.7 924.2 959.7 966.9 1006.5 1013.1 11741.8 17877.3 18252.5 18821.2 18847.7 53043.4 54577.2 54813.5 55988.0 57022.0 77454.0 78748.0 80176.8 80442.6 82466.0 7867.8 7872.3 8011.9 8012.0 8037.5 12059.6 12247.9 12479.8 12547.3 12620.0 9725.2 10377.2 10764.8 10812.9 11093.3 10659.9 10668.7 10714.6 10840.3 11027.6 10726.6 10860.3 10888.3 10895.6 11231.8 7772.8 7914.5 8011.5 8016.7 8194.3 10611.5 10635.6 10894.6 10941.4 10956.6 09:40:55 INFO - PROCESS | 1650 | 09:40:55 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5758.95 Median:4874.99 stddev:3240.49 (66.5%) stddev-sans-first:3232.31 09:40:55 INFO - PROCESS | 1650 | Values: 1306.9 1540.1 1675.7 1852.9 1885.5 8601.7 9037.3 9054.8 9066.8 9087.8 7953.2 8165.8 8176.3 8252.0 8825.2 2096.4 2135.9 2309.1 2376.1 2394.0 2367.3 2372.5 2376.0 2376.2 2376.4 2328.6 2382.7 2383.1 2386.3 2392.8 2340.2 2349.4 2363.1 2368.4 2369.8 2336.6 2359.8 2360.7 2377.2 2377.3 8749.3 8862.3 8869.0 8881.5 8895.7 5273.4 5436.2 5438.0 5447.6 5454.6 3456.5 3556.0 3625.6 3630.3 3636.4 1025.7 1067.4 1086.4 1089.2 1094.9 11782.6 11828.5 11850.6 11867.6 11887.0 4486.5 4646.5 4814.8 4821.4 4833.5 10034.3 10040.7 10054.7 10064.4 10074.0 5380.5 5385.2 5386.2 5389.4 5400.3 4765.5 4867.3 4882.7 4907.2 4915.1 3579.5 3710.1 3816.3 3896.9 3898.4 1063.9 1171.8 1179.7 1180.4 1188.8 770.9 875.0 904.9 920.3 925.6 5748.0 5757.6 5863.1 6111.6 6137.4 891.3 968.1 972.1 973.5 1012.5 3842.8 3954.0 3959.1 4025.4 4073.7 10452.5 10859.8 10869.1 10873.6 10876.2 10766.3 10800.4 10805.8 10806.9 10833.2 8092.8 8214.4 8240.6 8245.0 8266.5 5803.5 5841.4 5976.9 6069.0 6139.6 9801.9 9888.7 10172.4 10178.4 10200.6 10327.2 10385.6 10389.2 10398.6 10402.8 7539.5 7719.5 7735.1 7749.8 7778.0 7378.9 8071.7 8293.4 8417.3 8544.7 7450.0 7500.9 7525.7 7585.0 7589.5 7389.4 7444.7 7461.4 7467.7 7496.8 6953.0 7015.3 7110.1 7113.7 7135.0 5040.2 5046.9 5062.6 5110.0 5110.7 4908.0 5018.8 5070.8 5126.0 5219.1 09:40:55 INFO - PROCESS | 1650 | 09:40:55 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4505.92 Median:4867.29 stddev:1387.02 (28.5%) stddev-sans-first:1353.83 09:40:55 INFO - PROCESS | 1650 | Values: 261.4 269.5 269.5 295.8 309.7 4960.5 5021.4 5092.8 5335.8 5425.3 4320.5 5076.4 5083.2 5108.7 5220.6 4049.0 4058.5 4063.1 4068.0 4085.2 3935.5 3942.6 4088.8 4112.7 4124.3 4009.3 4033.6 4039.3 4059.7 4083.3 3845.5 3997.5 4012.0 4033.8 4040.2 3531.7 3538.2 3543.0 3543.6 3546.7 4784.5 4806.9 5067.4 5131.6 5210.6 4623.9 4632.9 4635.4 4642.4 4659.0 4606.7 5467.3 5530.6 5558.4 5577.7 3491.0 3736.7 3746.4 3925.7 3941.1 5804.3 5815.4 5823.7 5825.8 5837.7 3970.3 3979.2 3981.9 3984.7 3993.4 3389.8 3851.2 3998.1 4040.9 4063.5 4589.6 4600.3 4602.4 4654.7 4703.9 4743.6 5467.3 5646.9 5656.0 5714.6 1247.0 1280.8 1320.3 1346.6 1389.9 807.4 846.0 855.7 861.1 880.6 3697.1 3867.9 3954.4 4345.3 4518.9 4065.9 4530.5 4763.7 4789.6 4850.4 4704.5 4913.2 4996.2 5173.8 5406.5 2535.6 2808.3 3045.8 3059.3 3062.2 5693.4 6010.8 6097.7 6126.2 6144.8 4861.2 4902.0 5926.9 5929.6 5953.7 5358.0 5360.6 6028.8 6064.2 6066.6 5096.7 5383.6 5494.7 5826.7 5848.4 5751.5 5754.9 5757.3 5797.2 5864.9 5729.5 5939.9 6057.3 6089.1 6101.8 3853.3 3884.5 3885.4 3888.2 3891.8 5049.0 5078.3 5789.8 5793.1 5800.7 4492.6 5464.2 5610.7 5648.4 5657.9 4873.4 5033.3 5615.9 5703.3 5710.1 5232.3 5276.6 5492.8 5576.4 5597.8 4804.9 5655.3 5681.1 5683.0 5719.9 4508.7 4593.7 5457.0 5558.7 5609.7 09:40:55 INFO - PROCESS | 1650 | 09:40:55 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:25646.13 Median:3526.89 stddev:42503.42 (1205.1%) stddev-sans-first:42581.64 09:40:55 INFO - PROCESS | 1650 | Values: 776.0 796.4 798.6 800.0 813.0 12080.8 15939.3 15953.5 15988.9 15992.6 14030.2 14409.1 14634.2 14911.1 14927.4 662.6 833.9 844.1 844.6 845.9 672.8 682.4 817.9 835.3 844.2 878.5 879.6 879.6 880.0 883.0 693.7 875.7 875.8 876.9 878.3 523.3 524.4 524.5 524.5 637.6 14826.3 15201.2 15205.0 15205.2 15218.0 13658.9 13770.2 13939.7 14019.4 14106.0 12230.6 12467.9 12613.5 12754.6 12946.5 4384.0 4534.0 4571.4 4643.1 4704.1 112669.0 113168.4 122270.4 128370.0 133285.0 10652.2 10862.9 10984.4 11162.3 11332.5 21293.5 21443.6 21566.7 21624.0 21630.4 7734.4 7759.8 7776.4 7826.9 7922.8 4285.5 4301.2 4301.4 4361.9 4457.6 3393.3 3513.6 3526.7 3527.0 3530.8 580.3 628.4 711.6 712.2 714.4 530.9 614.5 615.9 673.7 699.8 9084.9 9241.0 9557.7 9749.5 9779.2 584.3 600.8 633.6 657.5 664.1 4480.0 4744.0 4751.5 4752.5 4775.5 136556.0 159504.0 165849.0 167911.0 172394.0 149359.0 150560.2 151659.0 153664.0 154678.2 88087.0 96430.0 101244.0 102330.0 105810.5 7554.5 8985.0 9669.3 9682.3 9894.6 49430.8 51504.7 54828.4 56683.9 58646.0 80774.2 93180.5 93545.5 96980.0 97744.0 12977.2 13064.6 13178.0 13182.1 13431.4 12482.3 14389.0 14550.6 14727.5 15000.2 11588.4 11993.9 13016.3 13486.0 13949.0 11495.9 13433.7 13659.6 14052.7 14098.4 13296.7 13343.4 13498.7 13689.6 14289.1 10580.7 10679.4 10925.4 11099.9 11237.6 10589.3 11087.9 11598.3 11608.8 11739.5 09:40:55 INFO - PROCESS | 1650 | -------- Summary: end -------- 09:40:55 INFO - PROCESS | 1650 | 09:40:55 INFO - TEST-INFO | 1650: exit 0 09:40:55 INFO - TEST-OK | dromaeo_css | took 1117307ms 09:40:55 INFO - TEST-START | kraken 09:40:55 INFO - operating with platform_type : mac_ 09:40:55 INFO - Initialising browser for kraken test... 09:40:55 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpDX_F05/profile http://localhost:49272/getInfo.html) 09:40:57 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 09:40:57 INFO - PROCESS | 1661 | colorDepth:24 09:40:57 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 09:40:57 INFO - PROCESS | 1661 | __metrics 09:40:58 INFO - PROCESS | 1661 | 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" 09:40:58 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:40:58 INFO - TEST-INFO | 1661: exit 0 09:40:58 INFO - Browser initialized. 09:40:58 INFO - Running cycle 1/1 for kraken test... 09:40:58 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpDX_F05/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:41:10 INFO - PROCESS | 1662 | RSS: Main: 219758592 09:41:10 INFO - PROCESS | 1662 | 09:41:13 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 09:41:14 INFO - PROCESS | 1662 | RSS: Main: 269443072 09:41:14 INFO - PROCESS | 1662 | 09:41:16 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 09:41:17 INFO - PROCESS | 1662 | RSS: Main: 280584192 09:41:17 INFO - PROCESS | 1662 | 09:41:20 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 09:41:21 INFO - PROCESS | 1662 | RSS: Main: 377139200 09:41:21 INFO - PROCESS | 1662 | 09:41:23 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 09:41:23 INFO - PROCESS | 1662 | RSS: Main: 279351296 09:41:23 INFO - PROCESS | 1662 | 09:41:25 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:41:26 INFO - PROCESS | 1662 | RSS: Main: 279842816 09:41:26 INFO - PROCESS | 1662 | 09:41:29 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 09:41:29 INFO - PROCESS | 1662 | RSS: Main: 317562880 09:41:29 INFO - PROCESS | 1662 | 09:41:32 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 09:41:33 INFO - PROCESS | 1662 | RSS: Main: 319303680 09:41:33 INFO - PROCESS | 1662 | 09:41:36 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 09:41:36 INFO - PROCESS | 1662 | RSS: Main: 317550592 09:41:36 INFO - PROCESS | 1662 | 09:41:38 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:41:38 INFO - PROCESS | 1662 | RSS: Main: 295370752 09:41:38 INFO - PROCESS | 1662 | 09:41:40 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:41:41 INFO - PROCESS | 1662 | RSS: Main: 297455616 09:41:41 INFO - PROCESS | 1662 | 09:41:43 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:41:44 INFO - PROCESS | 1662 | RSS: Main: 305471488 09:41:44 INFO - PROCESS | 1662 | 09:41:46 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:41:47 INFO - PROCESS | 1662 | RSS: Main: 311939072 09:41:47 INFO - PROCESS | 1662 | 09:41:50 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:41:51 INFO - PROCESS | 1662 | RSS: Main: 310181888 09:41:51 INFO - PROCESS | 1662 | 09:41:52 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 09:41:53 INFO - PROCESS | 1662 | RSS: Main: 353935360 09:41:53 INFO - PROCESS | 1662 | 09:41:53 INFO - PROCESS | 1662 | __start_tp_report 09:41:53 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 09:41:53 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 09:41:53 INFO - PROCESS | 1662 | |i|pagename|runs| 09:41:53 INFO - PROCESS | 1662 | |0;ai-astar;116;114;114;112;114;115;114;114;115;113 09:41:53 INFO - PROCESS | 1662 | |1;audio-beat-detection;142;109;110;144;110;112;131;132;143;105 09:41:53 INFO - PROCESS | 1662 | |2;audio-dft;182;186;183;183;184;181;184;183;183;182 09:41:53 INFO - PROCESS | 1662 | |3;audio-fft;81;58;59;89;61;59;58;59;82;59 09:41:53 INFO - PROCESS | 1662 | |4;audio-oscillator;84;70;95;70;69;68;92;68;68;92 09:41:53 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;90;87;91;88;91;86;82;129;133;88 09:41:53 INFO - PROCESS | 1662 | |6;imaging-darkroom;98;98;98;98;98;98;98;97;98;98 09:41:53 INFO - PROCESS | 1662 | |7;imaging-desaturate;85;86;85;87;84;86;84;95;81;83 09:41:53 INFO - PROCESS | 1662 | |8;json-parse-financial;55;53;55;52;56;57;57;57;58;57 09:41:53 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;70;69;73;72;72;68;69;69;69;69 09:41:53 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;85;84;83;83;82;82;82;85;81;84 09:41:53 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;139;139;146;148;140;135;139;143;246;152 09:41:53 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;166;164;159;165;166;164;166;165;161;172 09:41:53 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;67;68;66;66;67;67;66;65;67;66 09:41:53 INFO - PROCESS | 1662 | __end_tp_report 09:41:53 INFO - PROCESS | 1662 | __start_cc_report 09:41:53 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2040 09:41:53 INFO - PROCESS | 1662 | __end_cc_report 09:41:53 INFO - PROCESS | 1662 | __startTimestamp1477672913213__endTimestamp 09:41:53 INFO - PROCESS | 1662 | 09:41:53 INFO - PROCESS | 1662 | ------- Summary: start ------- 09:41:53 INFO - PROCESS | 1662 | Number of tests: 14 09:41:53 INFO - PROCESS | 1662 | 09:41:53 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:1.10 (1.0%) stddev-sans-first:0.93 09:41:53 INFO - PROCESS | 1662 | Values: 116.0 114.0 114.0 112.0 114.0 115.0 114.0 114.0 115.0 113.0 09:41:53 INFO - PROCESS | 1662 | 09:41:53 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:123.80 Median:131.50 stddev:16.05 (12.2%) stddev-sans-first:15.62 09:41:53 INFO - PROCESS | 1662 | Values: 142.0 109.0 110.0 144.0 110.0 112.0 131.0 132.0 143.0 105.0 09:41:53 INFO - PROCESS | 1662 | 09:41:53 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:183.10 Median:183.00 stddev:1.37 (0.7%) stddev-sans-first:1.39 09:41:53 INFO - PROCESS | 1662 | Values: 182.0 186.0 183.0 183.0 184.0 181.0 184.0 183.0 183.0 182.0 09:41:53 INFO - PROCESS | 1662 | 09:41:53 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:66.50 Median:60.00 stddev:12.28 (20.5%) stddev-sans-first:11.85 09:41:53 INFO - PROCESS | 1662 | Values: 81.0 58.0 59.0 89.0 61.0 59.0 58.0 59.0 82.0 59.0 09:41:53 INFO - PROCESS | 1662 | 09:41:53 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:77.00 stddev:11.66 (15.1%) stddev-sans-first:12.14 09:41:53 INFO - PROCESS | 1662 | Values: 84.0 70.0 95.0 70.0 69.0 68.0 92.0 68.0 68.0 92.0 09:41:53 INFO - PROCESS | 1662 | 09:41:53 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:96.50 Median:88.00 stddev:18.40 (20.9%) stddev-sans-first:19.36 09:41:53 INFO - PROCESS | 1662 | Values: 90.0 87.0 91.0 88.0 91.0 86.0 82.0 129.0 133.0 88.0 09:41:53 INFO - PROCESS | 1662 | 09:41:53 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:97.90 Median:98.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:41:53 INFO - PROCESS | 1662 | Values: 98.0 98.0 98.0 98.0 98.0 98.0 98.0 97.0 98.0 98.0 09:41:53 INFO - PROCESS | 1662 | 09:41:53 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:85.50 stddev:3.72 (4.3%) stddev-sans-first:3.94 09:41:53 INFO - PROCESS | 1662 | Values: 85.0 86.0 85.0 87.0 84.0 86.0 84.0 95.0 81.0 83.0 09:41:53 INFO - PROCESS | 1662 | 09:41:53 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:57.00 stddev:1.95 (3.4%) stddev-sans-first:2.05 09:41:53 INFO - PROCESS | 1662 | Values: 55.0 53.0 55.0 52.0 56.0 57.0 57.0 57.0 58.0 57.0 09:41:53 INFO - PROCESS | 1662 | 09:41:53 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:69.50 stddev:1.70 (2.4%) stddev-sans-first:1.80 09:41:53 INFO - PROCESS | 1662 | Values: 70.0 69.0 73.0 72.0 72.0 68.0 69.0 69.0 69.0 69.0 09:41:53 INFO - PROCESS | 1662 | 09:41:53 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.50 stddev:1.37 (1.6%) stddev-sans-first:1.27 09:41:53 INFO - PROCESS | 1662 | Values: 85.0 84.0 83.0 83.0 82.0 82.0 82.0 85.0 81.0 84.0 09:41:53 INFO - PROCESS | 1662 | 09:41:53 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:152.70 Median:144.50 stddev:33.17 (23.0%) stddev-sans-first:34.81 09:41:53 INFO - PROCESS | 1662 | Values: 139.0 139.0 146.0 148.0 140.0 135.0 139.0 143.0 246.0 152.0 09:41:53 INFO - PROCESS | 1662 | 09:41:53 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:165.50 stddev:3.43 (2.1%) stddev-sans-first:3.61 09:41:53 INFO - PROCESS | 1662 | Values: 166.0 164.0 159.0 165.0 166.0 164.0 166.0 165.0 161.0 172.0 09:41:53 INFO - PROCESS | 1662 | 09:41:53 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 09:41:53 INFO - PROCESS | 1662 | Values: 67.0 68.0 66.0 66.0 67.0 67.0 66.0 65.0 67.0 66.0 09:41:53 INFO - PROCESS | 1662 | -------- Summary: end -------- 09:41:53 INFO - PROCESS | 1662 | 09:41:53 INFO - TEST-INFO | 1662: exit 0 09:41:54 INFO - TEST-OK | kraken | took 58402ms 09:41:54 INFO - SUITE-END | took 1175s 09:41:54 INFO - Completed test suite (00:19:36) 09:41:54 INFO - javascript benchmark 09:41:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3314.1880239341363, 3322.485014822702, 3359.1434184283003, 3382.1206486313567, 3393.151712071982, 5601.103823388259, 5687.971560142204, 5696.743646535905, 5702.515286200678, 5706.429357064297, 5637.718114094299, 5693.743781529831, 5724.484796368326, 5724.971375143129, 5725.0, 5174.249733788598, 5185.766640501177, 5195.610329225323, 5241.449647786984, 5269.8155564555245, 5137.998090372379, 5159.7678104485385, 5306.628536002481, 5314.096603577382, 5346.572274218072, 5121.692698438087, 5187.325647665798, 5191.740412979355, 5195.532402083812, 5202.401723801754, 5187.584993200554, 5210.76551555181, 5226.8693282667855, 5276.076686579833, 5276.3932147802725, 5141.048905952411, 5171.276021357013, 5212.244224587452, 5219.164933610604, 5258.55302299305, 5549.139883318052, 5576.247206627135, 5588.524975377098, 5614.85962850932, 5616.66300022, 6141.516692814271, 6173.81478555644, 6187.412195841388, 6207.658578778165, 6208.87582248357, 6260.248770147566, 6340.080688300217, 6356.555041147121, 6366.267879193906, 6367.6497792621385, 5163.199704045879, 5499.0, 5642.689652069134, 5692.544596432275, 5808.2449281593545, 4915.778789954461, 6200.3799620037635, 6319.273283572448, 6327.209098862642, 6375.840603984938, 5752.654840709571, 5917.881642367214, 6159.476444502178, 6181.96909015452, 6193.938060619426, 6126.172966649535, 6143.051335359052, 6146.832101900624, 6158.753649853956, 6294.8111556653375, 6118.6782539406395, 6238.344973777779, 6244.594101383395, 6250.15622890913, 6259.530535209878, 6189.071639254058, 6270.0, 6271.466925311308, 6278.4035516625845, 6289.0252010938375, 4855.878603034882, 4894.0, 4938.333325001151, 4959.727215003138, 4976.427710813303, 4417.757023363746, 4433.268510695763, 4433.955660443419, 4438.977805110953, 4457.5988161065015, 4798.856034318976, 5715.199872017921, 5732.054211055212, 5755.769769209269, 5764.221830052973, 6346.714397852108, 6356.904646430307, 6368.840778980562, 6373.012183111625, 6376.968115159488, 5589.245451864028, 5600.27196464457, 5625.4374562544235, 5645.915311270334, 5698.715064246771, 5356.384015838151, 5372.489613486712, 5384.273123128406, 5394.217838413487, 5433.701146436984, 5607.0, 6113.296970848321, 6310.716017779211, 6346.619202847844, 6367.808965731036, 6103.572749907464, 6158.3841615838055, 6333.303336633059, 6337.271213810471, 6340.9048864268, 6222.844428889133, 6279.120923070683, 6286.27707813589, 6305.274893387135, 6318.115463835159, 5187.429382767968, 6178.0, 6185.041318595625, 6228.626282423069, 6233.688315584293, 6245.750169993331, 6293.087502312231, 6297.559170857996, 6324.146240257691, 6345.524085693499, 5957.463828255478, 5987.790427335022, 5993.730282137401, 6009.158717779427, 6142.477889379453, 6104.753717956914, 6127.571070025056, 6128.228138398679, 6139.461473530676, 6148.047052706837, 5873.177755114202, 5896.852578685395, 5909.054551271776, 5914.2311499504785, 5939.940600594112, 5057.924131138109, 5253.369595648393, 5963.165156878127, 6057.273127224761, 6126.969365153324, 4950.480199578992, 5883.911741323969, 5956.0, 6061.272647282354, 6065.72704228302], "value": 5657.706768977323, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [444.59319722453955, 471.20836993850327, 497.85313332566886, 501.0555103629657, 504.10772931910515, 28008.0, 31916.840415797888, 31932.882349117786, 31980.520292195608, 39497.80251098748, 41559.16881662365, 42288.0, 42306.0, 42309.78845105778, 42327.0, 8446.83106337873, 9882.802343953117, 9887.209023278121, 9893.505324733771, 9893.554790034466, 8810.471371717718, 8975.910240897605, 9724.0, 9866.112049915506, 9870.358426702278, 10398.324108932895, 11716.589919352824, 11883.346415947119, 12195.451204695766, 12210.0, 11971.94014029933, 11987.0, 12025.278483291031, 12037.0, 12039.398030098504, 11680.357580333079, 11770.470328835223, 11772.705682357924, 11776.528938842435, 11784.646460606196, 33460.330793384, 39806.00484987869, 39817.203655927005, 39839.0, 39848.80075599632, 3413.5562376891094, 3443.345764304774, 3513.6837684608254, 3560.43033114703, 4006.9198616027807, 30117.795288188667, 31191.84404077965, 31217.843910780302, 31380.0, 31638.36723265522, 3172.984135079333, 3182.80903145812, 3244.626867910197, 3250.6261779895376, 3276.8197749123788, 518064.0, 519855.0, 520968.9999999962, 522052.0, 522753.0, 32435.51346729801, 59923.400765991784, 60252.39747602556, 60327.69836150791, 60392.69803650954, 33570.32859342799, 34857.302853942776, 35044.47433288502, 35105.82447087799, 35152.76965306202, 15065.397384104732, 15220.771688424682, 15236.390544378322, 15245.0, 15246.466373676869, 12945.029122815826, 13048.0, 13050.021248406407, 13054.54309099196, 13081.869181308255, 7174.3184397482155, 7316.0, 7323.7436689715605, 7698.653560589675, 7796.961015194887, 3072.4008818280668, 3099.5815564898903, 3127.5152351385573, 3180.3321302526265, 3232.0, 1003.8544411060501, 1010.4038617215878, 1028.8971102889652, 1082.9224921203295, 1093.5079214353573, 29937.101886943427, 30132.041417307806, 30198.09405717832, 30519.847400762854, 30779.538306925413, 973.4889183178747, 990.5839547390113, 1028.876534815827, 1040.661784919904, 1149.9880105507268, 14908.329125189393, 15331.463398781212, 15364.0, 15595.610109747347, 15610.45363412275, 702629.0, 709470.0, 710470.0, 710604.0, 711430.0, 56911.430885690614, 57293.42706572881, 57318.426815731305, 57336.853262934506, 57467.71266143726, 1165.196014749803, 1166.6849950513483, 1182.8817118288102, 1212.678640160358, 1367.2411811444745, 27279.86360068187, 29230.415391692473, 30840.38319233558, 31038.68961310358, 31719.682803171672, 48378.274325885846, 48864.0, 48945.51054489552, 49023.754881225366, 49036.509634903196, 470803.0, 473260.0, 473515.0, 473517.0, 473643.0, 26388.604170937066, 26770.0, 26882.865585671945, 27079.72920270772, 27085.1874443767, 45980.54019459763, 46595.0, 46913.29630055484, 47021.0, 47100.29349559828, 37896.01183443772, 38426.42360364541, 38664.42003369895, 39336.803315983234, 39996.600034000454, 34863.47704784481, 38308.425373619975, 38672.22655546817, 39457.40813887851, 41300.793496032325, 37498.25003499969, 37963.810180948916, 38011.0, 38065.61934380621, 38507.6149238504, 32676.0, 34044.97865064052, 34923.47614785729, 35004.249787510016, 35031.7738879138, 21622.027008784327, 22048.33854984353, 22116.889415552818, 22135.0, 22287.219947301768], "value": 18687.87424462679, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.09079121262755, 373.3280095827511, 379.1866446472317, 386.07534953785694, 404.77332693691534, 15241.0, 15642.452514162007, 19581.902090489562, 20630.0, 20990.89504552479, 19503.512412189702, 19592.51018724529, 20016.49958751032, 20161.697574536392, 20294.391168264974, 5688.744006519696, 6018.909716354258, 6027.517798576104, 6036.39636036395, 6044.063170208625, 3348.280119774248, 3369.460886258199, 3903.1998440319667, 4375.409319741826, 5859.209006784072, 6583.9012414813815, 6591.5715478493985, 6686.331366863324, 6687.866242675143, 6711.161104861892, 6421.8715625687455, 6621.635810030446, 6681.365270299314, 6683.298253683366, 6689.8662026759675, 5723.599348045638, 5771.047777116771, 5782.624129431573, 5795.681237531934, 5797.797077102324, 24638.753612463825, 25229.36926576832, 25249.873750631312, 25260.0, 25630.487390252278, 2283.372072680026, 2300.505391340853, 2324.1284518305633, 2333.556624241389, 2390.521895620883, 13664.93167534156, 14924.701505969928, 15009.7748533771, 15025.549233522903, 15318.540443786704, 1814.5846239932873, 1850.2783914273443, 1947.191915355126, 1956.4228552577024, 2011.265887950902, 125889.0, 130275.34862325722, 133518.0, 133801.0, 135491.0, 9205.263578913671, 10276.280660353703, 11088.55645774176, 11214.607488737855, 11483.42582870853, 13053.738925221442, 13268.203907765565, 13271.203727776172, 13281.339832520935, 13763.793543096861, 7481.438892083115, 8391.664333426717, 8509.404341696021, 8519.318454523624, 8597.613107410181, 8274.338052955749, 8534.01858786235, 8555.358348123915, 8699.521526315986, 8742.0, 4291.377750226262, 4360.934585981213, 4392.604665580113, 4424.292113261863, 4482.618977386894, 1614.6286354138615, 1870.6165236126833, 1896.2509808625791, 1904.114586717183, 1913.158210387425, 785.8780695253432, 869.5000374784524, 889.2441424788877, 908.9681861134961, 926.7266156483853, 16690.666186676197, 20197.697034544493, 20750.377488675364, 20782.79217207839, 20881.89559052195, 850.8128211793396, 920.3511524375299, 935.3686261773275, 946.4652471353663, 974.6004138303404, 10159.52686860401, 10871.782564348669, 10911.290766100177, 10945.124390048937, 10959.862826748868, 523369.0, 613797.862021383, 614016.6495837551, 616050.0, 619753.0, 76250.85623715649, 78482.21517784863, 126376.0, 129205.0, 132470.67529324777, 924.1728652855656, 959.7312752429331, 966.9033096690275, 1006.5219020964983, 1013.0629168019552, 11741.76516469683, 17877.28490860403, 18252.543686407946, 18821.153048112596, 18847.717284241022, 53043.408697737585, 54577.181342280695, 54813.518648134865, 55988.0, 57022.0, 77454.0, 78748.0, 80176.79734803866, 80442.59778701303, 82466.0, 7867.763967080997, 7872.252136047066, 8011.919880801117, 8012.038555373392, 8037.477563958324, 12059.577914773292, 12247.938760306142, 12479.812802807783, 12547.3098979557, 12620.0, 9725.173360264456, 10377.221708371751, 10764.784704306026, 10812.945935270587, 11093.278936869077, 10659.89340106589, 10668.679939601825, 10714.624988125379, 10840.295380800222, 11027.558897644005, 10726.624568140078, 10860.348379097279, 10888.346699198073, 10895.564177432814, 11231.775364492827, 7772.7668169954995, 7914.485558438683, 8011.519308841488, 8016.719414820686, 8194.262516373556, 10611.469426528489, 10635.627753028606, 10894.61868834587, 10941.398223097805, 10956.616518421817], "value": 9464.189647987414, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.9019823513236, 1540.1144342003347, 1675.7151284281672, 1852.8610354223435, 1885.4532185666158, 8601.741947741562, 9037.322200834938, 9054.773630659236, 9066.773330666736, 9087.77280567986, 7953.204679532044, 8165.795855103625, 8176.345892328614, 8251.95874020629, 8825.205731484166, 2096.413004358782, 2135.8825264610477, 2309.0648287443614, 2376.1089591403224, 2394.006487307774, 2367.348979030763, 2372.466195106096, 2375.95248095038, 2376.1564644551195, 2376.4296568823443, 2328.6390609455475, 2382.7140743110763, 2383.0825132324007, 2386.2960426674085, 2392.808575313971, 2340.2277248507953, 2349.400902769791, 2363.1492662641435, 2368.4197371643886, 2369.7748713872156, 2336.6027775278244, 2359.7640235976437, 2360.6695062691238, 2377.2036367816804, 2377.322463098009, 8749.300055995569, 8862.335324850663, 8869.0, 8881.467111973237, 8895.73312800617, 5273.3935597406025, 5436.21174929633, 5438.048341540215, 5447.591430642718, 5454.645448045864, 3456.5333679953387, 3556.0, 3625.5649322081517, 3630.3283892479976, 3636.4363523653874, 1025.733219473949, 1067.4235912607182, 1086.4459125845797, 1089.2484185911696, 1094.8686157661052, 11782.587609433715, 11828.467718952581, 11850.64448066568, 11867.643970680894, 11886.989605883511, 4486.528914463935, 4646.4888862225125, 4814.759262036884, 4821.397325334333, 4833.468318484964, 10034.297599168134, 10040.748981275381, 10054.69835904924, 10064.39613623185, 10074.0, 5380.461953804666, 5385.246065550826, 5386.192071189353, 5389.407165211824, 5400.270963419966, 4765.451973023078, 4867.318575399447, 4882.658213925062, 4907.2393778964315, 4915.139850526144, 3579.49887015818, 3710.07248187953, 3816.2939856126704, 3896.941545876814, 3898.3957486589625, 1063.9361638301727, 1171.7949358862336, 1179.687382843547, 1180.4451907603413, 1188.8097904335266, 770.8573913825848, 874.9875286840241, 904.895936967244, 920.3419555018061, 925.6019911438146, 5747.971260143756, 5757.625754325955, 5863.120531920161, 6111.633302001894, 6137.447629713347, 891.31814162166, 968.1190116993503, 972.0813830929703, 973.5424350555228, 1012.5392946209604, 3842.8462861485787, 3953.9802300988886, 3959.148783011609, 4025.396190571379, 4073.653739432122, 10452.477376131163, 10859.83710244347, 10869.076128529005, 10873.619423320146, 10876.184286178568, 10766.300190487593, 10800.351978881292, 10805.83791243132, 10806.945965270123, 10833.241673082808, 8092.757217283491, 8214.383921205934, 8240.62917168717, 8244.958775206085, 8266.462679925906, 5803.506701930214, 5841.386654401396, 5976.850578735566, 6069.0, 6139.6009259398, 9801.852972205565, 9888.703338899844, 10172.440515771408, 10178.440185789852, 10200.591976320864, 10327.225458090523, 10385.584576616851, 10389.168866490814, 10398.636047738293, 10402.843957340494, 7539.509931854412, 7719.459637825523, 7735.110462296908, 7749.806254843674, 7778.0, 7378.889316660147, 8071.717489887826, 8293.377996650395, 8417.28453081495, 8544.658213671384, 7449.962750186214, 7500.887486687813, 7525.661345239368, 7585.0139481867, 7589.468737188344, 7389.445791565547, 7444.73943411978, 7461.365783908429, 7467.701291948261, 7496.812579685551, 6952.965235173791, 7015.263397343206, 7110.1112360954885, 7113.715451382094, 7134.964325178341, 5040.16837221869, 5046.949530504795, 5062.594992400525, 5109.97800439921, 5110.66780659256, 4908.0, 5018.774155162953, 5070.771815268396, 5126.026055049529, 5219.1388420910125], "value": 4610.716244922029, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [261.44443058500684, 269.4960424007107, 269.5337066874308, 295.8298978087599, 309.71042075659244, 4960.454350021495, 5021.397432308119, 5092.77082531286, 5335.799445124845, 5425.267588875506, 4320.546342634026, 5076.416212135606, 5083.161278389061, 5108.667936584119, 5220.590440581041, 4048.9835072870605, 4058.533268674096, 4063.0654949361665, 4067.983004248938, 4085.182963407323, 3935.488386509764, 3942.645161935425, 4088.8160032798596, 4112.670986321102, 4124.298869192245, 4009.338459154251, 4033.616806403402, 4039.333509970851, 4059.7158198926086, 4083.2854250506193, 3845.4808600839087, 3997.520297564282, 4011.9799401002956, 4033.757974521509, 4040.1717647882115, 3531.7351198659944, 3538.150843797496, 3542.982285088584, 3543.6279190684863, 3546.66306700863, 4784.545468180518, 4806.903861922777, 5067.442581316052, 5131.563817075553, 5210.583153347723, 4623.861284161447, 4632.86101416958, 4635.374224479686, 4642.419697537808, 4659.0, 4606.733148384188, 5467.289252397163, 5530.644991976991, 5558.388577256539, 5577.721113944327, 3491.0050635568996, 3736.7384283100196, 3746.363118269873, 3925.7241396546237, 3941.1329507508303, 5804.2744656917885, 5815.389384114692, 5823.708814559255, 5825.825225243249, 5837.708114594253, 3970.3250447424007, 3979.2240513100246, 3981.869699710641, 3984.7011474139554, 3993.3610622300293, 3389.7627166098628, 3851.2490064437166, 3998.100427403869, 4040.8585699500377, 4063.5326937401987, 4589.5639914208095, 4600.332951721982, 4602.4477062752685, 4654.69592551689, 4703.894584772575, 4743.644226683013, 5467.343918729698, 5646.915296270559, 5655.953648575027, 5714.628549144292, 1246.9625911222497, 1280.7694614969396, 1320.2870449957109, 1346.5860846111739, 1389.9166050037031, 807.4186585658316, 845.9915400846036, 855.7047818502607, 861.1001503428931, 880.5949263338807, 3697.131174174067, 3867.883963481044, 3954.406838974119, 4345.34819777036, 4518.938049558351, 4065.9390109148385, 4530.50822047879, 4763.711900291651, 4789.568938795455, 4850.405033307164, 4704.482506924235, 4913.1893237615395, 4996.225585034325, 5173.8439551873325, 5406.486383793534, 2535.619657051457, 2808.2838876086466, 3045.822237100484, 3059.3422414180613, 3062.1579065757096, 5693.405846363025, 6010.819675409744, 6097.725602347905, 6126.23422072241, 6144.754209831557, 4861.173600487926, 4901.975490122598, 5926.851828704317, 5929.555283353766, 5953.702314884238, 5357.999520268662, 5360.571154307646, 6028.788992385245, 6064.181335519648, 6066.574355026565, 5096.668716533413, 5383.569314454912, 5494.670319780826, 5826.746475073135, 5848.385919478564, 5751.482366587027, 5754.913676294943, 5757.251557297524, 5797.188393624811, 5864.912026319694, 5729.54163666914, 5939.940600593939, 6057.333693293822, 6089.086637004485, 6101.847453813512, 3853.2871418787613, 3884.533855937306, 3885.3977633466857, 3888.1640447303967, 3891.7698310401734, 5049.0, 5078.314427552233, 5789.7998760470755, 5793.102069179284, 5800.738966746591, 4492.573205545468, 5464.180372943932, 5610.747516361692, 5648.350439699487, 5657.9151312731165, 4873.415190177201, 5033.2701758245585, 5615.859603509945, 5703.287089113861, 5710.115661831669, 5232.26748255237, 5276.604254680838, 5492.780288788404, 5576.442355764391, 5597.776088956396, 4804.927926081042, 5655.321361436654, 5681.0910254359105, 5683.0, 5719.914201287067, 4508.729476231306, 4593.724376537419, 5456.972715136399, 5558.749856256397, 5609.74756135983], "value": 4054.5551523518297, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.0, 796.358931060496, 798.6006996501749, 799.9960000199998, 813.0365516862522, 12080.758384832308, 15939.282732277046, 15953.521394358158, 15988.880778345521, 15992.600184995381, 14030.228337441436, 14409.135451872895, 14634.195119268463, 14911.105333679987, 14927.402903883858, 662.5660192573848, 833.912439193885, 844.1474111147754, 844.6030365728097, 845.8773477845708, 672.8149758816315, 682.4438082962395, 817.9059408168077, 835.3484282259817, 844.2106630300658, 878.4816957994782, 879.577802654723, 879.6041781198454, 879.9780005499882, 882.960266787996, 693.7051753004953, 875.7022612311813, 875.8204568063563, 876.8553188723853, 878.3324673248313, 523.3353640876104, 524.3838489774499, 524.5357858295398, 524.5357858295436, 637.6142433827561, 14826.258687065603, 15201.239938003166, 15205.0, 15205.163715995615, 15218.01082929617, 13658.931705341409, 13770.24263665508, 13939.721205575832, 14019.43922243109, 14106.0, 12230.633081007583, 12467.93766031164, 12613.495460181583, 12754.553590624377, 12946.546870859569, 4383.956160438387, 4533.979854532737, 4571.394365073032, 4643.141018911479, 4704.082703872747, 112669.0, 113168.43415782951, 122270.38864805708, 128370.0, 133285.0, 10652.201084918506, 10862.945685271523, 10984.441526401599, 11162.274452160584, 11332.490037948312, 21293.46766330823, 21443.57112857734, 21566.676499852514, 21624.0, 21630.35108946734, 7734.381249500027, 7759.767206983686, 7776.416768742254, 7826.9433626459695, 7922.841543169219, 4285.528591854956, 4301.182775272689, 4301.440812694393, 4361.890952726144, 4457.598816106566, 3393.253484233465, 3513.5959364672876, 3526.7354948378975, 3527.0476971217627, 3530.841112149908, 580.3471095018105, 628.3841835001632, 711.6335087429977, 712.1738783011785, 714.4284572342106, 530.8699368654627, 614.4500671898626, 615.9199304090439, 673.71367168953, 699.7515881861967, 9084.8637270441, 9240.95379523098, 9557.665481708107, 9749.512524373895, 9779.217662586976, 584.3455330030393, 600.7747094839435, 633.5944995203074, 657.4871600151889, 664.1100924760747, 4479.977600111979, 4744.0, 4751.52484751529, 4752.453467851172, 4775.498572649891, 136556.0, 159504.0, 165849.0, 167911.0, 172394.0, 149359.0, 150560.2471987633, 151659.0, 153664.0, 154678.22660886848, 88087.0, 96430.0, 101244.0, 102330.0, 105810.4709476463, 7554.469252800373, 8985.0, 9669.323147379617, 9682.273829462678, 9894.554745036347, 49430.75284623554, 51504.74247628888, 54828.35514934558, 56683.86632267249, 58646.0, 80774.19225807901, 93180.53409732907, 93545.5322723382, 96980.0301996971, 97744.0, 12977.156484828456, 13064.608061758163, 13178.011649126162, 13182.143160694524, 13431.395587198404, 12482.313472759086, 14389.0, 14550.563483095524, 14727.484538041117, 15000.174990375634, 11588.420578970849, 11993.940030299793, 13016.349182541024, 13486.0, 13949.0, 11495.885041149815, 13433.66415839612, 13659.590212293648, 14052.718945621235, 14098.436062557794, 13296.734065318833, 13343.399547020214, 13498.730025399633, 13689.589312320646, 14289.142651440947, 10580.735481613021, 10679.359238445719, 10925.39910304909, 11099.944500277446, 11237.55049797999, 10589.311694739818, 11087.944560277147, 11598.304101753922, 11608.767824643628, 11739.471723772622], "value": 7798.964350239244, "unit": "score"}], "name": "dromaeo_css", "value": 7255.700398879538, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 114.0, 112.0, 114.0, 115.0, 114.0, 114.0, 115.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 110.0, 144.0, 110.0, 112.0, 131.0, 132.0, 143.0, 105.0], "value": 123.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 186.0, 183.0, 183.0, 184.0, 181.0, 184.0, 183.0, 183.0, 182.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 89.0, 61.0, 59.0, 58.0, 59.0, 82.0, 59.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 95.0, 70.0, 69.0, 68.0, 92.0, 68.0, 68.0, 92.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 91.0, 88.0, 91.0, 86.0, 82.0, 129.0, 133.0, 88.0], "value": 96.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 98.0, 98.0, 98.0, 98.0, 98.0, 97.0, 98.0, 98.0], "value": 97.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 87.0, 84.0, 86.0, 84.0, 95.0, 81.0, 83.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 55.0, 52.0, 56.0, 57.0, 57.0, 57.0, 58.0, 57.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 73.0, 72.0, 72.0, 68.0, 69.0, 69.0, 69.0, 69.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 83.0, 82.0, 82.0, 82.0, 85.0, 81.0, 84.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 146.0, 148.0, 140.0, 135.0, 139.0, 143.0, 246.0, 152.0], "value": 152.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 159.0, 165.0, 166.0, 164.0, 166.0, 165.0, 161.0, 172.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 66.0, 67.0, 67.0, 66.0, 65.0, 67.0, 66.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1437.9, "alertThreshold": 2.0}]} 09:41:54 INFO - Return code: 0 09:41:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:41:54 INFO - # TBPL SUCCESS # 09:41:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:41:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:41:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:41:54 INFO - 2016-10-28 09:41:54.517 screenresolution[1666:10220] starting screenresolution argv=screenresolution get 09:41:54 INFO - 2016-10-28 09:41:54.520 screenresolution[1666:10220] Display 0: 1600x1200x32@60 09:41:54 INFO - 2016-10-28 09:41:54.525 screenresolution[1667:10224] starting screenresolution argv=screenresolution list 09:41:54 INFO - Available Modes on Display 0 09:41:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:41:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:41:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:41:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:41:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:41:54 INFO - Intel Iris: 09:41:54 INFO - Chipset Model: Intel Iris 09:41:54 INFO - Type: GPU 09:41:54 INFO - Bus: Built-In 09:41:54 INFO - VRAM (Dynamic, Max): 1536 MB 09:41:54 INFO - Vendor: Intel (0x8086) 09:41:54 INFO - Device ID: 0x0a2e 09:41:54 INFO - Revision ID: 0x0009 09:41:54 INFO - Displays: 09:41:54 INFO - Display: 09:41:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:41:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:41:54 INFO - Display Serial Number: 1600x1200 60 09:41:54 INFO - Main Display: Yes 09:41:54 INFO - Mirror: Off 09:41:54 INFO - Online: Yes 09:41:54 INFO - Rotation: Supported 09:41:54 INFO - Return code: 0 09:41:54 INFO - Running post-action listener: _resource_record_post_action 09:41:54 INFO - [mozharness: 2016-10-28 16:41:54.760889Z] Finished run-tests step (success) 09:41:54 INFO - Running post-run listener: _resource_record_post_run 09:41:54 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 38552576; Write bytes: 665427968; Read time: 398; Write time: 1867 09:41:54 INFO - TinderboxPrint: CPU usage
53.4% 09:41:54 INFO - TinderboxPrint: I/O read bytes / time
38,552,576 / 398 09:41:54 INFO - TinderboxPrint: I/O write bytes / time
665,427,968 / 1,867 09:41:54 INFO - TinderboxPrint: CPU idle
2,254.5 (46.6%) 09:41:54 INFO - TinderboxPrint: CPU system
966.4 (20.0%) 09:41:54 INFO - TinderboxPrint: CPU user
1,616.8 (33.4%) 09:41:54 INFO - TinderboxPrint: Swap in / out
402,034,688 / 0 09:41:54 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 358695424; Write bytes: 357988352; Read time: 27555; Write time: 703 09:41:54 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 36586496; Write bytes: 296441856; Read time: 376; Write time: 1132 09:41:55 INFO - Running post-run listener: _upload_blobber_files 09:41:55 INFO - Blob upload gear active. 09:41:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:41:55 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 09:41:55 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'] 09:41:55 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 09:41:55 INFO - (blobuploader) - INFO - Open directory for files ... 09:41:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:41:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:41:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:56 INFO - (blobuploader) - INFO - Done attempting. 09:41:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:41:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:41:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:57 INFO - (blobuploader) - INFO - Done attempting. 09:41:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:41:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:42:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:42:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:42:00 INFO - (blobuploader) - INFO - Done attempting. 09:42:00 INFO - (blobuploader) - INFO - Iteration through files over. 09:42:00 INFO - Return code: 0 09:42:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:42:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:42:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b9ef34298dfa8467a653869df2ee749dc950f5d5f15b7d800d9e45d420b5a6388f531463033af9de02d972f7ee4b2b4ced9ba6333f07f9faf944195e7aeed1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f630c4e7f98c3c2b4cf889effb3885124e56a15ca716ce969c34bcf29b29bbba74e73ab6efeb82aac94c60d6c6b088d0c2cae4fc60fc5a4225400c93e8c1ae5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17062987de65591ca16deee08c13bf905a89ce55392a08233b59f7481da48d02d71d3c0e52efafbce9255552964edbd1a2f56156541323923df81a276d1e1dcd"} 09:42:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:42:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:42:00 INFO - Contents: 09:42:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b9ef34298dfa8467a653869df2ee749dc950f5d5f15b7d800d9e45d420b5a6388f531463033af9de02d972f7ee4b2b4ced9ba6333f07f9faf944195e7aeed1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f630c4e7f98c3c2b4cf889effb3885124e56a15ca716ce969c34bcf29b29bbba74e73ab6efeb82aac94c60d6c6b088d0c2cae4fc60fc5a4225400c93e8c1ae5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17062987de65591ca16deee08c13bf905a89ce55392a08233b59f7481da48d02d71d3c0e52efafbce9255552964edbd1a2f56156541323923df81a276d1e1dcd"} 09:42:00 INFO - Running post-run listener: copy_logs_to_upload_dir 09:42:00 INFO - Copying logs to upload dir... 09:42:00 INFO - mkdir: /builds/slave/test/build/upload/logs 09:42:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.122417 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-28 09:42:00.256295) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 09:42:00.260160) ========= 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.qRmIFeLvZh/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.DFORNh0xr8/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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/0b9ef34298dfa8467a653869df2ee749dc950f5d5f15b7d800d9e45d420b5a6388f531463033af9de02d972f7ee4b2b4ced9ba6333f07f9faf944195e7aeed1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f630c4e7f98c3c2b4cf889effb3885124e56a15ca716ce969c34bcf29b29bbba74e73ab6efeb82aac94c60d6c6b088d0c2cae4fc60fc5a4225400c93e8c1ae5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17062987de65591ca16deee08c13bf905a89ce55392a08233b59f7481da48d02d71d3c0e52efafbce9255552964edbd1a2f56156541323923df81a276d1e1dcd"} build_url:https://queue.taskcluster.net/v1/task/Rs63FGYFQvaxNHf9B7dgxg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011148 build_url: 'https://queue.taskcluster.net/v1/task/Rs63FGYFQvaxNHf9B7dgxg/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/0b9ef34298dfa8467a653869df2ee749dc950f5d5f15b7d800d9e45d420b5a6388f531463033af9de02d972f7ee4b2b4ced9ba6333f07f9faf944195e7aeed1e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f630c4e7f98c3c2b4cf889effb3885124e56a15ca716ce969c34bcf29b29bbba74e73ab6efeb82aac94c60d6c6b088d0c2cae4fc60fc5a4225400c93e8c1ae5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/17062987de65591ca16deee08c13bf905a89ce55392a08233b59f7481da48d02d71d3c0e52efafbce9255552964edbd1a2f56156541323923df81a276d1e1dcd"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-28 09:42:00.299070) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 09:42:00.299655) ========= 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.qRmIFeLvZh/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.DFORNh0xr8/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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.005280 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-28 09:42:00.350086) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 09:42:00.350694) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-28 09:42:00.351376) ========= ========= Total master_lag: 4.82 =========