builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0286 starttime: 1485805450.0 results: success (0) buildid: 20170130110008 builduid: b2763f7cacbe4d428e537c162f13b904 revision: d8d335074d5c896ccacce5e302baae193e62dbaf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 11:44:09.997943) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 11:44:09.998430) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 11:44:09.998748) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 11:44:10.026649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 11:44:10.027261) ========= 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.7ASfDR6jGN/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.CxfsCGHbQG/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-30 11:44:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2017-01-30 11:44:10 (18.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126907 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 11:44:10.180561) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 11:44:10.180918) ========= 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.7ASfDR6jGN/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.CxfsCGHbQG/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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.026215 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 11:44:10.229761) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-30 11:44:10.230121) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d8d335074d5c896ccacce5e302baae193e62dbaf --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 d8d335074d5c896ccacce5e302baae193e62dbaf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7ASfDR6jGN/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.CxfsCGHbQG/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-30 11:44:10,329 truncating revision to first 12 chars 2017-01-30 11:44:10,329 Setting DEBUG logging. 2017-01-30 11:44:10,330 attempt 1/10 2017-01-30 11:44:10,330 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d8d335074d5c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-30 11:44:12,132 unpacking tar archive at: mozilla-aurora-d8d335074d5c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.076505 ========= master_lag: 0.53 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-30 11:44:12.840696) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 11:44:12.841341) ========= script_repo_revision: d8d335074d5c896ccacce5e302baae193e62dbaf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 11:44:12.841720) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 11:44:12.841995) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 11:44:12.865448) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-30 11:44:12.865754) ========= /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.7ASfDR6jGN/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.CxfsCGHbQG/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 11:44:13 INFO - MultiFileLogger online at 20170130 11:44:13 in /builds/slave/test 11:44:13 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 11:44:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:44:13 INFO - {'append_to_log': False, 11:44:13 INFO - 'base_work_dir': '/builds/slave/test', 11:44:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:44:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:44:13 INFO - 'branch': 'Mozilla-Aurora', 11:44:13 INFO - 'buildbot_json_path': 'buildprops.json', 11:44:13 INFO - 'config_files': ('talos/mac_config.py',), 11:44:13 INFO - 'default_actions': ('clobber', 11:44:13 INFO - 'read-buildbot-config', 11:44:13 INFO - 'download-and-extract', 11:44:13 INFO - 'populate-webroot', 11:44:13 INFO - 'create-virtualenv', 11:44:13 INFO - 'install', 11:44:13 INFO - 'run-tests'), 11:44:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:44:13 INFO - 'download_minidump_stackwalk': True, 11:44:13 INFO - 'download_symbols': 'ondemand', 11:44:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:44:13 INFO - 'tooltool.py': '/tools/tooltool.py', 11:44:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:44:13 INFO - '/tools/misc-python/virtualenv.py')}, 11:44:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:44:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:44:13 INFO - 'installer_path': 'installer.exe', 11:44:13 INFO - 'log_level': 'info', 11:44:13 INFO - 'log_name': 'talos', 11:44:13 INFO - 'log_to_console': True, 11:44:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:44:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:44:13 INFO - 'opt_config_files': (), 11:44:13 INFO - 'pip_index': False, 11:44:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:44:13 INFO - 'cmd': ('bash', 11:44:13 INFO - '-c', 11:44:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:44:13 INFO - 'enabled': True, 11:44:13 INFO - 'halt_on_failure': False, 11:44:13 INFO - 'name': 'check_screen_resolution'},), 11:44:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:44:13 INFO - 'cmd': ('bash', 11:44:13 INFO - '-c', 11:44:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:44:13 INFO - 'enabled': True, 11:44:13 INFO - 'halt_on_failure': False, 11:44:13 INFO - 'name': 'check_screen_resolution'},), 11:44:13 INFO - 'run_cmd_checks_enabled': True, 11:44:13 INFO - 'sps_profile': False, 11:44:13 INFO - 'sps_profile_interval': 0, 11:44:13 INFO - 'suite': 'dromaeojs', 11:44:13 INFO - 'system_bits': '32', 11:44:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:44:13 INFO - 'title': 't-yosemite-r7-0286', 11:44:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:44:13 INFO - 'use_talos_json': True, 11:44:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:44:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:44:13 INFO - 'work_dir': 'build'} 11:44:13 INFO - [mozharness: 2017-01-30 19:44:13.067724Z] Running clobber step. 11:44:13 INFO - Running pre-action listener: _resource_record_pre_action 11:44:13 INFO - Running main action method: clobber 11:44:13 INFO - rmtree: /builds/slave/test/build 11:44:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:44:15 INFO - Running post-action listener: _resource_record_post_action 11:44:15 INFO - [mozharness: 2017-01-30 19:44:15.448368Z] Finished clobber step (success) 11:44:15 INFO - [mozharness: 2017-01-30 19:44:15.448535Z] Running read-buildbot-config step. 11:44:15 INFO - Running pre-action listener: _resource_record_pre_action 11:44:15 INFO - Running main action method: read_buildbot_config 11:44:15 INFO - Using buildbot properties: 11:44:15 INFO - { 11:44:15 INFO - "project": "", 11:44:15 INFO - "product": "firefox", 11:44:15 INFO - "script_repo_revision": "production", 11:44:15 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 11:44:15 INFO - "repository": "", 11:44:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 11:44:15 INFO - "buildid": "20170130110008", 11:44:15 INFO - "pgo_build": "False", 11:44:15 INFO - "basedir": "/builds/slave/test", 11:44:15 INFO - "buildnumber": 1, 11:44:15 INFO - "slavename": "t-yosemite-r7-0286", 11:44:15 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 11:44:15 INFO - "platform": "yosemite_r7", 11:44:15 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 11:44:15 INFO - "branch": "mozilla-aurora", 11:44:15 INFO - "repo_path": "releases/mozilla-aurora", 11:44:15 INFO - "revision": "d8d335074d5c896ccacce5e302baae193e62dbaf", 11:44:15 INFO - "stage_platform": "macosx64", 11:44:15 INFO - "builduid": "b2763f7cacbe4d428e537c162f13b904", 11:44:15 INFO - "slavebuilddir": "test" 11:44:15 INFO - } 11:44:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 11:44:15 INFO - Running post-action listener: _resource_record_post_action 11:44:15 INFO - [mozharness: 2017-01-30 19:44:15.452665Z] Finished read-buildbot-config step (success) 11:44:15 INFO - [mozharness: 2017-01-30 19:44:15.452813Z] Running download-and-extract step. 11:44:15 INFO - Running pre-action listener: _resource_record_pre_action 11:44:15 INFO - Running main action method: download_and_extract 11:44:15 INFO - mkdir: /builds/slave/test/build/tests 11:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:15 INFO - trying https://queue.taskcluster.net/v1/task/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 11:44:15 INFO - Downloading https://queue.taskcluster.net/v1/task/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 11:44:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 11:44:16 INFO - Downloaded 1199 bytes. 11:44:16 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 11:44:16 INFO - Using the following test package requirements: 11:44:16 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 11:44:16 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:44:16 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 11:44:16 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:44:16 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 11:44:16 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:44:16 INFO - u'jsshell-mac.zip'], 11:44:16 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:44:16 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 11:44:16 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 11:44:16 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:44:16 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 11:44:16 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:44:16 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 11:44:16 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:44:16 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 11:44:16 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:44:16 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 11:44:16 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 11:44:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 11:44:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:44:16 INFO - Fetch https://queue.taskcluster.net/v1/task/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 11:44:17 INFO - Expected file size: 16352280 11:44:17 INFO - Obtained file size: 16352280 11:44:23 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 11:44:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 11:44:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:44:23 INFO - Fetch https://queue.taskcluster.net/v1/task/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 11:44:24 INFO - Expected file size: 16352280 11:44:24 INFO - Obtained file size: 16352280 11:44:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 11:44:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 11:44:31 INFO - Fetch https://queue.taskcluster.net/v1/task/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 11:44:31 INFO - Expected file size: 14403485 11:44:31 INFO - Obtained file size: 14403485 11:44:32 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')]} 11:44:32 INFO - trying https://queue.taskcluster.net/v1/task/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:44:32 INFO - Downloading https://queue.taskcluster.net/v1/task/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 11:44:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 11:44:34 INFO - Downloaded 73867962 bytes. 11:44:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:44:34 INFO - mkdir: /builds/slave/test/properties 11:44:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:44:34 INFO - Writing to file /builds/slave/test/properties/build_url 11:44:34 INFO - Contents: 11:44:34 INFO - build_url:https://queue.taskcluster.net/v1/task/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:44:35 INFO - Running post-action listener: _resource_record_post_action 11:44:35 INFO - Running post-action listener: set_extra_try_arguments 11:44:35 INFO - [mozharness: 2017-01-30 19:44:35.400908Z] Finished download-and-extract step (success) 11:44:35 INFO - [mozharness: 2017-01-30 19:44:35.401061Z] Running populate-webroot step. 11:44:35 INFO - Running pre-action listener: _resource_record_pre_action 11:44:35 INFO - Running main action method: populate_webroot 11:44:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:44:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:44:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:44:35 INFO - '--tppagecycles', 11:44:35 INFO - '7'], 11:44:35 INFO - 'tests': ['tsvgm']}}, 11:44:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:44:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:44:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:44:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:44:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:44:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:44:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:44:35 INFO - 'talos_options': ['--disable-e10s'], 11:44:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:44:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:44:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:44:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:44:35 INFO - 'talos_options': ['--disable-e10s'], 11:44:35 INFO - 'tests': ['damp', 'tps']}, 11:44:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:44:35 INFO - 'tests': ['damp', 'tps']}, 11:44:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:44:35 INFO - 'tests': ['dromaeo_dom']}, 11:44:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:44:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:44:35 INFO - 'tests': ['basic_compositor_video']}, 11:44:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:44:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:44:35 INFO - 'tests': ['a11yr', 11:44:35 INFO - 'ts_paint', 11:44:35 INFO - 'tpaint', 11:44:35 INFO - 'sessionrestore', 11:44:35 INFO - 'sessionrestore_no_auto_restore', 11:44:35 INFO - 'tabpaint']}, 11:44:35 INFO - 'other-e10s': {'tests': ['a11yr', 11:44:35 INFO - 'ts_paint', 11:44:35 INFO - 'tpaint', 11:44:35 INFO - 'sessionrestore', 11:44:35 INFO - 'sessionrestore_no_auto_restore', 11:44:35 INFO - 'tabpaint']}, 11:44:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:44:35 INFO - 'ts_paint', 11:44:35 INFO - 'tpaint', 11:44:35 INFO - 'sessionrestore', 11:44:35 INFO - 'sessionrestore_no_auto_restore', 11:44:35 INFO - 'tabpaint']}, 11:44:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:44:35 INFO - 'ts_paint', 11:44:35 INFO - 'tpaint', 11:44:35 INFO - 'sessionrestore', 11:44:35 INFO - 'sessionrestore_no_auto_restore', 11:44:35 INFO - 'tabpaint']}, 11:44:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:44:35 INFO - 'tests': ['a11yr', 11:44:35 INFO - 'ts_paint', 11:44:35 INFO - 'tpaint', 11:44:35 INFO - 'sessionrestore', 11:44:35 INFO - 'sessionrestore_no_auto_restore', 11:44:35 INFO - 'tabpaint']}, 11:44:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:44:35 INFO - 'tests': ['a11yr', 11:44:35 INFO - 'ts_paint', 11:44:35 INFO - 'tpaint', 11:44:35 INFO - 'sessionrestore', 11:44:35 INFO - 'sessionrestore_no_auto_restore', 11:44:35 INFO - 'tabpaint']}, 11:44:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:44:35 INFO - 'tests': ['tsvgx', 11:44:35 INFO - 'tsvgr_opacity', 11:44:35 INFO - 'tart', 11:44:35 INFO - 'tscrollx', 11:44:35 INFO - 'cart', 11:44:35 INFO - 'tsvg_static']}, 11:44:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:44:35 INFO - 'tsvgr_opacity', 11:44:35 INFO - 'tart', 11:44:35 INFO - 'tscrollx', 11:44:35 INFO - 'cart', 11:44:35 INFO - 'tsvg_static']}, 11:44:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:44:35 INFO - 'talos_options': ['--disable-e10s'], 11:44:35 INFO - 'tests': ['tp5o']}, 11:44:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:44:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:44:35 INFO - 'talos_options': ['--disable-e10s', 11:44:35 INFO - '--xperf_path', 11:44:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:44:35 INFO - 'tests': ['tp5n']}, 11:44:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:44:35 INFO - 'talos_options': ['--xperf_path', 11:44:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:44:35 INFO - 'tests': ['tp5n']}}, 11:44:35 INFO - 'talos.zip': {'path': '', 11:44:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:44:35 INFO - Running post-action listener: _resource_record_post_action 11:44:35 INFO - [mozharness: 2017-01-30 19:44:35.419642Z] Finished populate-webroot step (success) 11:44:35 INFO - [mozharness: 2017-01-30 19:44:35.419779Z] Running create-virtualenv step. 11:44:35 INFO - Running pre-action listener: _resource_record_pre_action 11:44:35 INFO - Running main action method: create_virtualenv 11:44:35 INFO - Creating virtualenv /builds/slave/test/build/venv 11:44:35 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 11:44:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:44:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:44:35 INFO - Using real prefix '/tools/python27' 11:44:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:44:36 INFO - Installing distribute.............................................................................................................................................................................................done. 11:44:39 INFO - Installing pip.................done. 11:44:39 INFO - Return code: 0 11:44:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:44:39 INFO - Reading from file tmpfile_stdout 11:44:39 INFO - Output received: 11:44:39 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:44:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:39 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 0x10dd2ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8201498470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db08d30>, '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 0x10da2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafdbe8>, '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.7ASfDR6jGN/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.CxfsCGHbQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 11:44:39 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 11:44:39 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 11:44:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ASfDR6jGN/Render', 11:44:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:39 INFO - 'HOME': '/Users/cltbld', 11:44:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:39 INFO - 'LOGNAME': 'cltbld', 11:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:39 INFO - 'MOZ_NO_REMOTE': '1', 11:44:39 INFO - 'NO_EM_RESTART': '1', 11:44:39 INFO - 'PAGER': '/bin/cat', 11:44:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:39 INFO - 'PWD': '/builds/slave/test', 11:44:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:39 INFO - 'SHELL': '/bin/bash', 11:44:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxfsCGHbQG/Listeners', 11:44:39 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 11:44:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:39 INFO - 'USER': 'cltbld', 11:44:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:39 INFO - 'XPC_FLAGS': '0x0', 11:44:39 INFO - 'XPC_SERVICE_NAME': '0', 11:44:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:39 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 11:44:39 INFO - Cleaning up... 11:44:39 INFO - Return code: 0 11:44:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:39 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 0x10dd2ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8201498470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db08d30>, '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 0x10da2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafdbe8>, '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.7ASfDR6jGN/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.CxfsCGHbQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 11:44:39 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 11:44:39 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 11:44:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ASfDR6jGN/Render', 11:44:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:39 INFO - 'HOME': '/Users/cltbld', 11:44:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:39 INFO - 'LOGNAME': 'cltbld', 11:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:39 INFO - 'MOZ_NO_REMOTE': '1', 11:44:39 INFO - 'NO_EM_RESTART': '1', 11:44:39 INFO - 'PAGER': '/bin/cat', 11:44:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:39 INFO - 'PWD': '/builds/slave/test', 11:44:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:39 INFO - 'SHELL': '/bin/bash', 11:44:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxfsCGHbQG/Listeners', 11:44:39 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 11:44:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:39 INFO - 'USER': 'cltbld', 11:44:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:39 INFO - 'XPC_FLAGS': '0x0', 11:44:39 INFO - 'XPC_SERVICE_NAME': '0', 11:44:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:40 INFO - Downloading/unpacking psutil>=3.1.1 11:44: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 11:44: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 11:44: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 11:44: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 11:44: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 11:44: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 11:44:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:44:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:44:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:44:43 INFO - Installing collected packages: psutil 11:44:43 INFO - Running setup.py install for psutil 11:44:43 INFO - building 'psutil._psutil_osx' extension 11:44:43 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 11:44:44 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 11:44:44 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 11:44:44 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 11:44:44 INFO - building 'psutil._psutil_posix' extension 11:44:44 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 11:44:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:44:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:44:44 INFO - ^ 11:44:44 INFO - 1 warning generated. 11:44:44 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 11:44:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:44:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:44:44 INFO - Successfully installed psutil 11:44:44 INFO - Cleaning up... 11:44:44 INFO - Return code: 0 11:44:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:44: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')]} 11:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44: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')]} 11:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8201498470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db08d30>, '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 0x10da2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafdbe8>, '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.7ASfDR6jGN/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.CxfsCGHbQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 11:44: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:44: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 mozsystemmonitor==0.3 11:44:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ASfDR6jGN/Render', 11:44:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:44 INFO - 'HOME': '/Users/cltbld', 11:44:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:44 INFO - 'LOGNAME': 'cltbld', 11:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:44 INFO - 'MOZ_NO_REMOTE': '1', 11:44:44 INFO - 'NO_EM_RESTART': '1', 11:44:44 INFO - 'PAGER': '/bin/cat', 11:44:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:44 INFO - 'PWD': '/builds/slave/test', 11:44:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:44 INFO - 'SHELL': '/bin/bash', 11:44:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxfsCGHbQG/Listeners', 11:44:44 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 11:44:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:44 INFO - 'USER': 'cltbld', 11:44:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:44 INFO - 'XPC_FLAGS': '0x0', 11:44:44 INFO - 'XPC_SERVICE_NAME': '0', 11:44:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:44:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:44:47 INFO - Installing collected packages: mozsystemmonitor 11:44:47 INFO - Running setup.py install for mozsystemmonitor 11:44:48 INFO - Successfully installed mozsystemmonitor 11:44:48 INFO - Cleaning up... 11:44:48 INFO - Return code: 0 11:44:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dd2ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8201498470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db08d30>, '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 0x10da2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafdbe8>, '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.7ASfDR6jGN/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.CxfsCGHbQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 11:44:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:44:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ASfDR6jGN/Render', 11:44:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:48 INFO - 'HOME': '/Users/cltbld', 11:44:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:48 INFO - 'LOGNAME': 'cltbld', 11:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:48 INFO - 'MOZ_NO_REMOTE': '1', 11:44:48 INFO - 'NO_EM_RESTART': '1', 11:44:48 INFO - 'PAGER': '/bin/cat', 11:44:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:48 INFO - 'PWD': '/builds/slave/test', 11:44:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:48 INFO - 'SHELL': '/bin/bash', 11:44:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxfsCGHbQG/Listeners', 11:44:48 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 11:44:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:48 INFO - 'USER': 'cltbld', 11:44:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:48 INFO - 'XPC_FLAGS': '0x0', 11:44:48 INFO - 'XPC_SERVICE_NAME': '0', 11:44:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:48 INFO - Downloading/unpacking jsonschema==2.5.1 11:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:44:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:44:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:44:51 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 11:44:51 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 11:44:51 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 11:44:51 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 11:44:51 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 11:44:51 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 11:44:51 INFO - Downloading functools32-3.2.3-2.tar.gz 11:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:44:51 INFO - warning: no files found matching '*.txt' 11:44:51 INFO - no previously-included directories found matching 'build' 11:44:51 INFO - no previously-included directories found matching 'dist' 11:44:51 INFO - no previously-included directories found matching '.git*' 11:44:51 INFO - Installing collected packages: jsonschema, functools32 11:44:51 INFO - Running setup.py install for functools32 11:44:51 INFO - warning: no files found matching '*.txt' 11:44:51 INFO - no previously-included directories found matching 'build' 11:44:51 INFO - no previously-included directories found matching 'dist' 11:44:51 INFO - no previously-included directories found matching '.git*' 11:44:51 INFO - Successfully installed jsonschema functools32 11:44:51 INFO - Cleaning up... 11:44:51 INFO - Return code: 0 11:44:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:44:51 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')]} 11:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:51 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')]} 11:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:51 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 0x10dd2ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8201498470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db08d30>, '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 0x10da2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafdbe8>, '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.7ASfDR6jGN/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.CxfsCGHbQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 11:44:51 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 11:44:51 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 11:44:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ASfDR6jGN/Render', 11:44:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:51 INFO - 'HOME': '/Users/cltbld', 11:44:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:51 INFO - 'LOGNAME': 'cltbld', 11:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:51 INFO - 'MOZ_NO_REMOTE': '1', 11:44:51 INFO - 'NO_EM_RESTART': '1', 11:44:51 INFO - 'PAGER': '/bin/cat', 11:44:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:51 INFO - 'PWD': '/builds/slave/test', 11:44:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:51 INFO - 'SHELL': '/bin/bash', 11:44:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxfsCGHbQG/Listeners', 11:44:51 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 11:44:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:51 INFO - 'USER': 'cltbld', 11:44:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:51 INFO - 'XPC_FLAGS': '0x0', 11:44:51 INFO - 'XPC_SERVICE_NAME': '0', 11:44:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:44:52 INFO - Cleaning up... 11:44:52 INFO - Return code: 0 11:44:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:44: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')]} 11:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44: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')]} 11:44:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:52 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 0x10dd2ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8201498470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db08d30>, '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 0x10da2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafdbe8>, '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.7ASfDR6jGN/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.CxfsCGHbQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 11:44:52 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 11:44:52 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 11:44:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ASfDR6jGN/Render', 11:44:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:52 INFO - 'HOME': '/Users/cltbld', 11:44:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:52 INFO - 'LOGNAME': 'cltbld', 11:44:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:52 INFO - 'MOZ_NO_REMOTE': '1', 11:44:52 INFO - 'NO_EM_RESTART': '1', 11:44:52 INFO - 'PAGER': '/bin/cat', 11:44:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:52 INFO - 'PWD': '/builds/slave/test', 11:44:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:52 INFO - 'SHELL': '/bin/bash', 11:44:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxfsCGHbQG/Listeners', 11:44:52 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 11:44:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:52 INFO - 'USER': 'cltbld', 11:44:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:52 INFO - 'XPC_FLAGS': '0x0', 11:44:52 INFO - 'XPC_SERVICE_NAME': '0', 11:44:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:52 INFO - Downloading/unpacking blobuploader==1.2.4 11:44:52 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 11:44:52 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 11:44:52 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 11:44:52 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 11:44:52 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 11:44:52 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 11:44:54 INFO - Downloading blobuploader-1.2.4.tar.gz 11:44:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:44:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:44:55 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 11:44:55 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 11:44:55 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 11:44:55 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 11:44:55 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 11:44:55 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 11:44:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:44:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:44:55 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 11:44:55 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 11:44:55 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 11:44:55 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 11:44:55 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 11:44:55 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 11:44:56 INFO - Downloading docopt-0.6.1.tar.gz 11:44:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:44:56 INFO - Installing collected packages: blobuploader, requests, docopt 11:44:56 INFO - Running setup.py install for blobuploader 11:44:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:44:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:44:56 INFO - Running setup.py install for requests 11:44:56 INFO - Running setup.py install for docopt 11:44:57 INFO - Successfully installed blobuploader requests docopt 11:44:57 INFO - Cleaning up... 11:44:57 INFO - Return code: 0 11:44:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:44:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:44:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:44:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:44:57 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 0x10dd2ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8201498470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db08d30>, '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 0x10da2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafdbe8>, '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.7ASfDR6jGN/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.CxfsCGHbQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 11:44:57 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 11:44:57 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 11:44:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ASfDR6jGN/Render', 11:44:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:44:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:44:57 INFO - 'HOME': '/Users/cltbld', 11:44:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:44:57 INFO - 'LOGNAME': 'cltbld', 11:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:44:57 INFO - 'MOZ_NO_REMOTE': '1', 11:44:57 INFO - 'NO_EM_RESTART': '1', 11:44:57 INFO - 'PAGER': '/bin/cat', 11:44:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:44:57 INFO - 'PWD': '/builds/slave/test', 11:44:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:44:57 INFO - 'SHELL': '/bin/bash', 11:44:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxfsCGHbQG/Listeners', 11:44:57 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 11:44:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:44:57 INFO - 'USER': 'cltbld', 11:44:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:44:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:44:57 INFO - 'XPC_FLAGS': '0x0', 11:44:57 INFO - 'XPC_SERVICE_NAME': '0', 11:44:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:44:57 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-wy2ixa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:44:57 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-Z6WdUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:44:57 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ANRhjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:44:57 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-X7ducb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:44:57 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-xoJZXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:44:57 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-J23Glr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:44:58 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-S5QWmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:44:58 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-OMTiJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:44:58 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-KabKKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:44:58 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-WmJaDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:44:58 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-uzOnXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:44:58 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-3oUgcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:44:58 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-_AdGbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:44:58 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-s8j1zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:58 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-VdmoBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:44:59 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-1lYEQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:44:59 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-lv7rLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:44:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:44:59 INFO - Running setup.py install for manifestparser 11:44:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:44:59 INFO - Running setup.py install for mozcrash 11:44:59 INFO - Running setup.py install for mozdebug 11:44:59 INFO - Running setup.py install for mozdevice 11:44:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:44:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:44:59 INFO - Running setup.py install for mozfile 11:45:00 INFO - Running setup.py install for mozhttpd 11:45:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:45:00 INFO - Running setup.py install for mozinfo 11:45:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:45:00 INFO - Running setup.py install for mozInstall 11:45:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:45:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:45:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:45:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:45:00 INFO - Running setup.py install for mozleak 11:45:00 INFO - Running setup.py install for mozlog 11:45:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:45:00 INFO - Running setup.py install for moznetwork 11:45:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:45:00 INFO - Running setup.py install for mozprocess 11:45:01 INFO - Running setup.py install for mozprofile 11:45:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:45:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:45:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:45:01 INFO - Running setup.py install for mozrunner 11:45:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:45:01 INFO - Running setup.py install for mozscreenshot 11:45:01 INFO - Running setup.py install for moztest 11:45:01 INFO - Running setup.py install for mozversion 11:45:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:45:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:45:01 INFO - Cleaning up... 11:45:01 INFO - Return code: 0 11:45:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:45:01 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')]} 11:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:01 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')]} 11:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:01 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 0x10dd2ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8201498470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db08d30>, '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 0x10da2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafdbe8>, '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.7ASfDR6jGN/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.CxfsCGHbQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 11:45:01 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 11:45:01 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 11:45:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ASfDR6jGN/Render', 11:45:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:01 INFO - 'HOME': '/Users/cltbld', 11:45:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:01 INFO - 'LOGNAME': 'cltbld', 11:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:01 INFO - 'MOZ_NO_REMOTE': '1', 11:45:01 INFO - 'NO_EM_RESTART': '1', 11:45:01 INFO - 'PAGER': '/bin/cat', 11:45:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:01 INFO - 'PWD': '/builds/slave/test', 11:45:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:01 INFO - 'SHELL': '/bin/bash', 11:45:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxfsCGHbQG/Listeners', 11:45:01 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 11:45:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:01 INFO - 'USER': 'cltbld', 11:45:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:01 INFO - 'XPC_FLAGS': '0x0', 11:45:01 INFO - 'XPC_SERVICE_NAME': '0', 11:45:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:45:02 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-Jc_YAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:45:02 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)) 11:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:45:02 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-NJr_tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:45:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:45:02 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ajFZ1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:45:02 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)) 11:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:45:02 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-OunyGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:45:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:45:02 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-BOhWXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:45:02 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)) 11:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:45:02 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-XRUbeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:45:02 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)) 11:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:45:02 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ZVnamg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:45:02 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)) 11:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:45:02 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-QOSqEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:45:02 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)) 11:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:45:02 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ZtVAuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:45:03 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)) 11:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:45:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-r6yYtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:45:03 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)) 11:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:45:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-tKMlDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:45:03 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)) 11:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:45:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-IG5rkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:45:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-gOmgc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:45:03 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)) 11:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:45:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-sdWWAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:45:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-7rVAjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:45:03 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)) 11:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:45:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-dr7lun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:45:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-twpmdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:45:03 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)) 11:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:45:03 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)) 11:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:45:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:45:06 INFO - Downloading blessings-1.6.tar.gz 11:45:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:45:06 INFO - Installing collected packages: blessings 11:45:06 INFO - Running setup.py install for blessings 11:45:06 INFO - Successfully installed blessings 11:45:06 INFO - Cleaning up... 11:45:06 INFO - Return code: 0 11:45:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:45:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:45:07 INFO - Reading from file tmpfile_stdout 11:45:07 INFO - Current package versions: 11:45:07 INFO - blessings == 1.6 11:45:07 INFO - blobuploader == 1.2.4 11:45:07 INFO - docopt == 0.6.1 11:45:07 INFO - functools32 == 3.2.3-2 11:45:07 INFO - jsonschema == 2.5.1 11:45:07 INFO - manifestparser == 1.1 11:45:07 INFO - mozInstall == 1.12 11:45:07 INFO - mozcrash == 1.0 11:45:07 INFO - mozdebug == 0.1 11:45:07 INFO - mozdevice == 0.49 11:45:07 INFO - mozfile == 1.2 11:45:07 INFO - mozhttpd == 0.7 11:45:07 INFO - mozinfo == 0.9 11:45:07 INFO - mozleak == 0.1 11:45:07 INFO - mozlog == 3.4 11:45:07 INFO - moznetwork == 0.27 11:45:07 INFO - mozprocess == 0.24 11:45:07 INFO - mozprofile == 0.28 11:45:07 INFO - mozrunner == 6.13 11:45:07 INFO - mozscreenshot == 0.1 11:45:07 INFO - mozsystemmonitor == 0.3 11:45:07 INFO - moztest == 0.8 11:45:07 INFO - mozversion == 1.4 11:45:07 INFO - psutil == 3.1.1 11:45:07 INFO - requests == 1.2.3 11:45:07 INFO - wsgiref == 0.1.2 11:45:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:08 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 0x10dd2ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8201498470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db08d30>, '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 0x10da2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafdbe8>, '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.7ASfDR6jGN/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.CxfsCGHbQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 11:45:08 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 11:45:08 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 11:45:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ASfDR6jGN/Render', 11:45:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:08 INFO - 'HOME': '/Users/cltbld', 11:45:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:08 INFO - 'LOGNAME': 'cltbld', 11:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:08 INFO - 'MOZ_NO_REMOTE': '1', 11:45:08 INFO - 'NO_EM_RESTART': '1', 11:45:08 INFO - 'PAGER': '/bin/cat', 11:45:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:08 INFO - 'PWD': '/builds/slave/test', 11:45:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:08 INFO - 'SHELL': '/bin/bash', 11:45:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxfsCGHbQG/Listeners', 11:45:08 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 11:45:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:08 INFO - 'USER': 'cltbld', 11:45:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:08 INFO - 'XPC_FLAGS': '0x0', 11:45:08 INFO - 'XPC_SERVICE_NAME': '0', 11:45:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:08 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)) 11:45:08 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)) 11:45:08 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)) 11:45:08 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)) 11:45:08 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)) 11:45:08 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)) 11:45:08 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)) 11:45:08 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)) 11:45:08 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)) 11:45:08 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)) 11:45:08 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)) 11:45:08 INFO - Cleaning up... 11:45:08 INFO - Return code: 0 11:45:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:45:08 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')]} 11:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:08 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')]} 11:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:45:08 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 0x10dd2ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8201498470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db08d30>, '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 0x10da2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafdbe8>, '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.7ASfDR6jGN/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.CxfsCGHbQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 11:45:08 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 11:45:08 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 11:45:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ASfDR6jGN/Render', 11:45:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:08 INFO - 'HOME': '/Users/cltbld', 11:45:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:08 INFO - 'LOGNAME': 'cltbld', 11:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:08 INFO - 'MOZ_NO_REMOTE': '1', 11:45:08 INFO - 'NO_EM_RESTART': '1', 11:45:08 INFO - 'PAGER': '/bin/cat', 11:45:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:08 INFO - 'PWD': '/builds/slave/test', 11:45:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:08 INFO - 'SHELL': '/bin/bash', 11:45:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxfsCGHbQG/Listeners', 11:45:08 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 11:45:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:08 INFO - 'USER': 'cltbld', 11:45:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:08 INFO - 'XPC_FLAGS': '0x0', 11:45:08 INFO - 'XPC_SERVICE_NAME': '0', 11:45:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:45:08 INFO - Cleaning up... 11:45:09 INFO - Return code: 0 11:45:09 INFO - Running post-action listener: _resource_record_post_action 11:45:09 INFO - Running post-action listener: _start_resource_monitoring 11:45:09 INFO - Starting resource monitoring. 11:45:09 INFO - [mozharness: 2017-01-30 19:45:09.035371Z] Finished create-virtualenv step (success) 11:45:09 INFO - [mozharness: 2017-01-30 19:45:09.036385Z] Running install step. 11:45:09 INFO - Running pre-action listener: _resource_record_pre_action 11:45:09 INFO - Running main action method: install 11:45:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:45:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:45:09 INFO - Reading from file tmpfile_stdout 11:45:09 INFO - Detecting whether we're running mozinstall >=1.0... 11:45:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:45:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:45:09 INFO - Reading from file tmpfile_stdout 11:45:09 INFO - Output received: 11:45:09 INFO - Usage: mozinstall [options] installer 11:45:09 INFO - Options: 11:45:09 INFO - -h, --help show this help message and exit 11:45:09 INFO - -d DEST, --destination=DEST 11:45:09 INFO - Directory to install application into. [default: 11:45:09 INFO - "/builds/slave/test"] 11:45:09 INFO - --app=APP Application being installed. [default: firefox] 11:45:09 INFO - mkdir: /builds/slave/test/build/application 11:45:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:45:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 11:45:29 INFO - Reading from file tmpfile_stdout 11:45:29 INFO - Output received: 11:45:29 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 11:45:29 INFO - Running post-action listener: _resource_record_post_action 11:45:29 INFO - [mozharness: 2017-01-30 19:45:29.439242Z] Finished install step (success) 11:45:29 INFO - [mozharness: 2017-01-30 19:45:29.439445Z] Running run-tests step. 11:45:29 INFO - Running pre-action listener: _resource_record_pre_action 11:45:29 INFO - Running main action method: run_tests 11:45:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:45:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:45:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:45:29 INFO - 2017-01-30 11:45:29.454 screenresolution[1627:7452] starting screenresolution argv=screenresolution get 11:45:29 INFO - 2017-01-30 11:45:29.457 screenresolution[1627:7452] Display 0: 1600x1200x32@60 11:45:29 INFO - 2017-01-30 11:45:29.463 screenresolution[1628:7455] starting screenresolution argv=screenresolution list 11:45:29 INFO - Available Modes on Display 0 11:45:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:45:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:45:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:45:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:45:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:45:29 INFO - Intel Iris: 11:45:29 INFO - Chipset Model: Intel Iris 11:45:29 INFO - Type: GPU 11:45:29 INFO - Bus: Built-In 11:45:29 INFO - VRAM (Dynamic, Max): 1536 MB 11:45:29 INFO - Vendor: Intel (0x8086) 11:45:29 INFO - Device ID: 0x0a2e 11:45:29 INFO - Revision ID: 0x0009 11:45:29 INFO - Displays: 11:45:29 INFO - Display: 11:45:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:45:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:45:29 INFO - Display Serial Number: 1600x1200 60 11:45:29 INFO - Main Display: Yes 11:45:29 INFO - Mirror: Off 11:45:29 INFO - Online: Yes 11:45:29 INFO - Rotation: Supported 11:45:29 INFO - Return code: 0 11:45:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:45:29 INFO - Python 2.7.3 11:45:29 INFO - Return code: 0 11:45:29 INFO - grabbing minidump binary from tooltool 11:45: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')]} 11:45:29 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 0x10db08d30>, '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 0x10da2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dafdbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:45:29 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 11:45:29 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 11:45:29 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 11:45:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:45:29 INFO - Return code: 0 11:45:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:45:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:45:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:45:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:45:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:45:29 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/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0286', '--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 11:45:29 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/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0286 --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 11:45:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ASfDR6jGN/Render', 11:45:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:45:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:45:29 INFO - 'HOME': '/Users/cltbld', 11:45:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:45:29 INFO - 'LOGNAME': 'cltbld', 11:45:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:45:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:29 INFO - 'MOZ_NO_REMOTE': '1', 11:45:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:45:29 INFO - 'NO_EM_RESTART': '1', 11:45:29 INFO - 'PAGER': '/bin/cat', 11:45:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:29 INFO - 'PWD': '/builds/slave/test', 11:45:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:45:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:45:29 INFO - 'SHELL': '/bin/bash', 11:45:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CxfsCGHbQG/Listeners', 11:45:29 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 11:45:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:45:29 INFO - 'USER': 'cltbld', 11:45:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:45:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:29 INFO - 'XPC_FLAGS': '0x0', 11:45:29 INFO - 'XPC_SERVICE_NAME': '0', 11:45:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:45:29 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/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0286', '--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 11:45:30 INFO - mozversion application_buildid: 20170130110008 11:45:30 INFO - mozversion application_changeset: d8d335074d5c896ccacce5e302baae193e62dbaf 11:45:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:45:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:45:30 INFO - mozversion application_name: Firefox 11:45:30 INFO - mozversion application_remotingname: firefox-dev 11:45:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:45:30 INFO - mozversion application_vendor: Mozilla 11:45:30 INFO - mozversion application_version: 53.0a2 11:45:30 INFO - mozversion platform_buildid: 20170130110008 11:45:30 INFO - mozversion platform_changeset: d8d335074d5c896ccacce5e302baae193e62dbaf 11:45:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:45:30 INFO - mozversion platform_version: 53.0a2 11:45:30 INFO - using testdate: 1485805530 11:45:30 INFO - actual date: 1485805530 11:45:30 INFO - starting webserver on 'localhost:49241' 11:45:30 INFO - SUITE-START | Running 2 tests 11:45:30 INFO - TEST-START | dromaeo_css 11:45:30 INFO - operating with platform_type : mac_ 11:45:30 INFO - Initialising browser for dromaeo_css test... 11:45:30 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpbNgkJm/profile http://localhost:49241/getInfo.html) 11:45:32 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 11:45:32 INFO - PROCESS | 1638 | colorDepth:24 11:45:32 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 11:45:32 INFO - PROCESS | 1638 | __metrics 11:45:32 INFO - PROCESS | 1638 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:45:32 INFO - PROCESS | 1638 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:45:33 INFO - TEST-INFO | 1638: exit 0 11:45:33 INFO - Browser initialized. 11:45:33 INFO - Running cycle 1/1 for dromaeo_css test... 11:45:33 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpbNgkJm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:45:45 INFO - PROCESS | 1640 | RSS: Main: 213020672 11:45:45 INFO - PROCESS | 1640 | 11:48:49 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 11:48:50 INFO - PROCESS | 1640 | RSS: Main: 353263616 11:48:50 INFO - PROCESS | 1640 | 11:50:35 INFO - PROCESS | 1640 | ************************* 11:50:35 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 11:50:35 INFO - PROCESS | 1640 | 11:50:35 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:50:35 INFO - PROCESS | 1640 | Full stack: 11:50:35 INFO - PROCESS | 1640 | ************************* 11:51:53 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 11:51:54 INFO - PROCESS | 1640 | RSS: Main: 348942336 11:51:54 INFO - PROCESS | 1640 | 11:54:56 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 11:54:56 INFO - PROCESS | 1640 | RSS: Main: 333283328 11:54:56 INFO - PROCESS | 1640 | 11:57:59 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 11:57:59 INFO - PROCESS | 1640 | RSS: Main: 325066752 11:57:59 INFO - PROCESS | 1640 | 12:01:03 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 12:01:03 INFO - PROCESS | 1640 | RSS: Main: 312467456 12:01:03 INFO - PROCESS | 1640 | 12:04:07 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 12:04:07 INFO - PROCESS | 1640 | RSS: Main: 371838976 12:04:07 INFO - PROCESS | 1640 | 12:04:07 INFO - PROCESS | 1640 | __start_tp_report 12:04:07 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 12:04:07 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 12:04:07 INFO - PROCESS | 1640 | |i|pagename|runs| 12:04:07 INFO - PROCESS | 1640 | |0;dojo.html;2701.311165652759;3345.4647256438975;3353.8323083845803;3377.6284608693054;3412.4710669846168;5792.826215213545;5818.3308919474275;5829.679367634779;5844.532437405008;5846.210761547195;5788.768449262025;5861.150133230679;5881.794137205198;5887.35239123696;5887.764489420429;4628.606568441686;5276.551493123089;5289.576833853302;5385.272988146608;5390.353157621091;5182.611304152185;5262.000219958196;5272.23552584875;5286.867828304304;5411.134218525037;5286.973565132169;5293.947060529384;5297.602679799012;5371.650842695231;5381.354237491507;4393.604575588196;5385.919211211835;5395.514403703666;5404.83785486436;5425.131978883399;4963.60291176705;5107.8507335849135;5251.737413129366;5310.070737620901;5328.866778330534;5692.658440493584;5707.857303567403;5735.082386818089;5754.510866576346;5803.129530570406;6351.904721429182;6374.521910856704;6377.1709677742065;6377.362263773585;6385.106085148083;6216.502679785652;6313.147725057151;6317.5893566918;6319.5576309658345;6336.588121772116;5819.709014549256;5882.058870580687;5890.057590785539;5949.702514874239;5970.910436343458;6265.906011409833;6297.149884765498;6331.271903731038;6375.043743438521;6381.074744162163;6278.089676996809;6295.464885484785;6297.433231009231;6297.685115744194;6304.338044505353;6201.906971395432;6224.159738435344;6362.522810789209;6363.045543168561;6371.617702937839;6201.131841542097;6237.968810156011;6336.112944187817;6340.365963403623;6367.840803979938;5314.627976041717;6343.492520598341;6372.107904893319;6394.8721025579225;6404.871902562016;5032.899342013139;5038.294638750578;5066.569341605931;5088.084144853888;5110.514501122388;4468.128714900563;4477.171723231213;4484.12559550891;4497.595216430537;4582;5807.303123625192;5860.589758716849;5874.295084589877;5889.411058894162;5914;5139.640225184276;6233.501319894398;6263.467605253513;6278.623282603058;6377.936220637827;5817.534597232211;5826.126081087786;5830.271216097988;5898;5908.822735317947;5410.3507579090765;5461.481159289861;5557.44425557441;5558.86102847424;5571.192177134374;6247.812565623039;6258.843528911722;6278.466330361788;6345.682715864281;6352.428281454507;6342.985122380397;6344.68276586178;6347;6361.90457143134;6388.68056597159;6227.906581401373;6314.431701146918;6328.746850125944;6333.20834895638;6338.429541341301;6207.286162091236;6232.376762323732;6278.905816412849;6283.2460104787715;6369.044643303541;6325.304216536086;6341.175647165839;6353.110564521063;6355.300916899045;6359.8092057238355;4946.7031978079995;6145.016797312409;6191.535634827496;6220.626762394271;6236.376362363727;5897.882042359214;5949.762009519571;6118.663473509;6126.08108783686;6229.906551401642;6063.333033366414;6064.423879731595;6093.75624974996;6116.663583502772;6135.570510064253;6161.260648722182;6178.289496707936;6183.134361189527;6199.473044791062;6213.875722485434;5882.411758824254;5959.433853783884;6013.609115407485;6014.759409623741;6103.084537319438 12:04:07 INFO - PROCESS | 1640 | |1;ext.html;474.9337736780926;492.8817083899863;522.1827839431289;531.3942105999159;536.4447796530592;31424;37686;40885.59114408855;43227.35158972618;43246.78376608113;43466.56533434673;43833;43846.561534384644;43939;43953.56046439535;8424;9326.53367331634;9535;9552.952235238814;9558.426494410323;8443.535605541692;8644.567771611426;8648.524331161783;8649.740507784776;11144.832827507553;11238.381888996102;11422.371769552672;11432.828507572392;11448.599299024536;11454.140939429535;11374.886251137465;11432.542698292058;11438;11447.484863181135;11464.31214127155;8409.285210757092;8656.8701469478;11085.72285692856;11301.152413569016;11373.545058197662;41103.1779364414;41443.96390090242;41519.37720934188;41545.75362739123;41587.168256635;4024.3359845625437;4077.0622756765815;4094.529129150156;4104.199681062194;4116.320807066831;30052;30315.696843031506;30791.230219244473;31044.22389440282;31813.204669883205;3200.423923693734;3252.3007553376137;3257.088015355704;3270.280538281598;3296.75274354422;393714;397333;398270;399088;399399;65937.67031164814;66365.33634663688;66513.66743166253;66543.66728166328;66645.33354666489;69876;70048.64975675191;70073.64963175151;70084;70216.297837022;16387.508374748777;16911.323547058226;16962.83037169637;16980.896241744245;16983;12915.354232288348;12964.481420743065;12981.96144308453;12992.090553661343;13014.609561713163;15528.068315901082;16750.743694222983;17175.484735457958;19032.333868314818;19476.220951161795;6370.394812492806;7130.821729456805;7200.811866042044;7772.689092436352;7776.455648104691;829.2371018662844;877.2017464107631;895.5029958373035;897.1835629577184;923.2014307623857;27577.724222757915;29957.70042299549;30172;30516.542251866238;30892;1086.6577028236081;1087.521490544174;1088.7822435512771;1120.590984290728;1146.633077415236;15602.687946241012;15707.607309817346;15779.526614201362;15814.525564233092;16057.759133613004;609324;633716;641264;641659;642124;61445.692771535854;61757.764844702855;61801.690991544754;61839.38160618426;61901.69049154816;1432.477145841781;1449.2970909109074;1468.9118652880861;1472.9337179826935;1473.0940471610097;28256.85871570629;29891.103266902028;29995.250118747204;30215.848920755256;30264.72026262478;53616.195757062895;54322.72838635781;54329.45670543402;54398;54526;503090;505223;506118;507237;508230;41414.37878431886;41682.48417004151;42371;42693;42696.57303426926;46672;47501.7624911887;47689;48095.519044810506;48338;26444.735552644997;38835.805820970716;39696;39880.401793973695;41014.589854101076;38163.61836381712;38763;39091;39992.80003599964;40184.19631607293;36223.094422639646;38552.614473854905;38671.6132838668;38685.226295474495;38720;29013.854930726055;29393.85303073471;32862.34275314528;32897.01308960735;33692.49461258034;24326.270211893672;24695.38261543476;24729;24768.25695229146;25150.11974580881 12:04:07 INFO - PROCESS | 1640 | |2;jquery.html;368.2910397484841;384.3331819293526;387.7867173054821;395.86342711764433;417.18024082677533;15371.231438428076;16063.196840157989;20307.984600769956;22024.44938876525;22090.558188836214;20865.374038778824;21601.783982160214;21741.67387489189;22485.662715059287;22731;5554.444555544434;6044.093385992103;6054.727537260812;6126.203593532857;6214.446388402899;4276.743395396271;4478.708883922534;6093.725782339783;6133.417325354084;6145.60053596517;4466.531014243506;5284.735763211843;6765.154355705537;6839.794806155824;6853.348931851466;6605.339466053404;6803;6821.727130914757;6846.178458584952;6876.1748590169245;6017.819465416044;6021.187139736124;6021.42796434338;6030.849228769272;6044.184035155242;26175.607365889526;26314.473710525683;26641.86679066592;27207;27683.892644294203;2825.6044153818484;2832.603435519029;2833.8016338856287;2835.53213719736;2838.2762395589198;16050.919745401316;16165.353385864551;16267.10530920799;16270.430534931338;17082.487525374258;1872.5037864965796;1892.7917929027933;1906.5710215201607;1931.4881556387568;1937.680282753344;116420.41789791081;119855.99999999913;120545;120615;120699;10632.627858024933;10931.125509959184;11692.240004399688;11762.88237117635;11850.407479625985;14953.40186392554;15360.615984600474;15375.692486150214;15397.538073857802;15407.614809629626;8837.248833849066;9101.499417532099;9172.174504294511;9231.984481707006;9305;9081.364304498622;9093.90840106779;9102.044285350075;9247.907520924839;9271.35100542969;7540.095188577406;7698.191689872595;7719.729809456642;7734.265244801735;7763.573003484863;1933.0528041259681;1938.9224431022883;1956.3935180094215;2013.6476116679523;2019.7374341335826;1055.2191378379944;1080.9405482698528;1084;1094.9069329106956;1120.8374785656035;23854.926528306267;23875.641865372032;23966.801659917284;24018.51962960731;24216.394590135387;1076.321917192164;1092.1044743310567;1094.7482079121846;1102.9448527573588;1107.2968664897687;11605.419729013516;12293.446794894251;12447.066470014604;12512.81230781539;12540.310282934526;671074;713239;719745;720345;723908;136298;151141.48858511494;151577;154709.45290547176;155515.22242388714;1023.7133602591286;1033.4161198922584;1049.1397054415306;1055.9260851740305;1056.1920131099714;19487.415377538695;20224.539454290254;20481.180752769724;20701.792982069986;20817;59223.703881480316;59861.5591198053;60202.09696854463;60454.69772651108;60583.39416605778;79802.28938548754;82895.585522072;83224.16775832164;86261;86404.83987900353;6356.872862542631;7415.777526674208;7660.578668173304;7708.113566939874;8464.365172611955;12752.936235318764;12851.871481285441;13108.541201057917;13221.471141154247;13468;11414;11573.942130289632;11768.94115529417;11826.290422574673;11870.881291187323;10696.358218506915;11232.438378081226;11514.827277590675;11541.653750387502;11849.585264515701;11511.30932144074;11609.944844804842;11859.110566707704;11916.642500724993;11988.040956723615;6338.746450141943;6569.211694596679;7468.813279668052;7545.358644515278;7993.760187194393;8997.685081022133;11248.21262511649;11358.375289359165;11427.714307142389;11737.061035117 12:04:07 INFO - PROCESS | 1640 | |3;mootools.html;1426.6934543740851;1428.6714055767172;1435.1174027972793;1467.339697136289;1471.161437980351;8126.796830079244;8455.069942306342;8529.701460448885;8545.188207120329;8552.230299273064;7554.7355842545385;7787.104482984459;7813.218678132184;8148.837023259532;8351.83296334073;2302.804261637759;2350.976490235101;2356.4697942962866;2361.2562042956415;2362.7637236276405;2265.6261716816707;2281.0761641535205;2287.8627282363027;2298.977010229901;2303.986246051732;2310.503241803012;2324.62846920317;2336.170659415908;2342.320726989171;2348.8708121053337;2306.4695120122383;2314.525522267931;2330.382448651109;2334.7431782503827;2340.9297721068397;2304.493011537459;2373.299876536426;2374.584447721642;2375.038109565611;2378.9762102378927;7084.893726594105;8598.914010859873;8619.61211745473;8620.956895215546;8625.654973801104;4371.256886329332;5064.341635587387;5198.558122559549;5212.166053431432;5212.765425555859;3311.7350611950988;3410.9829450852835;3521.7006554442905;3562.946555801665;3594.3170797548382;1221.8106193540016;1238.9626919099512;1243.347242697582;1246.6820960655066;1266.5756971414587;10803.999999999922;11064.834027489595;11162.107031437465;11181.776364472746;11183.776324473465;4472.9776351118035;4690.624750019991;4709.693869898446;4772.403449568804;4796.25658023007;9704.75738106553;9722.27082968766;9725.02749725036;9730.221582273543;9751.317407781387;5336.599755018389;5340.572754179656;5340.732963351817;5345.705986170798;5348.732563371816;4099.754014759124;4540.750258735735;4736.881577960509;4807.254875494304;4869.683470574401;3854.171353159028;3860.208657225262;3928.685705143582;3959.7030222732833;3971.815501474178;1283.0890068051601;1283.666246775845;1287.7038281195378;1287.7488889666613;1299.0776548650374;804.617806541888;836.3392919593574;914.29599208609;922.3589605224305;927.8608208768603;5484;5591.944080559224;5623.915641265385;5751.827445176651;5950.553708471882;766.8542976834384;995.4425521707867;1006.4615430744517;1034.3897100710617;1038.85456036155;3644.2711457708565;3731.402975523903;3768.1144930941205;3808.1622043150464;3932.4887764590994;9860.753481163028;10051.648192313234;10191.184705223564;10210.183185345155;10251.794964100825;9952.054554817281;10088.142507886765;10089.495525223709;10119.59521619127;10120;6831.863362732618;7980.760577182694;8117.391195660349;8129.674813007414;8146.144654811278;5605.887882242251;5671.574631902541;5886.735096920564;5892.5285977122585;5935.228420305332;7122.893156602759;8704.564771761514;8705.956470217609;8791.604377802887;8829.470231786114;6987.755428559976;8817.206451419403;9047.909520904706;9063.32025098107;9068.863967040632;5825.2135961644635;6729.629870357177;6966.756163534252;7204.9279507204255;7243.23945985685;7627.389808815393;7699.191584883731;7700.075990880906;7719.073711154698;7982.321502672338;7067.081279433846;7173.031640728644;7200;7207.5675459472595;7333.596652184181;6997.965010174917;7043.542169758949;7056.470764692771;7067.646617669199;7135.750248741269;6467.029945508023;6467.773627923;6537.378948999837;6540.934590654033;6543;5030;5049.5960323174795;5056.7724452399;5096.490350965022;5099.6175286852895;4100.610442008005;5020.949790502194;5031.245313203049;5043.268726034631;5145.382554093533 12:04:07 INFO - PROCESS | 1640 | |4;prototype.html;353.29165024126627;360.702420503085;362.1742427265835;373.27398210480607;374.11521751058757;4691.6950398224135;5062.2406639004075;5134;5303.151495760679;5339.919901201485;4251.978740106303;4455.688101832865;5001.748164427346;5227.242049902762;5227.660202086861;3377.7635565510423;3775.3954569307934;3777.2067865748227;4111.958880411203;4174.20690068886;3433.3819912415756;3464.428369319059;3841.1357444574887;4059;4182.260619294367;4111.691623128278;4136.566649680758;4139.503259608836;4175.31107367284;4182.97908510457;3252.1056709404984;3592.568891733009;3782.1490164712995;4087.05997620546;4099.754014759124;3662.176010397666;3667.688246499051;3672.0452682302794;3672.7612705174347;3682.6615099411797;4458.4426946631675;4895.828645997409;4940.098062246026;5135.204043373283;5185.22221666753;3969.8015099245213;3999.8800035998966;4183.91632167358;4731.668783185179;4754.762261886926;5005.422207563108;5157.53582177602;5544.0575102232715;5545.390007099216;5568.972155139239;3763.6989040876665;4020.8994775130855;4022.5776293489057;4023.5574086850424;4029.8388064477385;4745.477997420281;5064.468230835746;5591.875087466737;5819.166962406828;5830.883382332372;3323.7673362864366;3463.688268055887;4114.403411505315;4128.545859955402;4159.9376009359885;3341.7159541438764;3635.309291234657;4093.85671501496;4179.185058913483;4206.915861682749;3712.7747843211673;3784.299904517673;4133.5611988926075;4523.683342166017;4526.7510286933875;5523.171524271311;5535.474129957647;5535.529479994165;5554.805581804699;5572.136318870582;979.3536266064506;1078.5308390850005;1178.6051672689746;1192.5647138794277;1200.2138599217526;732.8314487667759;830.6179157587577;857.0486759696731;864.5849992003873;871.9825603487894;4348.304271316574;4421.137878113801;4703.929441058387;4827.324174615556;4889.853304400874;4807.399075115611;4997.775100120503;5361.27622770921;5374.596905232123;5383.765737219089;4672.57946784791;5154.9484505155215;5169.759257778106;5198.142306519382;5235.345581802275;2403.90859951843;2649.615346188446;2807.1438211345735;2849.5155823510054;2882.1497658190883;4817.421909370828;5098.872528186751;5138.614603904722;5600.943990560124;5632;5323.281357016753;5504.394516603171;5532.806351777668;5566.610337276433;5591.700896471101;5016.523430274118;5046.899062018739;5242.554382877498;5598.880223955144;5626.887462250732;4935.481774413634;5219.712915789668;5283.630145889751;5325.893482130413;5369.973150134224;4635.745034023161;5050.742271235106;5288.867778305573;5305.734713264398;5356.651817631841;4958.925466210972;5132.307138536399;5225.399079105951;5500.642458240201;5531.096174508415;3524.7356448266996;3574.767640103385;3619.131408462003;3868.0909986153792;3904.6876249900506;4627.755538563862;5627.662340259598;5659.660420374791;5670.603057785916;5671.432856714296;5164.561012313845;5203.985222881502;5484.725763711878;5497.835064948058;5521.806736764354;5179.792808287626;5447.346318441812;5492.1212605982855;5521.66869987786;5525.182157099827;4724.456687480983;4915.188993816123;5153.7165455900285;5293.841184764463;5369.234844055392;5245.344331958505;5270.7101109439345;5511.090670039559;5595.496405323541;5604.6917419542315;5185.351831021122;5422.701751403711;5425.240466334795;5434.809781657623;5449.910017996496 12:04:07 INFO - PROCESS | 1640 | |5;yui.html;727.3163226567027;737.2111840330841;762.5386641082146;834.1200033964167;862.0129951205868;15015.324310406031;15793.526194214162;15856.445024424147;15972.2013899305;15991.84008159918;14277.071990320623;14419.495317663885;14426.278686065707;14435.566932992027;15486.303116359762;695.2942763095436;697.8171998462608;709.9929000710005;744.4416687484387;841.3227351981637;846.1115828380207;874.9693760718376;877.9473231606124;881.8368601808686;882.8499155143609;897.7755561109723;921.4333185091187;923.9538023098852;924.5377311344328;926.9860952085725;718.2996578336107;736.91157061153;887.1394747095308;903.6069309850236;913.3789023464042;685.1127789512593;686.1080595226186;688.198249039868;690.2303931116819;692.6744430117836;15288.541343759705;15294.617634559114;15684.76472852908;15711.450099246586;15734.921325393414;13483.325833708373;13745.587632371045;13774.035817492779;13800.447982080705;13949.651258718512;12726.745465090646;12751.42618582166;12778.808317875239;12938.288394138319;13058.804117938143;4431.468223813163;4444.533324000966;4469.642428605736;4479.216137176014;4638.420197475316;100458;100594;100907.49546252296;101019;104714.99999999924;10520.158387328995;10828.837567436494;10871.239013269153;10920.344779313107;11139.777204455866;22080.779192208192;22155.00302486392;22287.219947302092;22454.43863903383;22527.774722252896;7580.431467639949;7673.884891726629;7864.174261702553;7897.549582360141;8096.5546894921345;4219.367094935723;4236.512801027921;4391.60475557195;4408.669349798778;4494.9325760113625;3032.5147976323683;3684.9447258291148;3690.6309369063415;3723.4414837774007;3735.7198210134347;590.5983930927011;656.6651007985962;664.597918259446;666.0608541955819;667.4827009068011;556.2962851992233;572.7651662818224;575.7984705353093;641.7048157847443;646.5646265291047;10057.346272492265;10309.226807989431;10558.260921735558;10582.682519524427;10749.83875241872;588.3704436253169;609.0742072050458;611.0498175337304;661.3948237362855;715.9355657990806;4498.278541482421;4586.059857729158;4914.280001999343;4916.582090522345;4926.45808961014;69188;81657.59171204106;84077;89209.55395223112;90475;66460;77013;78142.60928695434;79030;84047.5797621008;69181.65409172921;71316;73090;73696.63151684101;74721.6263918677;9519.904800951901;10599;10602.20483463728;10876.728081798019;11014.008739213188;47037;47090.76454617842;47230.76384618055;47841.80395490141;48131.19071131415;60486.69756651189;62140;62225;63768.724625508155;64667.02999454918;12504.124711270124;12638.873611263769;12796.232226066466;13314.231325970199;13474;14239.928800355932;14466.493672721404;14835.851641483447;15286.312115954586;15317.080975141527;12995.545155919497;13919.164850109026;13958.371873265525;14087.08433951831;14443;11117.944410277896;13687.97340199509;13719.314034298444;13773.311334433438;14261.928690356483;13316.201027938354;13445.058845880694;13477.056606037484;13931.024828261925;13997.790033149715;9803.754906127118;11127.83308250393;11317.434128293387;11765.588204412805;11959.880401195876;8618.008928972997;10551.366917984946;11023.338599684044;11051.834222486508;11084.49066019819 12:04:07 INFO - PROCESS | 1640 | __end_tp_report 12:04:07 INFO - PROCESS | 1640 | __start_cc_report 12:04:07 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,1360 12:04:07 INFO - PROCESS | 1640 | __end_cc_report 12:04:07 INFO - PROCESS | 1640 | __startTimestamp1485806647367__endTimestamp 12:04:07 INFO - PROCESS | 1640 | 12:04:07 INFO - PROCESS | 1640 | ------- Summary: start ------- 12:04:07 INFO - PROCESS | 1640 | Number of tests: 6 12:04:07 INFO - PROCESS | 1640 | 12:04:07 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5805.06 Median:6013.61 stddev:677.22 (11.3%) stddev-sans-first:634.02 12:04:07 INFO - PROCESS | 1640 | Values: 2701.3 3345.5 3353.8 3377.6 3412.5 5792.8 5818.3 5829.7 5844.5 5846.2 5788.8 5861.2 5881.8 5887.4 5887.8 4628.6 5276.6 5289.6 5385.3 5390.4 5182.6 5262.0 5272.2 5286.9 5411.1 5287.0 5293.9 5297.6 5371.7 5381.4 4393.6 5385.9 5395.5 5404.8 5425.1 4963.6 5107.9 5251.7 5310.1 5328.9 5692.7 5707.9 5735.1 5754.5 5803.1 6351.9 6374.5 6377.2 6377.4 6385.1 6216.5 6313.1 6317.6 6319.6 6336.6 5819.7 5882.1 5890.1 5949.7 5970.9 6265.9 6297.1 6331.3 6375.0 6381.1 6278.1 6295.5 6297.4 6297.7 6304.3 6201.9 6224.2 6362.5 6363.0 6371.6 6201.1 6238.0 6336.1 6340.4 6367.8 5314.6 6343.5 6372.1 6394.9 6404.9 5032.9 5038.3 5066.6 5088.1 5110.5 4468.1 4477.2 4484.1 4497.6 4582.0 5807.3 5860.6 5874.3 5889.4 5914.0 5139.6 6233.5 6263.5 6278.6 6377.9 5817.5 5826.1 5830.3 5898.0 5908.8 5410.4 5461.5 5557.4 5558.9 5571.2 6247.8 6258.8 6278.5 6345.7 6352.4 6343.0 6344.7 6347.0 6361.9 6388.7 6227.9 6314.4 6328.7 6333.2 6338.4 6207.3 6232.4 6278.9 6283.2 6369.0 6325.3 6341.2 6353.1 6355.3 6359.8 4946.7 6145.0 6191.5 6220.6 6236.4 5897.9 5949.8 6118.7 6126.1 6229.9 6063.3 6064.4 6093.8 6116.7 6135.6 6161.3 6178.3 6183.1 6199.5 6213.9 5882.4 5959.4 6013.6 6014.8 6103.1 12:04:07 INFO - PROCESS | 1640 | 12:04:07 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:66620.98 Median:219484.20 stddev:138993.53 (63.3%) stddev-sans-first:139294.71 12:04:07 INFO - PROCESS | 1640 | Values: 474.9 492.9 522.2 531.4 536.4 31424.0 37686.0 40885.6 43227.4 43246.8 43466.6 43833.0 43846.6 43939.0 43953.6 8424.0 9326.5 9535.0 9553.0 9558.4 8443.5 8644.6 8648.5 8649.7 11144.8 11238.4 11422.4 11432.8 11448.6 11454.1 11374.9 11432.5 11438.0 11447.5 11464.3 8409.3 8656.9 11085.7 11301.2 11373.5 41103.2 41444.0 41519.4 41545.8 41587.2 4024.3 4077.1 4094.5 4104.2 4116.3 30052.0 30315.7 30791.2 31044.2 31813.2 3200.4 3252.3 3257.1 3270.3 3296.8 393714.0 397333.0 398270.0 399088.0 399399.0 65937.7 66365.3 66513.7 66543.7 66645.3 69876.0 70048.6 70073.6 70084.0 70216.3 16387.5 16911.3 16962.8 16980.9 16983.0 12915.4 12964.5 12982.0 12992.1 13014.6 15528.1 16750.7 17175.5 19032.3 19476.2 6370.4 7130.8 7200.8 7772.7 7776.5 829.2 877.2 895.5 897.2 923.2 27577.7 29957.7 30172.0 30516.5 30892.0 1086.7 1087.5 1088.8 1120.6 1146.6 15602.7 15707.6 15779.5 15814.5 16057.8 609324.0 633716.0 641264.0 641659.0 642124.0 61445.7 61757.8 61801.7 61839.4 61901.7 1432.5 1449.3 1468.9 1472.9 1473.1 28256.9 29891.1 29995.3 30215.8 30264.7 53616.2 54322.7 54329.5 54398.0 54526.0 503090.0 505223.0 506118.0 507237.0 508230.0 41414.4 41682.5 42371.0 42693.0 42696.6 46672.0 47501.8 47689.0 48095.5 48338.0 26444.7 38835.8 39696.0 39880.4 41014.6 38163.6 38763.0 39091.0 39992.8 40184.2 36223.1 38552.6 38671.6 38685.2 38720.0 29013.9 29393.9 32862.3 32897.0 33692.5 24326.3 24695.4 24729.0 24768.3 25150.1 12:04:07 INFO - PROCESS | 1640 | 12:04:07 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:39738.82 Median:22057.50 stddev:118082.62 (535.3%) stddev-sans-first:118376.87 12:04:07 INFO - PROCESS | 1640 | Values: 368.3 384.3 387.8 395.9 417.2 15371.2 16063.2 20308.0 22024.4 22090.6 20865.4 21601.8 21741.7 22485.7 22731.0 5554.4 6044.1 6054.7 6126.2 6214.4 4276.7 4478.7 6093.7 6133.4 6145.6 4466.5 5284.7 6765.2 6839.8 6853.3 6605.3 6803.0 6821.7 6846.2 6876.2 6017.8 6021.2 6021.4 6030.8 6044.2 26175.6 26314.5 26641.9 27207.0 27683.9 2825.6 2832.6 2833.8 2835.5 2838.3 16050.9 16165.4 16267.1 16270.4 17082.5 1872.5 1892.8 1906.6 1931.5 1937.7 116420.4 119856.0 120545.0 120615.0 120699.0 10632.6 10931.1 11692.2 11762.9 11850.4 14953.4 15360.6 15375.7 15397.5 15407.6 8837.2 9101.5 9172.2 9232.0 9305.0 9081.4 9093.9 9102.0 9247.9 9271.4 7540.1 7698.2 7719.7 7734.3 7763.6 1933.1 1938.9 1956.4 2013.6 2019.7 1055.2 1080.9 1084.0 1094.9 1120.8 23854.9 23875.6 23966.8 24018.5 24216.4 1076.3 1092.1 1094.7 1102.9 1107.3 11605.4 12293.4 12447.1 12512.8 12540.3 671074.0 713239.0 719745.0 720345.0 723908.0 136298.0 151141.5 151577.0 154709.5 155515.2 1023.7 1033.4 1049.1 1055.9 1056.2 19487.4 20224.5 20481.2 20701.8 20817.0 59223.7 59861.6 60202.1 60454.7 60583.4 79802.3 82895.6 83224.2 86261.0 86404.8 6356.9 7415.8 7660.6 7708.1 8464.4 12752.9 12851.9 13108.5 13221.5 13468.0 11414.0 11573.9 11768.9 11826.3 11870.9 10696.4 11232.4 11514.8 11541.7 11849.6 11511.3 11609.9 11859.1 11916.6 11988.0 6338.7 6569.2 7468.8 7545.4 7993.8 8997.7 11248.2 11358.4 11427.7 11737.1 12:04:07 INFO - PROCESS | 1640 | 12:04:07 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5432.56 Median:5098.05 stddev:2938.71 (57.6%) stddev-sans-first:2931.53 12:04:07 INFO - PROCESS | 1640 | Values: 1426.7 1428.7 1435.1 1467.3 1471.2 8126.8 8455.1 8529.7 8545.2 8552.2 7554.7 7787.1 7813.2 8148.8 8351.8 2302.8 2351.0 2356.5 2361.3 2362.8 2265.6 2281.1 2287.9 2299.0 2304.0 2310.5 2324.6 2336.2 2342.3 2348.9 2306.5 2314.5 2330.4 2334.7 2340.9 2304.5 2373.3 2374.6 2375.0 2379.0 7084.9 8598.9 8619.6 8621.0 8625.7 4371.3 5064.3 5198.6 5212.2 5212.8 3311.7 3411.0 3521.7 3562.9 3594.3 1221.8 1239.0 1243.3 1246.7 1266.6 10804.0 11064.8 11162.1 11181.8 11183.8 4473.0 4690.6 4709.7 4772.4 4796.3 9704.8 9722.3 9725.0 9730.2 9751.3 5336.6 5340.6 5340.7 5345.7 5348.7 4099.8 4540.8 4736.9 4807.3 4869.7 3854.2 3860.2 3928.7 3959.7 3971.8 1283.1 1283.7 1287.7 1287.7 1299.1 804.6 836.3 914.3 922.4 927.9 5484.0 5591.9 5623.9 5751.8 5950.6 766.9 995.4 1006.5 1034.4 1038.9 3644.3 3731.4 3768.1 3808.2 3932.5 9860.8 10051.6 10191.2 10210.2 10251.8 9952.1 10088.1 10089.5 10119.6 10120.0 6831.9 7980.8 8117.4 8129.7 8146.1 5605.9 5671.6 5886.7 5892.5 5935.2 7122.9 8704.6 8706.0 8791.6 8829.5 6987.8 8817.2 9047.9 9063.3 9068.9 5825.2 6729.6 6966.8 7204.9 7243.2 7627.4 7699.2 7700.1 7719.1 7982.3 7067.1 7173.0 7200.0 7207.6 7333.6 6998.0 7043.5 7056.5 7067.6 7135.8 6467.0 6467.8 6537.4 6540.9 6543.0 5030.0 5049.6 5056.8 5096.5 5099.6 4100.6 5020.9 5031.2 5043.3 5145.4 12:04:07 INFO - PROCESS | 1640 | 12:04:07 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4391.36 Median:4999.76 stddev:1331.56 (26.6%) stddev-sans-first:1300.34 12:04:07 INFO - PROCESS | 1640 | Values: 353.3 360.7 362.2 373.3 374.1 4691.7 5062.2 5134.0 5303.2 5339.9 4252.0 4455.7 5001.7 5227.2 5227.7 3377.8 3775.4 3777.2 4112.0 4174.2 3433.4 3464.4 3841.1 4059.0 4182.3 4111.7 4136.6 4139.5 4175.3 4183.0 3252.1 3592.6 3782.1 4087.1 4099.8 3662.2 3667.7 3672.0 3672.8 3682.7 4458.4 4895.8 4940.1 5135.2 5185.2 3969.8 3999.9 4183.9 4731.7 4754.8 5005.4 5157.5 5544.1 5545.4 5569.0 3763.7 4020.9 4022.6 4023.6 4029.8 4745.5 5064.5 5591.9 5819.2 5830.9 3323.8 3463.7 4114.4 4128.5 4159.9 3341.7 3635.3 4093.9 4179.2 4206.9 3712.8 3784.3 4133.6 4523.7 4526.8 5523.2 5535.5 5535.5 5554.8 5572.1 979.4 1078.5 1178.6 1192.6 1200.2 732.8 830.6 857.0 864.6 872.0 4348.3 4421.1 4703.9 4827.3 4889.9 4807.4 4997.8 5361.3 5374.6 5383.8 4672.6 5154.9 5169.8 5198.1 5235.3 2403.9 2649.6 2807.1 2849.5 2882.1 4817.4 5098.9 5138.6 5600.9 5632.0 5323.3 5504.4 5532.8 5566.6 5591.7 5016.5 5046.9 5242.6 5598.9 5626.9 4935.5 5219.7 5283.6 5325.9 5370.0 4635.7 5050.7 5288.9 5305.7 5356.7 4958.9 5132.3 5225.4 5500.6 5531.1 3524.7 3574.8 3619.1 3868.1 3904.7 4627.8 5627.7 5659.7 5670.6 5671.4 5164.6 5204.0 5484.7 5497.8 5521.8 5179.8 5447.3 5492.1 5521.7 5525.2 4724.5 4915.2 5153.7 5293.8 5369.2 5245.3 5270.7 5511.1 5595.5 5604.7 5185.4 5422.7 5425.2 5434.8 5449.9 12:04:07 INFO - PROCESS | 1640 | 12:04:07 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:19236.72 Median:4420.07 stddev:26170.52 (592.1%) stddev-sans-first:26207.03 12:04:07 INFO - PROCESS | 1640 | Values: 727.3 737.2 762.5 834.1 862.0 15015.3 15793.5 15856.4 15972.2 15991.8 14277.1 14419.5 14426.3 14435.6 15486.3 695.3 697.8 710.0 744.4 841.3 846.1 875.0 877.9 881.8 882.8 897.8 921.4 924.0 924.5 927.0 718.3 736.9 887.1 903.6 913.4 685.1 686.1 688.2 690.2 692.7 15288.5 15294.6 15684.8 15711.5 15734.9 13483.3 13745.6 13774.0 13800.4 13949.7 12726.7 12751.4 12778.8 12938.3 13058.8 4431.5 4444.5 4469.6 4479.2 4638.4 100458.0 100594.0 100907.5 101019.0 104715.0 10520.2 10828.8 10871.2 10920.3 11139.8 22080.8 22155.0 22287.2 22454.4 22527.8 7580.4 7673.9 7864.2 7897.5 8096.6 4219.4 4236.5 4391.6 4408.7 4494.9 3032.5 3684.9 3690.6 3723.4 3735.7 590.6 656.7 664.6 666.1 667.5 556.3 572.8 575.8 641.7 646.6 10057.3 10309.2 10558.3 10582.7 10749.8 588.4 609.1 611.0 661.4 715.9 4498.3 4586.1 4914.3 4916.6 4926.5 69188.0 81657.6 84077.0 89209.6 90475.0 66460.0 77013.0 78142.6 79030.0 84047.6 69181.7 71316.0 73090.0 73696.6 74721.6 9519.9 10599.0 10602.2 10876.7 11014.0 47037.0 47090.8 47230.8 47841.8 48131.2 60486.7 62140.0 62225.0 63768.7 64667.0 12504.1 12638.9 12796.2 13314.2 13474.0 14239.9 14466.5 14835.9 15286.3 15317.1 12995.5 13919.2 13958.4 14087.1 14443.0 11117.9 13688.0 13719.3 13773.3 14261.9 13316.2 13445.1 13477.1 13931.0 13997.8 9803.8 11127.8 11317.4 11765.6 11959.9 8618.0 10551.4 11023.3 11051.8 11084.5 12:04:07 INFO - PROCESS | 1640 | -------- Summary: end -------- 12:04:07 INFO - PROCESS | 1640 | 12:04:08 INFO - TEST-INFO | 1640: exit 0 12:04:08 INFO - TEST-OK | dromaeo_css | took 1117976ms 12:04:08 INFO - TEST-START | kraken 12:04:08 INFO - operating with platform_type : mac_ 12:04:08 INFO - Initialising browser for kraken test... 12:04:08 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmp7IwbBh/profile http://localhost:49241/getInfo.html) 12:04:10 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 12:04:10 INFO - PROCESS | 1650 | colorDepth:24 12:04:10 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 12:04:10 INFO - PROCESS | 1650 | __metrics 12:04:10 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:04:10 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:04:11 INFO - TEST-INFO | 1650: exit 0 12:04:11 INFO - Browser initialized. 12:04:11 INFO - Running cycle 1/1 for kraken test... 12:04:11 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmp7IwbBh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:04:23 INFO - PROCESS | 1651 | RSS: Main: 212647936 12:04:23 INFO - PROCESS | 1651 | 12:04:25 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 12:04:26 INFO - PROCESS | 1651 | RSS: Main: 265428992 12:04:26 INFO - PROCESS | 1651 | 12:04:29 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 12:04:29 INFO - PROCESS | 1651 | RSS: Main: 274595840 12:04:29 INFO - PROCESS | 1651 | 12:04:33 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 12:04:33 INFO - PROCESS | 1651 | RSS: Main: 372568064 12:04:33 INFO - PROCESS | 1651 | 12:04:35 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 12:04:36 INFO - PROCESS | 1651 | RSS: Main: 276471808 12:04:36 INFO - PROCESS | 1651 | 12:04:38 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:04:38 INFO - PROCESS | 1651 | RSS: Main: 276832256 12:04:38 INFO - PROCESS | 1651 | 12:04:41 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 12:04:42 INFO - PROCESS | 1651 | RSS: Main: 315252736 12:04:42 INFO - PROCESS | 1651 | 12:04:45 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 12:04:45 INFO - PROCESS | 1651 | RSS: Main: 316534784 12:04:45 INFO - PROCESS | 1651 | 12:04:48 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 12:04:49 INFO - PROCESS | 1651 | RSS: Main: 315183104 12:04:49 INFO - PROCESS | 1651 | 12:04:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:04:51 INFO - PROCESS | 1651 | RSS: Main: 294498304 12:04:51 INFO - PROCESS | 1651 | 12:04:53 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:04:54 INFO - PROCESS | 1651 | RSS: Main: 295903232 12:04:54 INFO - PROCESS | 1651 | 12:04:56 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:04:56 INFO - PROCESS | 1651 | RSS: Main: 298115072 12:04:56 INFO - PROCESS | 1651 | 12:04:59 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:05:00 INFO - PROCESS | 1651 | RSS: Main: 316616704 12:05:00 INFO - PROCESS | 1651 | 12:05:03 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:05:04 INFO - PROCESS | 1651 | RSS: Main: 310132736 12:05:04 INFO - PROCESS | 1651 | 12:05:05 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 12:05:06 INFO - PROCESS | 1651 | RSS: Main: 354680832 12:05:06 INFO - PROCESS | 1651 | 12:05:06 INFO - PROCESS | 1651 | __start_tp_report 12:05:06 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 12:05:06 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 12:05:06 INFO - PROCESS | 1651 | |i|pagename|runs| 12:05:06 INFO - PROCESS | 1651 | |0;ai-astar;117;109;115;114;113;115;112;114;114;114 12:05:06 INFO - PROCESS | 1651 | |1;audio-beat-detection;136;110;109;142;109;109;110;115;158;141 12:05:06 INFO - PROCESS | 1651 | |2;audio-dft;188;187;183;185;185;185;183;187;185;185 12:05:06 INFO - PROCESS | 1651 | |3;audio-fft;84;58;58;88;61;59;58;59;73;58 12:05:06 INFO - PROCESS | 1651 | |4;audio-oscillator;87;69;85;69;68;68;80;67;69;81 12:05:06 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;89;86;88;85;87;85;93;132;112;85 12:05:06 INFO - PROCESS | 1651 | |6;imaging-darkroom;94;94;94;93;94;93;94;93;93;93 12:05:06 INFO - PROCESS | 1651 | |7;imaging-desaturate;85;88;89;86;89;88;87;84;87;84 12:05:06 INFO - PROCESS | 1651 | |8;json-parse-financial;54;53;54;58;57;56;57;58;58;57 12:05:06 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;66;69;81;75;73;69;70;70;72;72 12:05:06 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;86;85;94;101;102;97;84;85;85;85 12:05:06 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;149;139;139;140;138;142;141;143;187;170 12:05:06 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;171;171;169;169;169;170;169;168;167;168 12:05:06 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;66;64;66;63;66;69;80;85;83;83 12:05:06 INFO - PROCESS | 1651 | __end_tp_report 12:05:06 INFO - PROCESS | 1651 | __start_cc_report 12:05:06 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1940 12:05:06 INFO - PROCESS | 1651 | __end_cc_report 12:05:06 INFO - PROCESS | 1651 | __startTimestamp1485806706102__endTimestamp 12:05:06 INFO - PROCESS | 1651 | 12:05:06 INFO - PROCESS | 1651 | ------- Summary: start ------- 12:05:06 INFO - PROCESS | 1651 | Number of tests: 14 12:05:06 INFO - PROCESS | 1651 | 12:05:06 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:2.11 (1.9%) stddev-sans-first:1.87 12:05:06 INFO - PROCESS | 1651 | Values: 117.0 109.0 115.0 114.0 113.0 115.0 112.0 114.0 114.0 114.0 12:05:06 INFO - PROCESS | 1651 | 12:05:06 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:123.90 Median:125.50 stddev:18.44 (14.7%) stddev-sans-first:19.03 12:05:06 INFO - PROCESS | 1651 | Values: 136.0 110.0 109.0 142.0 109.0 109.0 110.0 115.0 158.0 141.0 12:05:06 INFO - PROCESS | 1651 | 12:05:06 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:185.30 Median:185.00 stddev:1.64 (0.9%) stddev-sans-first:1.41 12:05:06 INFO - PROCESS | 1651 | Values: 188.0 187.0 183.0 185.0 185.0 185.0 183.0 187.0 185.0 185.0 12:05:06 INFO - PROCESS | 1651 | 12:05:06 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:65.60 Median:60.00 stddev:11.71 (19.5%) stddev-sans-first:10.36 12:05:06 INFO - PROCESS | 1651 | Values: 84.0 58.0 58.0 88.0 61.0 59.0 58.0 59.0 73.0 58.0 12:05:06 INFO - PROCESS | 1651 | 12:05:06 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:74.30 Median:74.50 stddev:7.96 (10.7%) stddev-sans-first:6.99 12:05:06 INFO - PROCESS | 1651 | Values: 87.0 69.0 85.0 69.0 68.0 68.0 80.0 67.0 69.0 81.0 12:05:06 INFO - PROCESS | 1651 | 12:05:06 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:94.20 Median:86.50 stddev:15.58 (18.0%) stddev-sans-first:16.41 12:05:06 INFO - PROCESS | 1651 | Values: 89.0 86.0 88.0 85.0 87.0 85.0 93.0 132.0 112.0 85.0 12:05:06 INFO - PROCESS | 1651 | 12:05:06 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:94.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 12:05:06 INFO - PROCESS | 1651 | Values: 94.0 94.0 94.0 93.0 94.0 93.0 94.0 93.0 93.0 93.0 12:05:06 INFO - PROCESS | 1651 | 12:05:06 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:86.70 Median:87.50 stddev:1.89 (2.2%) stddev-sans-first:1.90 12:05:06 INFO - PROCESS | 1651 | Values: 85.0 88.0 89.0 86.0 89.0 88.0 87.0 84.0 87.0 84.0 12:05:06 INFO - PROCESS | 1651 | 12:05:06 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:57.00 stddev:1.87 (3.3%) stddev-sans-first:1.81 12:05:06 INFO - PROCESS | 1651 | Values: 54.0 53.0 54.0 58.0 57.0 56.0 57.0 58.0 58.0 57.0 12:05:06 INFO - PROCESS | 1651 | 12:05:06 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.00 stddev:4.11 (5.7%) stddev-sans-first:3.81 12:05:06 INFO - PROCESS | 1651 | Values: 66.0 69.0 81.0 75.0 73.0 69.0 70.0 70.0 72.0 72.0 12:05:06 INFO - PROCESS | 1651 | 12:05:06 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:90.40 Median:85.00 stddev:7.31 (8.6%) stddev-sans-first:7.57 12:05:06 INFO - PROCESS | 1651 | Values: 86.0 85.0 94.0 101.0 102.0 97.0 84.0 85.0 85.0 85.0 12:05:06 INFO - PROCESS | 1651 | 12:05:06 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:148.80 Median:142.50 stddev:16.45 (11.5%) stddev-sans-first:17.45 12:05:06 INFO - PROCESS | 1651 | Values: 149.0 139.0 139.0 140.0 138.0 142.0 141.0 143.0 187.0 170.0 12:05:06 INFO - PROCESS | 1651 | 12:05:06 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:169.00 stddev:1.29 (0.8%) stddev-sans-first:1.17 12:05:06 INFO - PROCESS | 1651 | Values: 171.0 171.0 169.0 169.0 169.0 170.0 169.0 168.0 167.0 168.0 12:05:06 INFO - PROCESS | 1651 | 12:05:06 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:74.50 stddev:9.03 (12.1%) stddev-sans-first:9.27 12:05:06 INFO - PROCESS | 1651 | Values: 66.0 64.0 66.0 63.0 66.0 69.0 80.0 85.0 83.0 83.0 12:05:06 INFO - PROCESS | 1651 | -------- Summary: end -------- 12:05:06 INFO - PROCESS | 1651 | 12:05:06 INFO - TEST-INFO | 1651: exit 0 12:05:07 INFO - TEST-OK | kraken | took 59000ms 12:05:07 INFO - SUITE-END | took 1176s 12:05:07 INFO - Completed test suite (00:19:37) 12:05:07 INFO - javascript benchmark 12:05:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2701.311165652759, 3345.4647256438975, 3353.8323083845803, 3377.6284608693054, 3412.4710669846168, 5792.826215213545, 5818.3308919474275, 5829.679367634779, 5844.532437405008, 5846.210761547195, 5788.768449262025, 5861.150133230679, 5881.794137205198, 5887.35239123696, 5887.764489420429, 4628.606568441686, 5276.551493123089, 5289.576833853302, 5385.272988146608, 5390.353157621091, 5182.611304152185, 5262.000219958196, 5272.23552584875, 5286.867828304304, 5411.134218525037, 5286.973565132169, 5293.947060529384, 5297.602679799012, 5371.650842695231, 5381.354237491507, 4393.604575588196, 5385.919211211835, 5395.514403703666, 5404.83785486436, 5425.131978883399, 4963.60291176705, 5107.8507335849135, 5251.737413129366, 5310.070737620901, 5328.866778330534, 5692.658440493584, 5707.857303567403, 5735.082386818089, 5754.510866576346, 5803.129530570406, 6351.904721429182, 6374.521910856704, 6377.1709677742065, 6377.362263773585, 6385.106085148083, 6216.502679785652, 6313.147725057151, 6317.5893566918, 6319.5576309658345, 6336.588121772116, 5819.709014549256, 5882.058870580687, 5890.057590785539, 5949.702514874239, 5970.910436343458, 6265.906011409833, 6297.149884765498, 6331.271903731038, 6375.043743438521, 6381.074744162163, 6278.089676996809, 6295.464885484785, 6297.433231009231, 6297.685115744194, 6304.338044505353, 6201.906971395432, 6224.159738435344, 6362.522810789209, 6363.045543168561, 6371.617702937839, 6201.131841542097, 6237.968810156011, 6336.112944187817, 6340.365963403623, 6367.840803979938, 5314.627976041717, 6343.492520598341, 6372.107904893319, 6394.8721025579225, 6404.871902562016, 5032.899342013139, 5038.294638750578, 5066.569341605931, 5088.084144853888, 5110.514501122388, 4468.128714900563, 4477.171723231213, 4484.12559550891, 4497.595216430537, 4582.0, 5807.303123625192, 5860.589758716849, 5874.295084589877, 5889.411058894162, 5914.0, 5139.640225184276, 6233.501319894398, 6263.467605253513, 6278.623282603058, 6377.936220637827, 5817.534597232211, 5826.126081087786, 5830.271216097988, 5898.0, 5908.822735317947, 5410.3507579090765, 5461.481159289861, 5557.44425557441, 5558.86102847424, 5571.192177134374, 6247.812565623039, 6258.843528911722, 6278.466330361788, 6345.682715864281, 6352.428281454507, 6342.985122380397, 6344.68276586178, 6347.0, 6361.90457143134, 6388.68056597159, 6227.906581401373, 6314.431701146918, 6328.746850125944, 6333.20834895638, 6338.429541341301, 6207.286162091236, 6232.376762323732, 6278.905816412849, 6283.2460104787715, 6369.044643303541, 6325.304216536086, 6341.175647165839, 6353.110564521063, 6355.300916899045, 6359.8092057238355, 4946.7031978079995, 6145.016797312409, 6191.535634827496, 6220.626762394271, 6236.376362363727, 5897.882042359214, 5949.762009519571, 6118.663473509, 6126.08108783686, 6229.906551401642, 6063.333033366414, 6064.423879731595, 6093.75624974996, 6116.663583502772, 6135.570510064253, 6161.260648722182, 6178.289496707936, 6183.134361189527, 6199.473044791062, 6213.875722485434, 5882.411758824254, 5959.433853783884, 6013.609115407485, 6014.759409623741, 6103.084537319438], "value": 5760.241748562815, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.9337736780926, 492.8817083899863, 522.1827839431289, 531.3942105999159, 536.4447796530592, 31424.0, 37686.0, 40885.59114408855, 43227.35158972618, 43246.78376608113, 43466.56533434673, 43833.0, 43846.561534384644, 43939.0, 43953.56046439535, 8424.0, 9326.53367331634, 9535.0, 9552.952235238814, 9558.426494410323, 8443.535605541692, 8644.567771611426, 8648.524331161783, 8649.740507784776, 11144.832827507553, 11238.381888996102, 11422.371769552672, 11432.828507572392, 11448.599299024536, 11454.140939429535, 11374.886251137465, 11432.542698292058, 11438.0, 11447.484863181135, 11464.31214127155, 8409.285210757092, 8656.8701469478, 11085.72285692856, 11301.152413569016, 11373.545058197662, 41103.1779364414, 41443.96390090242, 41519.37720934188, 41545.75362739123, 41587.168256635, 4024.3359845625437, 4077.0622756765815, 4094.529129150156, 4104.199681062194, 4116.320807066831, 30052.0, 30315.696843031506, 30791.230219244473, 31044.22389440282, 31813.204669883205, 3200.423923693734, 3252.3007553376137, 3257.088015355704, 3270.280538281598, 3296.75274354422, 393714.0, 397333.0, 398270.0, 399088.0, 399399.0, 65937.67031164814, 66365.33634663688, 66513.66743166253, 66543.66728166328, 66645.33354666489, 69876.0, 70048.64975675191, 70073.64963175151, 70084.0, 70216.297837022, 16387.508374748777, 16911.323547058226, 16962.83037169637, 16980.896241744245, 16983.0, 12915.354232288348, 12964.481420743065, 12981.96144308453, 12992.090553661343, 13014.609561713163, 15528.068315901082, 16750.743694222983, 17175.484735457958, 19032.333868314818, 19476.220951161795, 6370.394812492806, 7130.821729456805, 7200.811866042044, 7772.689092436352, 7776.455648104691, 829.2371018662844, 877.2017464107631, 895.5029958373035, 897.1835629577184, 923.2014307623857, 27577.724222757915, 29957.70042299549, 30172.0, 30516.542251866238, 30892.0, 1086.6577028236081, 1087.521490544174, 1088.7822435512771, 1120.590984290728, 1146.633077415236, 15602.687946241012, 15707.607309817346, 15779.526614201362, 15814.525564233092, 16057.759133613004, 609324.0, 633716.0, 641264.0, 641659.0, 642124.0, 61445.692771535854, 61757.764844702855, 61801.690991544754, 61839.38160618426, 61901.69049154816, 1432.477145841781, 1449.2970909109074, 1468.9118652880861, 1472.9337179826935, 1473.0940471610097, 28256.85871570629, 29891.103266902028, 29995.250118747204, 30215.848920755256, 30264.72026262478, 53616.195757062895, 54322.72838635781, 54329.45670543402, 54398.0, 54526.0, 503090.0, 505223.0, 506118.0, 507237.0, 508230.0, 41414.37878431886, 41682.48417004151, 42371.0, 42693.0, 42696.57303426926, 46672.0, 47501.7624911887, 47689.0, 48095.519044810506, 48338.0, 26444.735552644997, 38835.805820970716, 39696.0, 39880.401793973695, 41014.589854101076, 38163.61836381712, 38763.0, 39091.0, 39992.80003599964, 40184.19631607293, 36223.094422639646, 38552.614473854905, 38671.6132838668, 38685.226295474495, 38720.0, 29013.854930726055, 29393.85303073471, 32862.34275314528, 32897.01308960735, 33692.49461258034, 24326.270211893672, 24695.38261543476, 24729.0, 24768.25695229146, 25150.11974580881], "value": 20483.805074228716, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.2910397484841, 384.3331819293526, 387.7867173054821, 395.86342711764433, 417.18024082677533, 15371.231438428076, 16063.196840157989, 20307.984600769956, 22024.44938876525, 22090.558188836214, 20865.374038778824, 21601.783982160214, 21741.67387489189, 22485.662715059287, 22731.0, 5554.444555544434, 6044.093385992103, 6054.727537260812, 6126.203593532857, 6214.446388402899, 4276.743395396271, 4478.708883922534, 6093.725782339783, 6133.417325354084, 6145.60053596517, 4466.531014243506, 5284.735763211843, 6765.154355705537, 6839.794806155824, 6853.348931851466, 6605.339466053404, 6803.0, 6821.727130914757, 6846.178458584952, 6876.1748590169245, 6017.819465416044, 6021.187139736124, 6021.42796434338, 6030.849228769272, 6044.184035155242, 26175.607365889526, 26314.473710525683, 26641.86679066592, 27207.0, 27683.892644294203, 2825.6044153818484, 2832.603435519029, 2833.8016338856287, 2835.53213719736, 2838.2762395589198, 16050.919745401316, 16165.353385864551, 16267.10530920799, 16270.430534931338, 17082.487525374258, 1872.5037864965796, 1892.7917929027933, 1906.5710215201607, 1931.4881556387568, 1937.680282753344, 116420.41789791081, 119855.99999999913, 120545.0, 120615.0, 120699.0, 10632.627858024933, 10931.125509959184, 11692.240004399688, 11762.88237117635, 11850.407479625985, 14953.40186392554, 15360.615984600474, 15375.692486150214, 15397.538073857802, 15407.614809629626, 8837.248833849066, 9101.499417532099, 9172.174504294511, 9231.984481707006, 9305.0, 9081.364304498622, 9093.90840106779, 9102.044285350075, 9247.907520924839, 9271.35100542969, 7540.095188577406, 7698.191689872595, 7719.729809456642, 7734.265244801735, 7763.573003484863, 1933.0528041259681, 1938.9224431022883, 1956.3935180094215, 2013.6476116679523, 2019.7374341335826, 1055.2191378379944, 1080.9405482698528, 1084.0, 1094.9069329106956, 1120.8374785656035, 23854.926528306267, 23875.641865372032, 23966.801659917284, 24018.51962960731, 24216.394590135387, 1076.321917192164, 1092.1044743310567, 1094.7482079121846, 1102.9448527573588, 1107.2968664897687, 11605.419729013516, 12293.446794894251, 12447.066470014604, 12512.81230781539, 12540.310282934526, 671074.0, 713239.0, 719745.0, 720345.0, 723908.0, 136298.0, 151141.48858511494, 151577.0, 154709.45290547176, 155515.22242388714, 1023.7133602591286, 1033.4161198922584, 1049.1397054415306, 1055.9260851740305, 1056.1920131099714, 19487.415377538695, 20224.539454290254, 20481.180752769724, 20701.792982069986, 20817.0, 59223.703881480316, 59861.5591198053, 60202.09696854463, 60454.69772651108, 60583.39416605778, 79802.28938548754, 82895.585522072, 83224.16775832164, 86261.0, 86404.83987900353, 6356.872862542631, 7415.777526674208, 7660.578668173304, 7708.113566939874, 8464.365172611955, 12752.936235318764, 12851.871481285441, 13108.541201057917, 13221.471141154247, 13468.0, 11414.0, 11573.942130289632, 11768.94115529417, 11826.290422574673, 11870.881291187323, 10696.358218506915, 11232.438378081226, 11514.827277590675, 11541.653750387502, 11849.585264515701, 11511.30932144074, 11609.944844804842, 11859.110566707704, 11916.642500724993, 11988.040956723615, 6338.746450141943, 6569.211694596679, 7468.813279668052, 7545.358644515278, 7993.760187194393, 8997.685081022133, 11248.21262511649, 11358.375289359165, 11427.714307142389, 11737.061035117], "value": 10393.058481203843, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.6934543740851, 1428.6714055767172, 1435.1174027972793, 1467.339697136289, 1471.161437980351, 8126.796830079244, 8455.069942306342, 8529.701460448885, 8545.188207120329, 8552.230299273064, 7554.7355842545385, 7787.104482984459, 7813.218678132184, 8148.837023259532, 8351.83296334073, 2302.804261637759, 2350.976490235101, 2356.4697942962866, 2361.2562042956415, 2362.7637236276405, 2265.6261716816707, 2281.0761641535205, 2287.8627282363027, 2298.977010229901, 2303.986246051732, 2310.503241803012, 2324.62846920317, 2336.170659415908, 2342.320726989171, 2348.8708121053337, 2306.4695120122383, 2314.525522267931, 2330.382448651109, 2334.7431782503827, 2340.9297721068397, 2304.493011537459, 2373.299876536426, 2374.584447721642, 2375.038109565611, 2378.9762102378927, 7084.893726594105, 8598.914010859873, 8619.61211745473, 8620.956895215546, 8625.654973801104, 4371.256886329332, 5064.341635587387, 5198.558122559549, 5212.166053431432, 5212.765425555859, 3311.7350611950988, 3410.9829450852835, 3521.7006554442905, 3562.946555801665, 3594.3170797548382, 1221.8106193540016, 1238.9626919099512, 1243.347242697582, 1246.6820960655066, 1266.5756971414587, 10803.999999999922, 11064.834027489595, 11162.107031437465, 11181.776364472746, 11183.776324473465, 4472.9776351118035, 4690.624750019991, 4709.693869898446, 4772.403449568804, 4796.25658023007, 9704.75738106553, 9722.27082968766, 9725.02749725036, 9730.221582273543, 9751.317407781387, 5336.599755018389, 5340.572754179656, 5340.732963351817, 5345.705986170798, 5348.732563371816, 4099.754014759124, 4540.750258735735, 4736.881577960509, 4807.254875494304, 4869.683470574401, 3854.171353159028, 3860.208657225262, 3928.685705143582, 3959.7030222732833, 3971.815501474178, 1283.0890068051601, 1283.666246775845, 1287.7038281195378, 1287.7488889666613, 1299.0776548650374, 804.617806541888, 836.3392919593574, 914.29599208609, 922.3589605224305, 927.8608208768603, 5484.0, 5591.944080559224, 5623.915641265385, 5751.827445176651, 5950.553708471882, 766.8542976834384, 995.4425521707867, 1006.4615430744517, 1034.3897100710617, 1038.85456036155, 3644.2711457708565, 3731.402975523903, 3768.1144930941205, 3808.1622043150464, 3932.4887764590994, 9860.753481163028, 10051.648192313234, 10191.184705223564, 10210.183185345155, 10251.794964100825, 9952.054554817281, 10088.142507886765, 10089.495525223709, 10119.59521619127, 10120.0, 6831.863362732618, 7980.760577182694, 8117.391195660349, 8129.674813007414, 8146.144654811278, 5605.887882242251, 5671.574631902541, 5886.735096920564, 5892.5285977122585, 5935.228420305332, 7122.893156602759, 8704.564771761514, 8705.956470217609, 8791.604377802887, 8829.470231786114, 6987.755428559976, 8817.206451419403, 9047.909520904706, 9063.32025098107, 9068.863967040632, 5825.2135961644635, 6729.629870357177, 6966.756163534252, 7204.9279507204255, 7243.23945985685, 7627.389808815393, 7699.191584883731, 7700.075990880906, 7719.073711154698, 7982.321502672338, 7067.081279433846, 7173.031640728644, 7200.0, 7207.5675459472595, 7333.596652184181, 6997.965010174917, 7043.542169758949, 7056.470764692771, 7067.646617669199, 7135.750248741269, 6467.029945508023, 6467.773627923, 6537.378948999837, 6540.934590654033, 6543.0, 5030.0, 5049.5960323174795, 5056.7724452399, 5096.490350965022, 5099.6175286852895, 4100.610442008005, 5020.949790502194, 5031.245313203049, 5043.268726034631, 5145.382554093533], "value": 4438.187041834146, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.29165024126627, 360.702420503085, 362.1742427265835, 373.27398210480607, 374.11521751058757, 4691.6950398224135, 5062.2406639004075, 5134.0, 5303.151495760679, 5339.919901201485, 4251.978740106303, 4455.688101832865, 5001.748164427346, 5227.242049902762, 5227.660202086861, 3377.7635565510423, 3775.3954569307934, 3777.2067865748227, 4111.958880411203, 4174.20690068886, 3433.3819912415756, 3464.428369319059, 3841.1357444574887, 4059.0, 4182.260619294367, 4111.691623128278, 4136.566649680758, 4139.503259608836, 4175.31107367284, 4182.97908510457, 3252.1056709404984, 3592.568891733009, 3782.1490164712995, 4087.05997620546, 4099.754014759124, 3662.176010397666, 3667.688246499051, 3672.0452682302794, 3672.7612705174347, 3682.6615099411797, 4458.4426946631675, 4895.828645997409, 4940.098062246026, 5135.204043373283, 5185.22221666753, 3969.8015099245213, 3999.8800035998966, 4183.91632167358, 4731.668783185179, 4754.762261886926, 5005.422207563108, 5157.53582177602, 5544.0575102232715, 5545.390007099216, 5568.972155139239, 3763.6989040876665, 4020.8994775130855, 4022.5776293489057, 4023.5574086850424, 4029.8388064477385, 4745.477997420281, 5064.468230835746, 5591.875087466737, 5819.166962406828, 5830.883382332372, 3323.7673362864366, 3463.688268055887, 4114.403411505315, 4128.545859955402, 4159.9376009359885, 3341.7159541438764, 3635.309291234657, 4093.85671501496, 4179.185058913483, 4206.915861682749, 3712.7747843211673, 3784.299904517673, 4133.5611988926075, 4523.683342166017, 4526.7510286933875, 5523.171524271311, 5535.474129957647, 5535.529479994165, 5554.805581804699, 5572.136318870582, 979.3536266064506, 1078.5308390850005, 1178.6051672689746, 1192.5647138794277, 1200.2138599217526, 732.8314487667759, 830.6179157587577, 857.0486759696731, 864.5849992003873, 871.9825603487894, 4348.304271316574, 4421.137878113801, 4703.929441058387, 4827.324174615556, 4889.853304400874, 4807.399075115611, 4997.775100120503, 5361.27622770921, 5374.596905232123, 5383.765737219089, 4672.57946784791, 5154.9484505155215, 5169.759257778106, 5198.142306519382, 5235.345581802275, 2403.90859951843, 2649.615346188446, 2807.1438211345735, 2849.5155823510054, 2882.1497658190883, 4817.421909370828, 5098.872528186751, 5138.614603904722, 5600.943990560124, 5632.0, 5323.281357016753, 5504.394516603171, 5532.806351777668, 5566.610337276433, 5591.700896471101, 5016.523430274118, 5046.899062018739, 5242.554382877498, 5598.880223955144, 5626.887462250732, 4935.481774413634, 5219.712915789668, 5283.630145889751, 5325.893482130413, 5369.973150134224, 4635.745034023161, 5050.742271235106, 5288.867778305573, 5305.734713264398, 5356.651817631841, 4958.925466210972, 5132.307138536399, 5225.399079105951, 5500.642458240201, 5531.096174508415, 3524.7356448266996, 3574.767640103385, 3619.131408462003, 3868.0909986153792, 3904.6876249900506, 4627.755538563862, 5627.662340259598, 5659.660420374791, 5670.603057785916, 5671.432856714296, 5164.561012313845, 5203.985222881502, 5484.725763711878, 5497.835064948058, 5521.806736764354, 5179.792808287626, 5447.346318441812, 5492.1212605982855, 5521.66869987786, 5525.182157099827, 4724.456687480983, 4915.188993816123, 5153.7165455900285, 5293.841184764463, 5369.234844055392, 5245.344331958505, 5270.7101109439345, 5511.090670039559, 5595.496405323541, 5604.6917419542315, 5185.351831021122, 5422.701751403711, 5425.240466334795, 5434.809781657623, 5449.910017996496], "value": 3974.9528182020395, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.3163226567027, 737.2111840330841, 762.5386641082146, 834.1200033964167, 862.0129951205868, 15015.324310406031, 15793.526194214162, 15856.445024424147, 15972.2013899305, 15991.84008159918, 14277.071990320623, 14419.495317663885, 14426.278686065707, 14435.566932992027, 15486.303116359762, 695.2942763095436, 697.8171998462608, 709.9929000710005, 744.4416687484387, 841.3227351981637, 846.1115828380207, 874.9693760718376, 877.9473231606124, 881.8368601808686, 882.8499155143609, 897.7755561109723, 921.4333185091187, 923.9538023098852, 924.5377311344328, 926.9860952085725, 718.2996578336107, 736.91157061153, 887.1394747095308, 903.6069309850236, 913.3789023464042, 685.1127789512593, 686.1080595226186, 688.198249039868, 690.2303931116819, 692.6744430117836, 15288.541343759705, 15294.617634559114, 15684.76472852908, 15711.450099246586, 15734.921325393414, 13483.325833708373, 13745.587632371045, 13774.035817492779, 13800.447982080705, 13949.651258718512, 12726.745465090646, 12751.42618582166, 12778.808317875239, 12938.288394138319, 13058.804117938143, 4431.468223813163, 4444.533324000966, 4469.642428605736, 4479.216137176014, 4638.420197475316, 100458.0, 100594.0, 100907.49546252296, 101019.0, 104714.99999999924, 10520.158387328995, 10828.837567436494, 10871.239013269153, 10920.344779313107, 11139.777204455866, 22080.779192208192, 22155.00302486392, 22287.219947302092, 22454.43863903383, 22527.774722252896, 7580.431467639949, 7673.884891726629, 7864.174261702553, 7897.549582360141, 8096.5546894921345, 4219.367094935723, 4236.512801027921, 4391.60475557195, 4408.669349798778, 4494.9325760113625, 3032.5147976323683, 3684.9447258291148, 3690.6309369063415, 3723.4414837774007, 3735.7198210134347, 590.5983930927011, 656.6651007985962, 664.597918259446, 666.0608541955819, 667.4827009068011, 556.2962851992233, 572.7651662818224, 575.7984705353093, 641.7048157847443, 646.5646265291047, 10057.346272492265, 10309.226807989431, 10558.260921735558, 10582.682519524427, 10749.83875241872, 588.3704436253169, 609.0742072050458, 611.0498175337304, 661.3948237362855, 715.9355657990806, 4498.278541482421, 4586.059857729158, 4914.280001999343, 4916.582090522345, 4926.45808961014, 69188.0, 81657.59171204106, 84077.0, 89209.55395223112, 90475.0, 66460.0, 77013.0, 78142.60928695434, 79030.0, 84047.5797621008, 69181.65409172921, 71316.0, 73090.0, 73696.63151684101, 74721.6263918677, 9519.904800951901, 10599.0, 10602.20483463728, 10876.728081798019, 11014.008739213188, 47037.0, 47090.76454617842, 47230.76384618055, 47841.80395490141, 48131.19071131415, 60486.69756651189, 62140.0, 62225.0, 63768.724625508155, 64667.02999454918, 12504.124711270124, 12638.873611263769, 12796.232226066466, 13314.231325970199, 13474.0, 14239.928800355932, 14466.493672721404, 14835.851641483447, 15286.312115954586, 15317.080975141527, 12995.545155919497, 13919.164850109026, 13958.371873265525, 14087.08433951831, 14443.0, 11117.944410277896, 13687.97340199509, 13719.314034298444, 13773.311334433438, 14261.928690356483, 13316.201027938354, 13445.058845880694, 13477.056606037484, 13931.024828261925, 13997.790033149715, 9803.754906127118, 11127.83308250393, 11317.434128293387, 11765.588204412805, 11959.880401195876, 8618.008928972997, 10551.366917984946, 11023.338599684044, 11051.834222486508, 11084.49066019819], "value": 7432.868201106783, "unit": "score"}], "name": "dromaeo_css", "value": 7374.340958402604, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 109.0, 115.0, 114.0, 113.0, 115.0, 112.0, 114.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 110.0, 109.0, 142.0, 109.0, 109.0, 110.0, 115.0, 158.0, 141.0], "value": 123.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 187.0, 183.0, 185.0, 185.0, 185.0, 183.0, 187.0, 185.0, 185.0], "value": 185.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 58.0, 88.0, 61.0, 59.0, 58.0, 59.0, 73.0, 58.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 85.0, 69.0, 68.0, 68.0, 80.0, 67.0, 69.0, 81.0], "value": 74.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 85.0, 87.0, 85.0, 93.0, 132.0, 112.0, 85.0], "value": 94.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 93.0, 93.0, 93.0], "value": 93.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 89.0, 86.0, 89.0, 88.0, 87.0, 84.0, 87.0, 84.0], "value": 86.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 58.0, 57.0, 56.0, 57.0, 58.0, 58.0, 57.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 81.0, 75.0, 73.0, 69.0, 70.0, 70.0, 72.0, 72.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 94.0, 101.0, 102.0, 97.0, 84.0, 85.0, 85.0, 85.0], "value": 90.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 139.0, 139.0, 140.0, 138.0, 142.0, 141.0, 143.0, 187.0, 170.0], "value": 148.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 169.0, 169.0, 169.0, 170.0, 169.0, 168.0, 167.0, 168.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 66.0, 63.0, 66.0, 69.0, 80.0, 85.0, 83.0, 83.0], "value": 72.5, "unit": "score"}], "name": "kraken", "value": 1445.9, "alertThreshold": 2.0}]} 12:05:07 INFO - Return code: 0 12:05:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:05:07 ERROR - # TBPL SUCCESS # 12:05:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:05:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:05:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:05:07 INFO - 2017-01-30 12:05:07.420 screenresolution[1655:9885] starting screenresolution argv=screenresolution get 12:05:07 INFO - 2017-01-30 12:05:07.423 screenresolution[1655:9885] Display 0: 1600x1200x32@60 12:05:07 INFO - 2017-01-30 12:05:07.429 screenresolution[1656:9888] starting screenresolution argv=screenresolution list 12:05:07 INFO - Available Modes on Display 0 12:05:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:05:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:05:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:05:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:05:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:05:07 INFO - Intel Iris: 12:05:07 INFO - Chipset Model: Intel Iris 12:05:07 INFO - Type: GPU 12:05:07 INFO - Bus: Built-In 12:05:07 INFO - VRAM (Dynamic, Max): 1536 MB 12:05:07 INFO - Vendor: Intel (0x8086) 12:05:07 INFO - Device ID: 0x0a2e 12:05:07 INFO - Revision ID: 0x0009 12:05:07 INFO - Displays: 12:05:07 INFO - Display: 12:05:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:05:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:05:07 INFO - Display Serial Number: 1600x1200 60 12:05:07 INFO - Main Display: Yes 12:05:07 INFO - Mirror: Off 12:05:07 INFO - Online: Yes 12:05:07 INFO - Rotation: Supported 12:05:07 INFO - Return code: 0 12:05:07 INFO - Running post-action listener: _resource_record_post_action 12:05:07 INFO - [mozharness: 2017-01-30 20:05:07.667432Z] Finished run-tests step (success) 12:05:07 INFO - Running post-run listener: _resource_record_post_run 12:05:07 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 37770240; Write bytes: 510345216; Read time: 239; Write time: 1597 12:05:07 INFO - TinderboxPrint: CPU usage
53.8% 12:05:07 INFO - TinderboxPrint: I/O read bytes / time
37,770,240 / 239 12:05:07 INFO - TinderboxPrint: I/O write bytes / time
510,345,216 / 1,597 12:05:07 INFO - TinderboxPrint: CPU idle
2,215.4 (46.2%) 12:05:07 INFO - TinderboxPrint: CPU system
967.6 (20.2%) 12:05:07 INFO - TinderboxPrint: CPU user
1,610.8 (33.6%) 12:05:07 INFO - TinderboxPrint: Swap in / out
245,100,544 / 0 12:05:07 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 203223552; Write bytes: 202459136; Read time: 15640; Write time: 454 12:05:07 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 35742720; Write bytes: 296966144; Read time: 220; Write time: 1110 12:05:08 INFO - Running post-run listener: _upload_blobber_files 12:05:08 INFO - Blob upload gear active. 12:05:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:05:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:05:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:05:08 INFO - (blobuploader) - INFO - Open directory for files ... 12:05:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:05:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:05:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:05:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:05:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:05:09 INFO - (blobuploader) - INFO - Done attempting. 12:05:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:05:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:05:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:05:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:05:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:05:10 INFO - (blobuploader) - INFO - Done attempting. 12:05:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:05:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:05:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:05:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:05:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:05:11 INFO - (blobuploader) - INFO - Done attempting. 12:05:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:05:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:05:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:05:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:05:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:05:13 INFO - (blobuploader) - INFO - Done attempting. 12:05:13 INFO - (blobuploader) - INFO - Iteration through files over. 12:05:13 INFO - Return code: 0 12:05:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:05:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:05:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ce67c70a4f4e9f31fa127a91af66a0e1cc7a6c2c752472a9bae20e7ec73678a67e0fbb66cc51b314987ab48d267418392fec83644f4a3ff015da1ac1719d60b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/015aa610120cc09af19f1175425e46df1f63a70199104a5f2924de93baee06c5c82d2592ba96dc7b82fe2ae5ec90aeebe9fdf477e4b0202bffb346c8c39c4033", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3bf238bd0c3e49b22d28bebcfc2bf959b7344cd453c81a2c3da7b4a749d9b35621a31dafaf042a687ae07aef8d116f4151f80763c100fa63f43f8106b7f92761", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/671b8181c71c0a5317a5c886d87ea636b3405263d74b92b606890fb0bb698cecac44b576c88da657d4d52aa97f418a0f055ed1dd4b5e7a2ae1cda6a12754b490"} 12:05:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:05:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:05:13 INFO - Contents: 12:05:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ce67c70a4f4e9f31fa127a91af66a0e1cc7a6c2c752472a9bae20e7ec73678a67e0fbb66cc51b314987ab48d267418392fec83644f4a3ff015da1ac1719d60b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/015aa610120cc09af19f1175425e46df1f63a70199104a5f2924de93baee06c5c82d2592ba96dc7b82fe2ae5ec90aeebe9fdf477e4b0202bffb346c8c39c4033", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3bf238bd0c3e49b22d28bebcfc2bf959b7344cd453c81a2c3da7b4a749d9b35621a31dafaf042a687ae07aef8d116f4151f80763c100fa63f43f8106b7f92761", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/671b8181c71c0a5317a5c886d87ea636b3405263d74b92b606890fb0bb698cecac44b576c88da657d4d52aa97f418a0f055ed1dd4b5e7a2ae1cda6a12754b490"} 12:05:13 INFO - Running post-run listener: copy_logs_to_upload_dir 12:05:13 INFO - Copying logs to upload dir... 12:05:13 INFO - mkdir: /builds/slave/test/build/upload/logs 12:05:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.510091 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-30 12:05:13.414539) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 12:05:13.418270) ========= 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.7ASfDR6jGN/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.CxfsCGHbQG/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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/6ce67c70a4f4e9f31fa127a91af66a0e1cc7a6c2c752472a9bae20e7ec73678a67e0fbb66cc51b314987ab48d267418392fec83644f4a3ff015da1ac1719d60b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/015aa610120cc09af19f1175425e46df1f63a70199104a5f2924de93baee06c5c82d2592ba96dc7b82fe2ae5ec90aeebe9fdf477e4b0202bffb346c8c39c4033", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3bf238bd0c3e49b22d28bebcfc2bf959b7344cd453c81a2c3da7b4a749d9b35621a31dafaf042a687ae07aef8d116f4151f80763c100fa63f43f8106b7f92761", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/671b8181c71c0a5317a5c886d87ea636b3405263d74b92b606890fb0bb698cecac44b576c88da657d4d52aa97f418a0f055ed1dd4b5e7a2ae1cda6a12754b490"} build_url:https://queue.taskcluster.net/v1/task/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011060 build_url: 'https://queue.taskcluster.net/v1/task/LxbI2ANhTHGBiXlYIxljIg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6ce67c70a4f4e9f31fa127a91af66a0e1cc7a6c2c752472a9bae20e7ec73678a67e0fbb66cc51b314987ab48d267418392fec83644f4a3ff015da1ac1719d60b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/015aa610120cc09af19f1175425e46df1f63a70199104a5f2924de93baee06c5c82d2592ba96dc7b82fe2ae5ec90aeebe9fdf477e4b0202bffb346c8c39c4033", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3bf238bd0c3e49b22d28bebcfc2bf959b7344cd453c81a2c3da7b4a749d9b35621a31dafaf042a687ae07aef8d116f4151f80763c100fa63f43f8106b7f92761", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/671b8181c71c0a5317a5c886d87ea636b3405263d74b92b606890fb0bb698cecac44b576c88da657d4d52aa97f418a0f055ed1dd4b5e7a2ae1cda6a12754b490"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 12:05:13.453455) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 12:05:13.453772) ========= 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.7ASfDR6jGN/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.CxfsCGHbQG/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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.005060 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 12:05:13.502563) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 12:05:13.502871) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 12:05:13.503195) ========= ========= Total master_lag: 0.69 =========