builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0005 starttime: 1478015768.9 results: success (0) buildid: 20161101063617 builduid: 9a5f5c0777f844d9b6775f960eeff54a revision: e5d9f12de81ed7bb1c237f72db80da9c1fff9ee6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-01 08:56:08.895421) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-01 08:56:08.895953) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-01 08:56:08.896250) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-01 08:56:08.928289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 08:56:08.928718) ========= 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.UVHApgBT1f/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.G9IH9LxQSN/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-01 08:56:08-- 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% 14.8M=0.001s 2016-11-01 08:56:09 (14.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122904 ========= master_lag: 0.30 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 08:56:09.355087) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 08:56:09.355492) ========= 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.UVHApgBT1f/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.G9IH9LxQSN/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.028226 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 08:56:09.413826) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 08:56:09.414239) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e5d9f12de81ed7bb1c237f72db80da9c1fff9ee6 --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 e5d9f12de81ed7bb1c237f72db80da9c1fff9ee6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UVHApgBT1f/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.G9IH9LxQSN/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-01 08:56:09,496 truncating revision to first 12 chars 2016-11-01 08:56:09,496 Setting DEBUG logging. 2016-11-01 08:56:09,496 attempt 1/10 2016-11-01 08:56:09,496 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e5d9f12de81e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-01 08:56:09,989 unpacking tar archive at: mozilla-aurora-e5d9f12de81e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.759479 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 08:56:10.199979) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-01 08:56:10.200392) ========= script_repo_revision: e5d9f12de81ed7bb1c237f72db80da9c1fff9ee6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-01 08:56:10.200824) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-01 08:56:10.201125) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-01 08:56:10.220033) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-01 08:56:10.220503) ========= /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.UVHApgBT1f/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.G9IH9LxQSN/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:56:10 INFO - MultiFileLogger online at 20161101 08:56:10 in /builds/slave/test 08:56:10 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 08:56:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:56:10 INFO - {'append_to_log': False, 08:56:10 INFO - 'base_work_dir': '/builds/slave/test', 08:56:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:56:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:56:10 INFO - 'branch': 'Mozilla-Aurora', 08:56:10 INFO - 'buildbot_json_path': 'buildprops.json', 08:56:10 INFO - 'config_files': ('talos/mac_config.py',), 08:56:10 INFO - 'default_actions': ('clobber', 08:56:10 INFO - 'read-buildbot-config', 08:56:10 INFO - 'download-and-extract', 08:56:10 INFO - 'populate-webroot', 08:56:10 INFO - 'create-virtualenv', 08:56:10 INFO - 'install', 08:56:10 INFO - 'run-tests'), 08:56:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:56:10 INFO - 'download_minidump_stackwalk': True, 08:56:10 INFO - 'download_symbols': 'ondemand', 08:56:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:56:10 INFO - 'tooltool.py': '/tools/tooltool.py', 08:56:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:56:10 INFO - '/tools/misc-python/virtualenv.py')}, 08:56:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:56:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:56:10 INFO - 'installer_path': 'installer.exe', 08:56:10 INFO - 'log_level': 'info', 08:56:10 INFO - 'log_name': 'talos', 08:56:10 INFO - 'log_to_console': True, 08:56:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:56:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:56:10 INFO - 'opt_config_files': (), 08:56:10 INFO - 'pip_index': False, 08:56:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:56:10 INFO - 'cmd': ('bash', 08:56:10 INFO - '-c', 08:56:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:56:10 INFO - 'enabled': True, 08:56:10 INFO - 'halt_on_failure': False, 08:56:10 INFO - 'name': 'check_screen_resolution'},), 08:56:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:56:10 INFO - 'cmd': ('bash', 08:56:10 INFO - '-c', 08:56:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:56:10 INFO - 'enabled': True, 08:56:10 INFO - 'halt_on_failure': False, 08:56:10 INFO - 'name': 'check_screen_resolution'},), 08:56:10 INFO - 'run_cmd_checks_enabled': True, 08:56:10 INFO - 'sps_profile': False, 08:56:10 INFO - 'sps_profile_interval': 0, 08:56:10 INFO - 'suite': 'dromaeojs', 08:56:10 INFO - 'system_bits': '32', 08:56:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:56:10 INFO - 'title': 't-yosemite-r7-0005', 08:56:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:56:10 INFO - 'use_talos_json': True, 08:56:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:56:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:56:10 INFO - 'work_dir': 'build'} 08:56:10 INFO - [mozharness: 2016-11-01 15:56:10.421238Z] Running clobber step. 08:56:10 INFO - Running pre-action listener: _resource_record_pre_action 08:56:10 INFO - Running main action method: clobber 08:56:10 INFO - rmtree: /builds/slave/test/build 08:56:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:56:12 INFO - Running post-action listener: _resource_record_post_action 08:56:12 INFO - [mozharness: 2016-11-01 15:56:12.722913Z] Finished clobber step (success) 08:56:12 INFO - [mozharness: 2016-11-01 15:56:12.723044Z] Running read-buildbot-config step. 08:56:12 INFO - Running pre-action listener: _resource_record_pre_action 08:56:12 INFO - Running main action method: read_buildbot_config 08:56:12 INFO - Using buildbot properties: 08:56:12 INFO - { 08:56:12 INFO - "project": "", 08:56:12 INFO - "product": "firefox", 08:56:12 INFO - "script_repo_revision": "production", 08:56:12 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:56:12 INFO - "repository": "", 08:56:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:56:12 INFO - "buildid": "20161101063617", 08:56:12 INFO - "pgo_build": "False", 08:56:12 INFO - "basedir": "/builds/slave/test", 08:56:12 INFO - "buildnumber": 13, 08:56:12 INFO - "slavename": "t-yosemite-r7-0005", 08:56:12 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 08:56:12 INFO - "platform": "yosemite_r7", 08:56:12 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:56:12 INFO - "branch": "mozilla-aurora", 08:56:12 INFO - "repo_path": "releases/mozilla-aurora", 08:56:12 INFO - "revision": "e5d9f12de81ed7bb1c237f72db80da9c1fff9ee6", 08:56:12 INFO - "stage_platform": "macosx64", 08:56:12 INFO - "builduid": "9a5f5c0777f844d9b6775f960eeff54a", 08:56:12 INFO - "slavebuilddir": "test" 08:56:12 INFO - } 08:56:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 08:56:12 INFO - Running post-action listener: _resource_record_post_action 08:56:12 INFO - [mozharness: 2016-11-01 15:56:12.726327Z] Finished read-buildbot-config step (success) 08:56:12 INFO - [mozharness: 2016-11-01 15:56:12.726417Z] Running download-and-extract step. 08:56:12 INFO - Running pre-action listener: _resource_record_pre_action 08:56:12 INFO - Running main action method: download_and_extract 08:56:12 INFO - mkdir: /builds/slave/test/build/tests 08:56:12 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')]} 08:56:12 INFO - trying https://queue.taskcluster.net/v1/task/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 08:56:12 INFO - Downloading https://queue.taskcluster.net/v1/task/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 08:56:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 08:56:14 INFO - Downloaded 1199 bytes. 08:56:14 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 08:56:14 INFO - Using the following test package requirements: 08:56:14 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 08:56:14 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:56:14 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 08:56:14 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:56:14 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 08:56:14 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:56:14 INFO - u'jsshell-mac.zip'], 08:56:14 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:56:14 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 08:56:14 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 08:56:14 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:56:14 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 08:56:14 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:56:14 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 08:56:14 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:56:14 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 08:56:14 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:56:14 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 08:56:14 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:56:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 08:56:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:56:14 INFO - Fetch https://queue.taskcluster.net/v1/task/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 08:56:14 INFO - Expected file size: 16421582 08:56:22 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:56:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 08:56:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:56:22 INFO - Fetch https://queue.taskcluster.net/v1/task/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 08:56:22 INFO - Expected file size: 16421582 08:56:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 08:56:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:56:29 INFO - Fetch https://queue.taskcluster.net/v1/task/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 08:56:30 INFO - Expected file size: 14414089 08:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:30 INFO - trying https://queue.taskcluster.net/v1/task/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 08:56:30 INFO - Downloading https://queue.taskcluster.net/v1/task/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 08:56:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 08:56:33 INFO - Downloaded 115423867 bytes. 08:56:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 08:56:33 INFO - mkdir: /builds/slave/test/properties 08:56:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:56:33 INFO - Writing to file /builds/slave/test/properties/build_url 08:56:33 INFO - Contents: 08:56:33 INFO - build_url:https://queue.taskcluster.net/v1/task/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 08:56:34 INFO - Running post-action listener: _resource_record_post_action 08:56:34 INFO - Running post-action listener: set_extra_try_arguments 08:56:34 INFO - [mozharness: 2016-11-01 15:56:34.840595Z] Finished download-and-extract step (success) 08:56:34 INFO - [mozharness: 2016-11-01 15:56:34.840732Z] Running populate-webroot step. 08:56:34 INFO - Running pre-action listener: _resource_record_pre_action 08:56:34 INFO - Running main action method: populate_webroot 08:56:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:56:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:56:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:56:34 INFO - '--tppagecycles', 08:56:34 INFO - '7'], 08:56:34 INFO - 'tests': ['tsvgm']}}, 08:56:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:56:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:56:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:56:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:56:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:34 INFO - 'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:34 INFO - 'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['damp', 'tps']}, 08:56:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:34 INFO - 'tests': ['damp', 'tps']}, 08:56:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['dromaeo_dom']}, 08:56:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:56:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['basic_compositor_video']}, 08:56:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:56:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['a11yr', 08:56:34 INFO - 'ts_paint', 08:56:34 INFO - 'tpaint', 08:56:34 INFO - 'sessionrestore', 08:56:34 INFO - 'sessionrestore_no_auto_restore', 08:56:34 INFO - 'tabpaint']}, 08:56:34 INFO - 'other-e10s': {'tests': ['a11yr', 08:56:34 INFO - 'ts_paint', 08:56:34 INFO - 'tpaint', 08:56:34 INFO - 'sessionrestore', 08:56:34 INFO - 'sessionrestore_no_auto_restore', 08:56:34 INFO - 'tabpaint']}, 08:56:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:56:34 INFO - 'ts_paint', 08:56:34 INFO - 'tpaint', 08:56:34 INFO - 'sessionrestore', 08:56:34 INFO - 'sessionrestore_no_auto_restore', 08:56:34 INFO - 'tabpaint']}, 08:56:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:56:34 INFO - 'ts_paint', 08:56:34 INFO - 'tpaint', 08:56:34 INFO - 'sessionrestore', 08:56:34 INFO - 'sessionrestore_no_auto_restore', 08:56:34 INFO - 'tabpaint']}, 08:56:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['a11yr', 08:56:34 INFO - 'ts_paint', 08:56:34 INFO - 'tpaint', 08:56:34 INFO - 'sessionrestore', 08:56:34 INFO - 'sessionrestore_no_auto_restore', 08:56:34 INFO - 'tabpaint']}, 08:56:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['a11yr', 08:56:34 INFO - 'ts_paint', 08:56:34 INFO - 'tpaint', 08:56:34 INFO - 'sessionrestore', 08:56:34 INFO - 'sessionrestore_no_auto_restore', 08:56:34 INFO - 'tabpaint']}, 08:56:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['tsvgx', 08:56:34 INFO - 'tsvgr_opacity', 08:56:34 INFO - 'tart', 08:56:34 INFO - 'tscrollx', 08:56:34 INFO - 'cart']}, 08:56:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:56:34 INFO - 'tsvgr_opacity', 08:56:34 INFO - 'tart', 08:56:34 INFO - 'tscrollx', 08:56:34 INFO - 'cart']}, 08:56:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:34 INFO - 'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['tp5o']}, 08:56:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:34 INFO - 'tests': ['tp5o']}, 08:56:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:34 INFO - 'talos_options': ['--disable-e10s', 08:56:34 INFO - '--xperf_path', 08:56:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:34 INFO - 'tests': ['tp5n']}, 08:56:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:34 INFO - 'talos_options': ['--xperf_path', 08:56:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:34 INFO - 'tests': ['tp5n']}}, 08:56:34 INFO - 'talos.zip': {'path': '', 08:56:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:56:34 INFO - Running post-action listener: _resource_record_post_action 08:56:34 INFO - [mozharness: 2016-11-01 15:56:34.859260Z] Finished populate-webroot step (success) 08:56:34 INFO - [mozharness: 2016-11-01 15:56:34.859370Z] Running create-virtualenv step. 08:56:34 INFO - Running pre-action listener: _resource_record_pre_action 08:56:34 INFO - Running main action method: create_virtualenv 08:56:34 INFO - Creating virtualenv /builds/slave/test/build/venv 08:56:34 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 08:56:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:56:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:56:34 INFO - Using real prefix '/tools/python27' 08:56:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:56:35 INFO - Installing distribute.............................................................................................................................................................................................done. 08:56:38 INFO - Installing pip.................done. 08:56:38 INFO - Return code: 0 08:56:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102ce5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c5b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fe1597a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102af9d30>, '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 0x10295fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af1b20>, '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.UVHApgBT1f/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.G9IH9LxQSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:56:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVHApgBT1f/Render', 08:56:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:38 INFO - 'HOME': '/Users/cltbld', 08:56:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:38 INFO - 'LOGNAME': 'cltbld', 08:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:38 INFO - 'MOZ_NO_REMOTE': '1', 08:56:38 INFO - 'NO_EM_RESTART': '1', 08:56:38 INFO - 'PAGER': '/bin/cat', 08:56:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:38 INFO - 'PWD': '/builds/slave/test', 08:56:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:38 INFO - 'SHELL': '/bin/bash', 08:56:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G9IH9LxQSN/Listeners', 08:56:38 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:56:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:38 INFO - 'USER': 'cltbld', 08:56:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:38 INFO - 'XPC_FLAGS': '0x0', 08:56:38 INFO - 'XPC_SERVICE_NAME': '0', 08:56:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:38 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 08:56:38 INFO - Cleaning up... 08:56:38 INFO - Return code: 0 08:56:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102ce5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c5b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fe1597a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102af9d30>, '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 0x10295fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af1b20>, '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.UVHApgBT1f/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.G9IH9LxQSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:56:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVHApgBT1f/Render', 08:56:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:38 INFO - 'HOME': '/Users/cltbld', 08:56:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:38 INFO - 'LOGNAME': 'cltbld', 08:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:38 INFO - 'MOZ_NO_REMOTE': '1', 08:56:38 INFO - 'NO_EM_RESTART': '1', 08:56:38 INFO - 'PAGER': '/bin/cat', 08:56:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:38 INFO - 'PWD': '/builds/slave/test', 08:56:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:38 INFO - 'SHELL': '/bin/bash', 08:56:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G9IH9LxQSN/Listeners', 08:56:38 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:56:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:38 INFO - 'USER': 'cltbld', 08:56:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:38 INFO - 'XPC_FLAGS': '0x0', 08:56:38 INFO - 'XPC_SERVICE_NAME': '0', 08:56:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:39 INFO - Downloading/unpacking psutil>=3.1.1 08:56:39 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 08:56:39 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 08:56:39 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 08:56:39 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 08:56:39 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 08:56:39 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 08:56:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:56:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:56:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:56:42 INFO - Installing collected packages: psutil 08:56:42 INFO - Running setup.py install for psutil 08:56:42 INFO - building 'psutil._psutil_osx' extension 08:56:42 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 08:56:42 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 08:56:42 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 08:56:42 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 08:56:43 INFO - building 'psutil._psutil_posix' extension 08:56:43 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 08:56:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:56:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:56:43 INFO - ^ 08:56:43 INFO - 1 warning generated. 08:56:43 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 08:56:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:56:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:56:43 INFO - Successfully installed psutil 08:56:43 INFO - Cleaning up... 08:56:43 INFO - Return code: 0 08:56:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:56:43 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')]} 08:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:43 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')]} 08:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:43 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 0x102ce5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c5b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fe1597a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102af9d30>, '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 0x10295fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af1b20>, '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.UVHApgBT1f/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.G9IH9LxQSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:56:43 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 08:56:43 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 08:56:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVHApgBT1f/Render', 08:56:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:43 INFO - 'HOME': '/Users/cltbld', 08:56:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:43 INFO - 'LOGNAME': 'cltbld', 08:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:43 INFO - 'MOZ_NO_REMOTE': '1', 08:56:43 INFO - 'NO_EM_RESTART': '1', 08:56:43 INFO - 'PAGER': '/bin/cat', 08:56:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:43 INFO - 'PWD': '/builds/slave/test', 08:56:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:43 INFO - 'SHELL': '/bin/bash', 08:56:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G9IH9LxQSN/Listeners', 08:56:43 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:56:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:43 INFO - 'USER': 'cltbld', 08:56:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:43 INFO - 'XPC_FLAGS': '0x0', 08:56:43 INFO - 'XPC_SERVICE_NAME': '0', 08:56:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:56:43 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 08:56:43 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 08:56:43 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 08:56:43 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 08:56:43 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 08:56:43 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 08:56:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:56:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:56:46 INFO - Installing collected packages: mozsystemmonitor 08:56:46 INFO - Running setup.py install for mozsystemmonitor 08:56:46 INFO - Successfully installed mozsystemmonitor 08:56:46 INFO - Cleaning up... 08:56:46 INFO - Return code: 0 08:56:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:56:46 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')]} 08:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:46 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')]} 08:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:46 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 0x102ce5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c5b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fe1597a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102af9d30>, '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 0x10295fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af1b20>, '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.UVHApgBT1f/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.G9IH9LxQSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:56:46 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 08:56:46 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 08:56:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVHApgBT1f/Render', 08:56:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:46 INFO - 'HOME': '/Users/cltbld', 08:56:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:46 INFO - 'LOGNAME': 'cltbld', 08:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:46 INFO - 'MOZ_NO_REMOTE': '1', 08:56:46 INFO - 'NO_EM_RESTART': '1', 08:56:46 INFO - 'PAGER': '/bin/cat', 08:56:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:46 INFO - 'PWD': '/builds/slave/test', 08:56:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:46 INFO - 'SHELL': '/bin/bash', 08:56:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G9IH9LxQSN/Listeners', 08:56:46 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:56:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:46 INFO - 'USER': 'cltbld', 08:56:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:46 INFO - 'XPC_FLAGS': '0x0', 08:56:46 INFO - 'XPC_SERVICE_NAME': '0', 08:56:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:46 INFO - Downloading/unpacking jsonschema==2.5.1 08:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:56:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:56:49 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 08:56:49 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 08:56:49 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 08:56:49 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 08:56:49 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 08:56:49 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 08:56:49 INFO - Downloading functools32-3.2.3-2.tar.gz 08:56:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:56:49 INFO - warning: no files found matching '*.txt' 08:56:49 INFO - no previously-included directories found matching 'build' 08:56:49 INFO - no previously-included directories found matching 'dist' 08:56:49 INFO - no previously-included directories found matching '.git*' 08:56:49 INFO - Installing collected packages: jsonschema, functools32 08:56:49 INFO - Running setup.py install for functools32 08:56:49 INFO - warning: no files found matching '*.txt' 08:56:49 INFO - no previously-included directories found matching 'build' 08:56:49 INFO - no previously-included directories found matching 'dist' 08:56:49 INFO - no previously-included directories found matching '.git*' 08:56:50 INFO - Successfully installed jsonschema functools32 08:56:50 INFO - Cleaning up... 08:56:50 INFO - Return code: 0 08:56:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:50 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 0x102ce5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c5b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fe1597a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102af9d30>, '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 0x10295fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af1b20>, '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.UVHApgBT1f/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.G9IH9LxQSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:56:50 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 08:56:50 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 08:56:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVHApgBT1f/Render', 08:56:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:50 INFO - 'HOME': '/Users/cltbld', 08:56:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:50 INFO - 'LOGNAME': 'cltbld', 08:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:50 INFO - 'MOZ_NO_REMOTE': '1', 08:56:50 INFO - 'NO_EM_RESTART': '1', 08:56:50 INFO - 'PAGER': '/bin/cat', 08:56:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:50 INFO - 'PWD': '/builds/slave/test', 08:56:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:50 INFO - 'SHELL': '/bin/bash', 08:56:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G9IH9LxQSN/Listeners', 08:56:50 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:56:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:50 INFO - 'USER': 'cltbld', 08:56:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:50 INFO - 'XPC_FLAGS': '0x0', 08:56:50 INFO - 'XPC_SERVICE_NAME': '0', 08:56:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:56:50 INFO - Cleaning up... 08:56:50 INFO - Return code: 0 08:56:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:50 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 0x102ce5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c5b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fe1597a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102af9d30>, '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 0x10295fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af1b20>, '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.UVHApgBT1f/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.G9IH9LxQSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:56:50 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 08:56:50 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 08:56:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVHApgBT1f/Render', 08:56:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:50 INFO - 'HOME': '/Users/cltbld', 08:56:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:50 INFO - 'LOGNAME': 'cltbld', 08:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:50 INFO - 'MOZ_NO_REMOTE': '1', 08:56:50 INFO - 'NO_EM_RESTART': '1', 08:56:50 INFO - 'PAGER': '/bin/cat', 08:56:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:50 INFO - 'PWD': '/builds/slave/test', 08:56:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:50 INFO - 'SHELL': '/bin/bash', 08:56:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G9IH9LxQSN/Listeners', 08:56:50 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:56:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:50 INFO - 'USER': 'cltbld', 08:56:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:50 INFO - 'XPC_FLAGS': '0x0', 08:56:50 INFO - 'XPC_SERVICE_NAME': '0', 08:56:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:50 INFO - Downloading/unpacking blobuploader==1.2.4 08:56:50 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 08:56:50 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 08:56:50 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 08:56:50 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 08:56:50 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 08:56:50 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 08:56:53 INFO - Downloading blobuploader-1.2.4.tar.gz 08:56:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:56:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:56:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:54 INFO - Downloading docopt-0.6.1.tar.gz 08:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:56:54 INFO - Installing collected packages: blobuploader, requests, docopt 08:56:54 INFO - Running setup.py install for blobuploader 08:56:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:56:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:56:54 INFO - Running setup.py install for requests 08:56:55 INFO - Running setup.py install for docopt 08:56:55 INFO - Successfully installed blobuploader requests docopt 08:56:55 INFO - Cleaning up... 08:56:55 INFO - Return code: 0 08:56:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:55 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')]} 08:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:55 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')]} 08:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:55 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 0x102ce5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c5b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fe1597a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102af9d30>, '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 0x10295fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af1b20>, '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.UVHApgBT1f/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.G9IH9LxQSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:56:55 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 08:56:55 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 08:56:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVHApgBT1f/Render', 08:56:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:55 INFO - 'HOME': '/Users/cltbld', 08:56:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:55 INFO - 'LOGNAME': 'cltbld', 08:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:55 INFO - 'MOZ_NO_REMOTE': '1', 08:56:55 INFO - 'NO_EM_RESTART': '1', 08:56:55 INFO - 'PAGER': '/bin/cat', 08:56:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:55 INFO - 'PWD': '/builds/slave/test', 08:56:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:55 INFO - 'SHELL': '/bin/bash', 08:56:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G9IH9LxQSN/Listeners', 08:56:55 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:56:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:55 INFO - 'USER': 'cltbld', 08:56:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:55 INFO - 'XPC_FLAGS': '0x0', 08:56:55 INFO - 'XPC_SERVICE_NAME': '0', 08:56:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:55 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-PYzUjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:55 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Leyffj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:55 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Qxcc5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:55 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-xtJnzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:55 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-w9cO2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:56 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-eWAA1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:56 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-SX9lu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:56 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-EFbF4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:56 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-3m5Wae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:56 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-r74oaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:56 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-hGALsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:56 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Dm0fhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:56 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-TjzH93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:56 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-mdk3un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:57 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-omTY3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:57 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-N5MISt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:57 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-pXUfMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:56:57 INFO - Running setup.py install for manifestparser 08:56:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:56:57 INFO - Running setup.py install for mozcrash 08:56:57 INFO - Running setup.py install for mozdebug 08:56:57 INFO - Running setup.py install for mozdevice 08:56:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:56:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:56:57 INFO - Running setup.py install for mozfile 08:56:58 INFO - Running setup.py install for mozhttpd 08:56:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:56:58 INFO - Running setup.py install for mozinfo 08:56:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:56:58 INFO - Running setup.py install for mozInstall 08:56:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:56:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:56:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:56:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:56:58 INFO - Running setup.py install for mozleak 08:56:58 INFO - Running setup.py install for mozlog 08:56:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:56:58 INFO - Running setup.py install for moznetwork 08:56:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:56:58 INFO - Running setup.py install for mozprocess 08:56:59 INFO - Running setup.py install for mozprofile 08:56:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:56:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:56:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:56:59 INFO - Running setup.py install for mozrunner 08:56:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:56:59 INFO - Running setup.py install for mozscreenshot 08:56:59 INFO - Running setup.py install for moztest 08:56:59 INFO - Running setup.py install for mozversion 08:56:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:56:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:56:59 INFO - Cleaning up... 08:56:59 INFO - Return code: 0 08:56:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:59 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')]} 08:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:59 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')]} 08:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:59 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 0x102ce5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c5b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fe1597a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102af9d30>, '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 0x10295fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af1b20>, '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.UVHApgBT1f/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.G9IH9LxQSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:56:59 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 08:56:59 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 08:56:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVHApgBT1f/Render', 08:56:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:59 INFO - 'HOME': '/Users/cltbld', 08:56:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:59 INFO - 'LOGNAME': 'cltbld', 08:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:59 INFO - 'MOZ_NO_REMOTE': '1', 08:56:59 INFO - 'NO_EM_RESTART': '1', 08:56:59 INFO - 'PAGER': '/bin/cat', 08:56:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:59 INFO - 'PWD': '/builds/slave/test', 08:56:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:59 INFO - 'SHELL': '/bin/bash', 08:56:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G9IH9LxQSN/Listeners', 08:56:59 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:56:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:59 INFO - 'USER': 'cltbld', 08:56:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:59 INFO - 'XPC_FLAGS': '0x0', 08:56:59 INFO - 'XPC_SERVICE_NAME': '0', 08:56:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:57:00 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-R1ZHJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:57:00 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)) 08:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:57:00 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-VBqy3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:57:00 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-e8ML_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:57:00 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)) 08:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:57:00 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-t3WXf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:57:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:57:00 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-I1EaUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:57:00 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)) 08:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:57:00 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ZC822j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:57:00 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)) 08:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:57:00 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-j9jtO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:57:00 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)) 08:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:57:00 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-3YpeiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:57:01 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)) 08:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:57:01 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-8vOkmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:57:01 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)) 08:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:57:01 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-QI1WZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:57:01 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)) 08:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:57:01 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-uqE3px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:57:01 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)) 08:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:57:01 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-axEsUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:57:01 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ggdubl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:57:01 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)) 08:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:57:01 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-wQU35D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:01 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-pRGhpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:01 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)) 08:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:57:01 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-mwk95E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:57:01 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-gdIdTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:57:01 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)) 08:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:57:01 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)) 08:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:57:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:57:01 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 08:57:01 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 08:57:01 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 08:57:01 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 08:57:01 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 08:57:01 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 08:57:04 INFO - Downloading blessings-1.6.tar.gz 08:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:57:04 INFO - Installing collected packages: blessings 08:57:04 INFO - Running setup.py install for blessings 08:57:04 INFO - Successfully installed blessings 08:57:04 INFO - Cleaning up... 08:57:04 INFO - Return code: 0 08:57:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:57:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:57:05 INFO - Reading from file tmpfile_stdout 08:57:05 INFO - Current package versions: 08:57:05 INFO - blessings == 1.6 08:57:05 INFO - blobuploader == 1.2.4 08:57:05 INFO - docopt == 0.6.1 08:57:05 INFO - functools32 == 3.2.3-2 08:57:05 INFO - jsonschema == 2.5.1 08:57:05 INFO - manifestparser == 1.1 08:57:05 INFO - mozInstall == 1.12 08:57:05 INFO - mozcrash == 0.17 08:57:05 INFO - mozdebug == 0.1 08:57:05 INFO - mozdevice == 0.48 08:57:05 INFO - mozfile == 1.2 08:57:05 INFO - mozhttpd == 0.7 08:57:05 INFO - mozinfo == 0.9 08:57:05 INFO - mozleak == 0.1 08:57:05 INFO - mozlog == 3.4 08:57:05 INFO - moznetwork == 0.27 08:57:05 INFO - mozprocess == 0.23 08:57:05 INFO - mozprofile == 0.28 08:57:05 INFO - mozrunner == 6.12 08:57:05 INFO - mozscreenshot == 0.1 08:57:05 INFO - mozsystemmonitor == 0.3 08:57:05 INFO - moztest == 0.7 08:57:05 INFO - mozversion == 1.4 08:57:05 INFO - psutil == 3.1.1 08:57:05 INFO - requests == 1.2.3 08:57:05 INFO - wsgiref == 0.1.2 08:57:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:05 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 0x102ce5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c5b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fe1597a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102af9d30>, '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 0x10295fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af1b20>, '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.UVHApgBT1f/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.G9IH9LxQSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:57:05 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 08:57:05 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 08:57:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVHApgBT1f/Render', 08:57:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:05 INFO - 'HOME': '/Users/cltbld', 08:57:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:05 INFO - 'LOGNAME': 'cltbld', 08:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:05 INFO - 'MOZ_NO_REMOTE': '1', 08:57:05 INFO - 'NO_EM_RESTART': '1', 08:57:05 INFO - 'PAGER': '/bin/cat', 08:57:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:05 INFO - 'PWD': '/builds/slave/test', 08:57:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:05 INFO - 'SHELL': '/bin/bash', 08:57:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G9IH9LxQSN/Listeners', 08:57:05 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:57:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:05 INFO - 'USER': 'cltbld', 08:57:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:05 INFO - 'XPC_FLAGS': '0x0', 08:57:05 INFO - 'XPC_SERVICE_NAME': '0', 08:57:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:05 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)) 08:57:05 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)) 08:57:05 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)) 08:57:05 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)) 08:57:05 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)) 08:57:05 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)) 08:57:05 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)) 08:57:05 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)) 08:57:05 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)) 08:57:05 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)) 08:57:05 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)) 08:57:05 INFO - Cleaning up... 08:57:05 INFO - Return code: 0 08:57:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:05 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 0x102ce5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c5b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fe1597a50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102af9d30>, '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 0x10295fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af1b20>, '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.UVHApgBT1f/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.G9IH9LxQSN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 08:57:05 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 08:57:05 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 08:57:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVHApgBT1f/Render', 08:57:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:05 INFO - 'HOME': '/Users/cltbld', 08:57:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:05 INFO - 'LOGNAME': 'cltbld', 08:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:05 INFO - 'MOZ_NO_REMOTE': '1', 08:57:05 INFO - 'NO_EM_RESTART': '1', 08:57:05 INFO - 'PAGER': '/bin/cat', 08:57:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:05 INFO - 'PWD': '/builds/slave/test', 08:57:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:05 INFO - 'SHELL': '/bin/bash', 08:57:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G9IH9LxQSN/Listeners', 08:57:05 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:57:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:05 INFO - 'USER': 'cltbld', 08:57:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:05 INFO - 'XPC_FLAGS': '0x0', 08:57:05 INFO - 'XPC_SERVICE_NAME': '0', 08:57:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:57:06 INFO - Cleaning up... 08:57:06 INFO - Return code: 0 08:57:06 INFO - Running post-action listener: _resource_record_post_action 08:57:06 INFO - Running post-action listener: _start_resource_monitoring 08:57:06 INFO - Starting resource monitoring. 08:57:06 INFO - [mozharness: 2016-11-01 15:57:06.044320Z] Finished create-virtualenv step (success) 08:57:06 INFO - [mozharness: 2016-11-01 15:57:06.045302Z] Running install step. 08:57:06 INFO - Running pre-action listener: _resource_record_pre_action 08:57:06 INFO - Running main action method: install 08:57:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:57:06 INFO - Reading from file tmpfile_stdout 08:57:06 INFO - Detecting whether we're running mozinstall >=1.0... 08:57:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:57:06 INFO - Reading from file tmpfile_stdout 08:57:06 INFO - Output received: 08:57:06 INFO - Usage: mozinstall [options] installer 08:57:06 INFO - Options: 08:57:06 INFO - -h, --help show this help message and exit 08:57:06 INFO - -d DEST, --destination=DEST 08:57:06 INFO - Directory to install application into. [default: 08:57:06 INFO - "/builds/slave/test"] 08:57:06 INFO - --app=APP Application being installed. [default: firefox] 08:57:06 INFO - mkdir: /builds/slave/test/build/application 08:57:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:57:38 INFO - Reading from file tmpfile_stdout 08:57:38 INFO - Output received: 08:57:38 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:57:38 INFO - Running post-action listener: _resource_record_post_action 08:57:38 INFO - [mozharness: 2016-11-01 15:57:38.846730Z] Finished install step (success) 08:57:38 INFO - [mozharness: 2016-11-01 15:57:38.846863Z] Running run-tests step. 08:57:38 INFO - Running pre-action listener: _resource_record_pre_action 08:57:38 INFO - Running main action method: run_tests 08:57:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:57:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:57:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:57:38 INFO - 2016-11-01 08:57:38.861 screenresolution[1638:7438] starting screenresolution argv=screenresolution get 08:57:38 INFO - 2016-11-01 08:57:38.864 screenresolution[1638:7438] Display 0: 1600x1200x32@60 08:57:38 INFO - 2016-11-01 08:57:38.869 screenresolution[1639:7441] starting screenresolution argv=screenresolution list 08:57:38 INFO - Available Modes on Display 0 08:57:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:57:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:57:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:57:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:57:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:57:39 INFO - Intel Iris: 08:57:39 INFO - Chipset Model: Intel Iris 08:57:39 INFO - Type: GPU 08:57:39 INFO - Bus: Built-In 08:57:39 INFO - VRAM (Dynamic, Max): 1536 MB 08:57:39 INFO - Vendor: Intel (0x8086) 08:57:39 INFO - Device ID: 0x0a2e 08:57:39 INFO - Revision ID: 0x0009 08:57:39 INFO - Displays: 08:57:39 INFO - Display: 08:57:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:57:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:57:39 INFO - Display Serial Number: 1600x1200 60 08:57:39 INFO - Main Display: Yes 08:57:39 INFO - Mirror: Off 08:57:39 INFO - Online: Yes 08:57:39 INFO - Rotation: Supported 08:57:39 INFO - Return code: 0 08:57:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:57:39 INFO - Python 2.7.3 08:57:39 INFO - Return code: 0 08:57:39 INFO - grabbing minidump binary from tooltool 08:57: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')]} 08:57:39 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 0x102af9d30>, '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 0x10295fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102af1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:57:39 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 08:57:39 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 08:57:39 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 08:57:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:57:39 INFO - Return code: 0 08:57:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:57:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:57:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:57:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:57:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:57:39 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/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0005', '--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 08:57:39 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/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0005 --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 08:57:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UVHApgBT1f/Render', 08:57:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:39 INFO - 'HOME': '/Users/cltbld', 08:57:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:39 INFO - 'LOGNAME': 'cltbld', 08:57:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:57:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:39 INFO - 'MOZ_NO_REMOTE': '1', 08:57:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:57:39 INFO - 'NO_EM_RESTART': '1', 08:57:39 INFO - 'PAGER': '/bin/cat', 08:57:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:39 INFO - 'PWD': '/builds/slave/test', 08:57:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:57:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:39 INFO - 'SHELL': '/bin/bash', 08:57:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.G9IH9LxQSN/Listeners', 08:57:39 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 08:57:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:39 INFO - 'USER': 'cltbld', 08:57:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:39 INFO - 'XPC_FLAGS': '0x0', 08:57:39 INFO - 'XPC_SERVICE_NAME': '0', 08:57:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:39 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/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0005', '--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 08:57:39 INFO - mozversion application_buildid: 20161101063617 08:57:39 INFO - mozversion application_changeset: e5d9f12de81ed7bb1c237f72db80da9c1fff9ee6 08:57:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:57:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:57:39 INFO - mozversion application_name: Firefox 08:57:39 INFO - mozversion application_remotingname: firefox-dev 08:57:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:57:39 INFO - mozversion application_vendor: Mozilla 08:57:39 INFO - mozversion application_version: 51.0a2 08:57:39 INFO - mozversion platform_buildid: 20161101063617 08:57:39 INFO - mozversion platform_changeset: e5d9f12de81ed7bb1c237f72db80da9c1fff9ee6 08:57:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:57:39 INFO - mozversion platform_version: 51.0a2 08:57:39 INFO - using testdate: 1478015859 08:57:39 INFO - actual date: 1478015859 08:57:39 INFO - starting webserver on 'localhost:49267' 08:57:39 INFO - SUITE-START | Running 2 tests 08:57:39 INFO - TEST-START | dromaeo_css 08:57:39 INFO - operating with platform_type : mac_ 08:57:39 INFO - Initialising browser for dromaeo_css test... 08:57:39 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmp_4p9Mv/profile http://localhost:49267/getInfo.html) 08:57:41 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 08:57:41 INFO - PROCESS | 1649 | colorDepth:24 08:57:41 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 08:57:41 INFO - PROCESS | 1649 | __metrics 08:57:42 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:57:42 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:57:42 INFO - TEST-INFO | 1649: exit 0 08:57:42 INFO - Browser initialized. 08:57:42 INFO - Running cycle 1/1 for dromaeo_css test... 08:57:42 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmp_4p9Mv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:57:54 INFO - PROCESS | 1654 | RSS: Main: 219926528 08:57:54 INFO - PROCESS | 1654 | 08:58:45 INFO - PROCESS | 1654 | 1478015925984 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:00:58 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 09:00:59 INFO - PROCESS | 1654 | RSS: Main: 372391936 09:00:59 INFO - PROCESS | 1654 | 09:04:02 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 09:04:03 INFO - PROCESS | 1654 | RSS: Main: 348176384 09:04:03 INFO - PROCESS | 1654 | 09:07:05 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 09:07:05 INFO - PROCESS | 1654 | RSS: Main: 318676992 09:07:05 INFO - PROCESS | 1654 | 09:10:08 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 09:10:08 INFO - PROCESS | 1654 | RSS: Main: 324161536 09:10:08 INFO - PROCESS | 1654 | 09:13:12 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 09:13:12 INFO - PROCESS | 1654 | RSS: Main: 309743616 09:13:12 INFO - PROCESS | 1654 | 09:16:16 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 09:16:16 INFO - PROCESS | 1654 | RSS: Main: 506847232 09:16:16 INFO - PROCESS | 1654 | 09:16:16 INFO - PROCESS | 1654 | __start_tp_report 09:16:16 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 09:16:16 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 09:16:16 INFO - PROCESS | 1654 | |i|pagename|runs| 09:16:16 INFO - PROCESS | 1654 | |0;dojo.html;3252.7072563469283;3306.818125003124;3336.33273345331;3338.0987133473946;3391.050505858359;5667.801626943058;5728.484436400723;5759.280089988752;5762;5764.625299355539;5738.512226460756;5754;5765.423457654232;5766.423357664242;5776.480116789488;5203.60972927032;5214.426413094557;5218.843434696965;5235.842924712265;5251.632385733;4412.514623391425;5130.666506677054;5152.793888244466;5289.68261904287;5318.335208098988;4298.957010429903;5161.793528258884;5199.740012999354;5236.842894713165;5238.47615238475;5221.686698798084;5277.234800953878;5332.706701131437;5335.813246536352;5342.038433082043;5185.351831021122;5227.398849132361;5251.369835619712;5268.5521730652945;5291.603129765244;4628.560286772751;5501.944980550184;5609.467100625434;5617.21359009739;5647.576431767634;6117.736059405531;6170.136180934673;6174.536909731788;6185.319614842364;6194.318624951252;6162.84592885177;6235.532335074888;6241.719122639447;6241.906371404432;6252.5935814171935;5689.118186681112;5744.770209191585;5784.421557844182;5823.79616713413;5858.326292476378;6232.844178895564;6241.687915604201;6242.65665388408;6253.937460625336;6262.530310226751;6200.751969921243;6204.720787564571;6206.627602343874;6207;6211.875762484816;6102.298235702862;6105.572609917263;6133.8855759873895;6136.151476879633;6223.595466294767;5275.894482110336;6165.722542485599;6234.251889773256;6234.594751341148;6269.435750782452;6215.471684906744;6280.466160376328;6281.811545653638;6288.245410550671;6295.276043254993;4792.017636384602;4897.1674815281485;4948.158813001726;4964.975175124174;4984.675996060245;4342.1532801103485;4434.512203657595;4435.334699795057;4444.266695995189;4494.213512635276;5798.768049278066;5799.246098007232;5803.419658034163;5803.622764520293;5809.157672137517;6295.307516173218;6296.401841825019;6307.022411526221;6316.589421687576;6323.494120470444;4601.976990115028;4776.904461910743;5713.085906254979;5728.198052272685;5794.971025144847;4192.580741925783;4451.376807246988;5408.242846001563;5436;5436.537894278951;5891.734871930859;6316.178896743394;6316.463100636497;6330.240371155399;6335.461485773761;6144.56988010835;6163.445289923929;6233.625982441068;6242.781502647385;6245.313015568375;6190.566660333913;6227.844303892439;6230.813075607739;6271.466925311217;6273.99616061428;6156.938430615815;6163.876722465615;6169.50643948474;6173.6913154343;6176.4441200292185;6154.353792851865;6187.535934804818;6198.535109866688;6270.811875643738;6293.779717709858;5984.58107932458;6021.006533921854;6041.093835924647;6075.1191077294425;6123.112148738319;6119.228375855631;6135.202423685071;6146.877062458815;6154.876902461836;6160.10678451631;5875.3243377012195;5984.670843103671;6005.759769609167;6034.366391528826;6040.6979651018155;5200.167973124282;6011.759529618941;6061;6090.299615544269;6131.84670383244;5017.598592112549;6042.456178943916;6054.182685337423;6089.147519347206;6104.633721976696 09:16:16 INFO - PROCESS | 1654 | |1;ext.html;495.980759539147;504.5181851331976;509.236145781328;529.7642549065667;564.4778579813672;31616.20959476014;42500;43689.126217475634;43791.78104109483;43831.34252986208;44565.331520027226;44921.550784492145;45122.774386128025;45134;45187.32219016717;9778.755531111708;9974.850377244347;9985.151262142726;9993.400395976229;10002.649907253248;9802.754931126743;9920.40477571348;9930.950345248264;9931.255155863302;9942.850857237147;9816.312858099936;9859.90140098597;9934.850977235346;9951.55218015191;9968.95015524925;9886.555105020256;9915.504224788732;9927.751806204831;9933.652322168726;9942.254330925209;8378.622961966665;9798.020197980144;9809.509524523744;9904.316266234757;9919.156871665917;41782.955426114284;42017.369739453934;42179.36730949038;42249.36625950583;42279.788601056796;3252.317013427183;3378.4425569780956;3405.9659403405894;3412.351653185887;3427.8114703691285;29832;30925.381492370252;31529.36941261162;32581.83709081463;32920.670793292236;2702.8783704733137;3141.0419821954297;3202.4876019836715;3233.4988076848126;3233.757468189872;503457;505729;511293;511352.4432377814;512642;61320.69339653273;61613.38386616166;61707.38292617106;61717;61758.764824703256;30548.694513054586;35052.474212886824;35684.75103371369;37593.436098458544;66789.99815002682;17544.561385965197;17718.379856704953;17724.46826595204;17744.3789467368;17793.288268469376;13390.93304533471;13469.12450690702;13475.528356507475;13478.663033424047;13492.5277615283;19498.31755888537;19814.108365123604;19853.305134320228;19889.403317900196;19890.403287901387;7787.338076263468;7851.803704907423;7852.60736963161;7895.328897043701;7927.326177274881;822.9465084769471;836.3727204596553;912.5346073502561;1034.1984961654628;1046.68076236747;29319.97380091729;30182.943596974;30372.84813575918;31014;31227.219319517193;852.5907564369013;889.0087552379051;921.8847644044495;1070.769784496337;1073.7745073534488;12939.805902911465;16989.830101698826;17097.401590944257;17348.739768903477;17496.47510574685;695650;696403;698172;698387;698656;56671;57040.85918281611;57149.14276285859;57314.7134264326;57382.42617573855;1236.758832027746;1277.163457935054;1278.360819590205;1278.5844600504872;1280.782267014591;27309.72690273072;27931.58102628503;33388.66611333856;33470.497942531365;33969.49045764365;58289.70855145697;59228;59312;59369.10946335722;59379.703101484214;665651;670667;670819;671436;672628;22766.772332276465;27376.315592110357;27878.30304242329;27912;28424.715752842207;40552.391714124904;49578;49766.50233497618;50110.24834627556;50234;39704.80147599243;40822.79588602038;40857.79571102125;41543;42423;39986.00034999148;40205.597944020185;40834.38748418835;41956.3706544396;42270.36594451024;31347.21631959128;39464.01339966409;39626.60373396344;39823;42051.57948420599;34064.31871362509;35924.64075359213;36498.08754781152;36552;37341.2531749358;25850.482990340464;26153.346166345233;26333.736662633128;26434.942602295694;26829 09:16:16 INFO - PROCESS | 1654 | |2;jquery.html;375.9585946927012;378.75570257184137;388.4445243302077;397.658014107867;406.5467004290217;15839.762403563942;18619.720704189433;19489.805101949012;19577.119029643665;19704.605907881833;20108.89945550274;20239.696404553943;20934.267300644442;21441.356759297207;21626.24308149215;5640.7461664225;5952.6130801497875;5972;6162.815115546518;6239.438450539451;6129.754809807602;6185.195924529805;6213.596116252452;6245.188125543673;6247.06294055893;5955.731992060346;6205.10026046223;6254.530910181755;6323.272823625273;6365.777197798078;6169.3522180170885;6230.5638605297645;6269.655168965705;6316.147320111772;6330.905036424458;6098.481629061535;6164.476019538344;6182.103594978747;6182.876342473125;6185.628862268279;11963.222390544586;12352.691182720504;13145.342732863319;13232.536861209908;13314.533991310258;2217.5121473275854;2247.2471721973156;2317.9304620861403;2355.7644235576477;2902.6226590543306;9899.15857152143;10024.949875250577;10192.388456692623;10578.206634502443;10653.307535010277;1856.3781133320354;1888.055972013993;1956.9706454403054;1975.2987689370211;1975.5752513209586;113278.63688860198;115852;128847;129353.35323323417;134913.65086349208;7660.502067365604;9869.11177993984;10193.643222487177;10228.437435941094;11319.26424782403;12501.187422817487;12619;12626.368681565886;12635.747285054247;12638.494460221487;6134.478569321568;7625.771226863203;7626.69493220276;7710.228977102357;7729.497582657222;7642.885356719654;7650.885236721454;7662.118856331482;7792.064952205772;7811.023622047244;3941.8620348288246;3944.9605503944595;3956.1692044670367;4024.2353952748886;4035.1727895781296;1763.8147994460396;1807.0193490222657;1909.9140538675515;1928.8746231494908;1961.7322654120235;796.8207153390441;969.7769513012047;980.4901451245313;982.4841957972122;1003.6938733686296;20763.480912977295;22225.888870555544;22297.888510557343;22349.770762607888;22385.888070559544;912.4069354919222;920.9861852072224;944.0653752784693;953.6137864165024;955.5938726041404;9519.762005949768;11698.667662806625;11850.407479625985;11912.40437978115;11921.940390297994;598665;603492;609203.9539802272;615430;616284;122205;131137;132416.37918104057;138816;155294.447055528;825.6738588257605;959.467495539982;1004.9547770350351;1038.5897570459626;1039.9012093851072;13865.653358666113;14585.885046668385;20137.798622013594;20138.59722805565;20206.29277975264;57351.426485734606;57917.710411447675;58521.82956340764;59111.704441477516;60157;80660;81303;82018;82820.58589707012;82854;8127.715529956423;8164.918350816416;8199.426040177368;8317.750467485985;8440.282575981111;12677.492900283885;12783.360831958178;13058.281794501394;13318;13521.526746563823;8676.392652514263;11056.613018544313;11183.552657893593;11337.829932551183;11543.36511491876;11246.212765106364;11270.605528806453;11489.770204596029;11693.123015774021;11870.881291186977;11198.664040078811;11589.710257243636;11834.52661893549;11911.404429778304;11931.880681193425;8128.634211460617;8306.83386332258;8354;8423.11557286476;8487.533185674847;8993.865092023494;10693.9465302673;11496.770064598828;11506.712332191762;11843.70390740204 09:16:16 INFO - PROCESS | 1654 | |3;mootools.html;1386.4315630591457;1501.4369611395728;1664.750287456882;1827.661882551727;1862.6274745050985;8407.747767566967;8931.972823125343;8985.415947963378;9091.818163636723;9093.272538196945;7782.96108519458;7988.121306656263;8017.67929282828;8532.91467085329;8658.523781192032;1957.1290775604825;2413.4811015631635;2419.9153029643967;2426.7209270933804;2431.8905649245826;2386.284114765572;2398.760123987596;2405.5429468401035;2426.8543887366727;2443.5723748344058;2404.0744313439277;2411.6623672685837;2420.9031638734427;2430.0887167312258;2430.1251549442186;2377.5839228135005;2388.1163969331283;2394.856308621488;2397.8681172535503;2402.435427674486;2367.088670861731;2367.2779802160335;2371.513839662865;2379.0602711928864;2382.2614989353183;8616.224539791448;8881.156290152425;8906.198442140174;8936.687215947475;8955.507447090407;5181.663191892552;5324.787008519655;5355.518003379676;5385.569154467633;5428.83713488596;3459.7924124552605;3464.7401444891734;3672.0085576894357;3682.668559829628;3693.021349342426;1047.3422336075698;1075.714935542082;1087.33129125588;1100.779844031197;1110.134095405585;11410.030147437477;11520.423978801111;11553.30680159193;11606.187566870323;11682.766344673144;4529;4665.650076244296;4823.517648235219;4836.758162091881;4853.563179313879;9847.852282215772;9900.851487227697;9934.254930880214;9937.652182173733;10016.248781341428;5351.170568561879;5351.491608297206;5387.515123638891;5405.864853378618;5408.486193811582;4019.7667444845947;4380.0582874682095;4748.19280722278;4942.332785074041;4972.875678108004;3934.409838524187;3964.960350396517;4034.8184331705143;4037.959620403817;4046.291898917678;1281.9038572106942;1283.332667013148;1291.3156027305542;1300.830891984036;1302.9934850325687;872.1714371347246;882.4705176893813;888.2982443869271;902.7923577577194;912.2884150362728;4921.901561968741;5120.308758317654;5520.558355331564;5783.074708046776;5950.761969521257;866.6663334616218;877.7937184761576;898.9796580880748;916.6974898283684;927.8840144981878;3720.3489389356755;3876.9224615507533;3944.013996500875;3956.248312820555;3982.8406863725127;9721.805563888682;10677.145828333714;10687.679369618923;10854.891451085547;10933.398663073449;10552.103071239031;10870.945645271722;10920.781584368267;10921.12630989519;10997.945010275058;8089.150639182919;8215.34277257818;8256.339492840678;8373.958130209432;8384.790380240544;5661.518770904519;5725.19847221381;5762.135679648086;5845.1232315151365;5970.462658360769;9813.901860981585;9956.153726933291;10044.799104018024;10170.338927969658;10218.540165692413;10022.298439109192;10076;10217.33587316822;10245.538950747085;10542.314749541256;6531.836704082436;6721.899171512334;6756.6959486822225;7020.192677841909;7210.9278907210255;8084.87872681922;8189.426740128134;8285.50286982783;8524.36067294943;8554.18735220153;7399.519031262951;7438.330550250504;7444.888326674996;7575.431842611716;7693.230676932262;7255.709771609288;7305.744298949511;7316.597587132759;7412.518186317872;7444.218357072429;6928.203256625553;7016.543924644881;7042;7075.5047146699235;7114.786556403316;4909.361782968192;4914.311996320446;4944.728039957837;4959.851204463872;5029.44676085623;4140.523839758466;4596.264597664492;4932.53140951609;5022.472640372708;5062.468440813662 09:16:16 INFO - PROCESS | 1654 | |4;prototype.html;245.83160535033502;302.35598175885366;309.96900309969;314.718327097248;316.52679244529435;4079.5716449772754;4522.186006518826;5041.899162016757;5136.691798492093;5218.26944227808;4319.352097185424;4831.444383895853;4971.602271818246;5010.549050585447;5192.558632516231;3999.540052893911;4010.19796040793;4017.6986725995666;4027.919441611173;4035.6771458283265;3680.742348035625;3763.6612704856557;4037.7577345359227;4039.656629186523;4055.614716601918;3331.8172048922647;3867.149227170018;3913.7651740895494;3944.4280579315982;3976.125252444472;3846.2692088503236;3920.4315374270714;3924.7448915820382;3935.9016024599614;3937.232239713257;3437.9484307735406;3457.6888080072663;3459.290845376692;3465.047112044183;3476.28736109097;3855.7879316637573;4258.041940563379;4641.535846415365;4817.578814249805;5008.949910500921;4469.463664360265;4482.9551704482865;4494;4510.751908645023;4522.68341216115;4048.4332193492933;4500.459944806644;4951.331570238044;5400.540954018913;5452.209429632681;3426.6573342665783;3806.7335286529956;3827.445020472044;3829.8468061277517;3849.095462566295;4778.2115950868065;4888.388951381077;5419.918701219485;5642.858928526779;5671.092625179993;3780.5652349980105;3795.8291876865605;3806.980965095157;3837.846486140523;3847.3844184930276;3256.46268365717;3853.8265778040054;3893.357595996629;3894.4547763313158;3904.1020565270146;3944.3689009758873;4278.935815962763;4480.910381792346;4488.438945131858;4613.938794077381;5354.955783622234;5402.243685883979;5446.373667028263;5448.42791506894;5504.862378440491;1120.456578559398;1127.2898074213358;1135.3358285402967;1142.9998751092794;1211.249025604131;766.7469734987441;845.9323254139654;897.7620930453435;904.0597778310615;907.4645958884158;5153.407358153785;5209.895802083937;5224.604007395147;5237.214417837278;5238.371395432497;4535.931961020588;4558.658100642465;5284.920726189111;5385.246065550826;5716.314042314949;4770.022145460172;4789.880252993703;5231.790728370898;5282.339707536558;5302.575793936476;2588.6021548363674;2970.9554356684666;2998.205475548981;3005.6844031376827;3021.6222972128485;5125.666831655931;5571.60998730085;5721.885562288731;5858.443447872445;5886.6173698709445;4896.510348965075;5776.451237132465;5790.971045144832;5808.30300363959;5846.181534585162;5699.2590963174525;5849.473547380756;5928.525717942554;5941.70291485424;6015.969920150371;5337.439568845215;5635.408282130317;5686.744096515749;5695.430456954271;5700.771969121189;5314.946850531445;5665.773369065191;5668.603197776116;5670.291213598301;5757.395473475225;5224.817131400383;5939.91090133657;5980.803839232084;5985.264273360851;6008.459238668541;3220.9838950805097;3759;3848.5381754189675;3852.3643598805884;3860.9034774130873;4756.643251756202;5738.340090889601;5747.48272655463;5750.878578677118;5776.971115144397;4355.803988820448;4655.743934083658;5604.775808967595;5604.775808967759;5676.687782171855;5594.272744543184;5595.356533998643;5596.468335508121;5621.634593751393;5660.7169641518585;4476.5299643538265;5119.257707632447;5240;5342.626016178986;5586.357568879631;5266.07843627356;5399.568034557147;5483.341998960151;5498.340199175965;5645.4072322405555;5126.384833819965;5199.818006369759;5375.274337964481;5384.600003999067;5397.78408863641 09:16:16 INFO - PROCESS | 1654 | |5;yui.html;721.9855602887939;737;753.1527032088899;757.7953952432844;769.2576663519702;13296;15124.016938898963;15806.604834879105;16497.83502164978;16579.25393357299;14549.781753273683;14933.92533037336;14968.775468367983;14975.850241497581;15077.019993700402;690.2407351912906;717.0785540580355;842.7977285451478;861.4357595774777;865.5023361567092;709.4359983812856;845.5096044294295;872.2324354567971;878.0999475537593;881.4446898453965;864.2567392042838;865.0398058155442;881.9250363719092;917.1928702741611;918.0406475233397;720.3121019426435;905.9184673379394;910.167197014734;913.5021413329684;917.7338571814166;551.4981366956051;652.5399593286721;668.1080757189159;674.1169068520254;675.1729131813489;15224.771628425582;15272.694546109016;15282.159481228528;15291.770623440658;15299.388024479007;13727.931360343135;14051.64870878226;14072.22602756848;14097.577072687836;14431.567052988426;12265.603134620738;12519.326853762139;12565.371731413392;12655.683607909783;13060.738785224337;3381.7994611912663;3460.411730005905;3530.858765649371;3532.8586856525967;3572.4641303804638;102224.48887755514;120560;128790.3560482201;129712;130181.34909325487;10734.2486025979;10992.84575119601;11019.944900275448;11115.777684446266;11135.05352045069;22349;22479.66280505794;22479.66280505794;22487.32538023862;22491.100355985578;7656.502327348704;7770.10643775973;7773.883391749128;8007.119216886138;8008.919910800934;4286.207051695446;4393.406890069864;4402.25161722508;4444.622207112367;4539.341795439643;3429.7599168058496;3503.5095086687884;3542.3092496962845;3546.4857595648486;3567.304375646724;619.123939625425;631.425402883374;632.1497585747163;642.5662677692538;645.9483241340776;589.7581991383598;603.2820943077724;619.7397093220858;619.8543342314553;639.6449970266453;8595.957020214859;8923.553822308988;9285.978542360335;9303.441793492277;9326.067393260755;538.526097034607;568.4400865147826;578.9015867302485;595.6455908734296;632.4213344789558;4207.305794543866;4516.728996260234;4525.253333200051;4538.682292239511;4638.281066434708;104079;128663;167841;168791.15604421898;171314;122578.77421225673;122701;131516.3424182873;138799.6120038807;140850;61590.38409615936;82034.58982705048;96857;126411.99999999817;126617;9374.67188648394;9989.700308990741;10446.216533760151;10463.267571269938;10465.215108866712;58696;63885;66490.67546622553;67161.66419167873;67837;99001;101914.35642327003;105423.54109189066;105850.94149058411;107874.92125078649;13423.060385772902;13627.454901803816;13804.447822087406;14303.141811491343;14445.205513696848;14138.293085345897;15130.470433534774;15392.461263855712;15906.602334941255;15950.760738588699;13450.192988420726;13562.660933476742;14380.85853359023;15261.771073434129;15272.694546109238;13406.530771422953;14018.649533761329;14227.715445691236;14846.0188920499;14965;13150.539731109366;13326.866731332562;13928.72142557123;13937.30313484342;14545.127292362493;11029.283096598696;11199.552017919192;11632.360220187971;11852.525898963944;11970.221935574507;10721.839172412576;11081.778364432828;11632.18574699763;11876.406179691154;11910.761784764429 09:16:16 INFO - PROCESS | 1654 | __end_tp_report 09:16:16 INFO - PROCESS | 1654 | __start_cc_report 09:16:16 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1419 09:16:16 INFO - PROCESS | 1654 | __end_cc_report 09:16:16 INFO - PROCESS | 1654 | __startTimestamp1478016976257__endTimestamp 09:16:16 INFO - PROCESS | 1654 | 09:16:16 INFO - PROCESS | 1654 | ------- Summary: start ------- 09:16:16 INFO - PROCESS | 1654 | Number of tests: 6 09:16:16 INFO - PROCESS | 1654 | 09:16:16 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5695.09 Median:6005.76 stddev:685.45 (11.4%) stddev-sans-first:660.23 09:16:16 INFO - PROCESS | 1654 | Values: 3252.7 3306.8 3336.3 3338.1 3391.1 5667.8 5728.5 5759.3 5762.0 5764.6 5738.5 5754.0 5765.4 5766.4 5776.5 5203.6 5214.4 5218.8 5235.8 5251.6 4412.5 5130.7 5152.8 5289.7 5318.3 4299.0 5161.8 5199.7 5236.8 5238.5 5221.7 5277.2 5332.7 5335.8 5342.0 5185.4 5227.4 5251.4 5268.6 5291.6 4628.6 5501.9 5609.5 5617.2 5647.6 6117.7 6170.1 6174.5 6185.3 6194.3 6162.8 6235.5 6241.7 6241.9 6252.6 5689.1 5744.8 5784.4 5823.8 5858.3 6232.8 6241.7 6242.7 6253.9 6262.5 6200.8 6204.7 6206.6 6207.0 6211.9 6102.3 6105.6 6133.9 6136.2 6223.6 5275.9 6165.7 6234.3 6234.6 6269.4 6215.5 6280.5 6281.8 6288.2 6295.3 4792.0 4897.2 4948.2 4965.0 4984.7 4342.2 4434.5 4435.3 4444.3 4494.2 5798.8 5799.2 5803.4 5803.6 5809.2 6295.3 6296.4 6307.0 6316.6 6323.5 4602.0 4776.9 5713.1 5728.2 5795.0 4192.6 4451.4 5408.2 5436.0 5436.5 5891.7 6316.2 6316.5 6330.2 6335.5 6144.6 6163.4 6233.6 6242.8 6245.3 6190.6 6227.8 6230.8 6271.5 6274.0 6156.9 6163.9 6169.5 6173.7 6176.4 6154.4 6187.5 6198.5 6270.8 6293.8 5984.6 6021.0 6041.1 6075.1 6123.1 6119.2 6135.2 6146.9 6154.9 6160.1 5875.3 5984.7 6005.8 6034.4 6040.7 5200.2 6011.8 6061.0 6090.3 6131.8 5017.6 6042.5 6054.2 6089.1 6104.6 09:16:16 INFO - PROCESS | 1654 | 09:16:16 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:75262.16 Median:42115.47 stddev:169059.94 (401.4%) stddev-sans-first:169441.00 09:16:16 INFO - PROCESS | 1654 | Values: 496.0 504.5 509.2 529.8 564.5 31616.2 42500.0 43689.1 43791.8 43831.3 44565.3 44921.6 45122.8 45134.0 45187.3 9778.8 9974.9 9985.2 9993.4 10002.6 9802.8 9920.4 9931.0 9931.3 9942.9 9816.3 9859.9 9934.9 9951.6 9969.0 9886.6 9915.5 9927.8 9933.7 9942.3 8378.6 9798.0 9809.5 9904.3 9919.2 41783.0 42017.4 42179.4 42249.4 42279.8 3252.3 3378.4 3406.0 3412.4 3427.8 29832.0 30925.4 31529.4 32581.8 32920.7 2702.9 3141.0 3202.5 3233.5 3233.8 503457.0 505729.0 511293.0 511352.4 512642.0 61320.7 61613.4 61707.4 61717.0 61758.8 30548.7 35052.5 35684.8 37593.4 66790.0 17544.6 17718.4 17724.5 17744.4 17793.3 13390.9 13469.1 13475.5 13478.7 13492.5 19498.3 19814.1 19853.3 19889.4 19890.4 7787.3 7851.8 7852.6 7895.3 7927.3 822.9 836.4 912.5 1034.2 1046.7 29320.0 30182.9 30372.8 31014.0 31227.2 852.6 889.0 921.9 1070.8 1073.8 12939.8 16989.8 17097.4 17348.7 17496.5 695650.0 696403.0 698172.0 698387.0 698656.0 56671.0 57040.9 57149.1 57314.7 57382.4 1236.8 1277.2 1278.4 1278.6 1280.8 27309.7 27931.6 33388.7 33470.5 33969.5 58289.7 59228.0 59312.0 59369.1 59379.7 665651.0 670667.0 670819.0 671436.0 672628.0 22766.8 27376.3 27878.3 27912.0 28424.7 40552.4 49578.0 49766.5 50110.2 50234.0 39704.8 40822.8 40857.8 41543.0 42423.0 39986.0 40205.6 40834.4 41956.4 42270.4 31347.2 39464.0 39626.6 39823.0 42051.6 34064.3 35924.6 36498.1 36552.0 37341.3 25850.5 26153.3 26333.7 26434.9 26829.0 09:16:16 INFO - PROCESS | 1654 | 09:16:16 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:35547.13 Median:2336.85 stddev:102031.15 (4366.2%) stddev-sans-first:102283.20 09:16:16 INFO - PROCESS | 1654 | Values: 376.0 378.8 388.4 397.7 406.5 15839.8 18619.7 19489.8 19577.1 19704.6 20108.9 20239.7 20934.3 21441.4 21626.2 5640.7 5952.6 5972.0 6162.8 6239.4 6129.8 6185.2 6213.6 6245.2 6247.1 5955.7 6205.1 6254.5 6323.3 6365.8 6169.4 6230.6 6269.7 6316.1 6330.9 6098.5 6164.5 6182.1 6182.9 6185.6 11963.2 12352.7 13145.3 13232.5 13314.5 2217.5 2247.2 2317.9 2355.8 2902.6 9899.2 10024.9 10192.4 10578.2 10653.3 1856.4 1888.1 1957.0 1975.3 1975.6 113278.6 115852.0 128847.0 129353.4 134913.7 7660.5 9869.1 10193.6 10228.4 11319.3 12501.2 12619.0 12626.4 12635.7 12638.5 6134.5 7625.8 7626.7 7710.2 7729.5 7642.9 7650.9 7662.1 7792.1 7811.0 3941.9 3945.0 3956.2 4024.2 4035.2 1763.8 1807.0 1909.9 1928.9 1961.7 796.8 969.8 980.5 982.5 1003.7 20763.5 22225.9 22297.9 22349.8 22385.9 912.4 921.0 944.1 953.6 955.6 9519.8 11698.7 11850.4 11912.4 11921.9 598665.0 603492.0 609204.0 615430.0 616284.0 122205.0 131137.0 132416.4 138816.0 155294.4 825.7 959.5 1005.0 1038.6 1039.9 13865.7 14585.9 20137.8 20138.6 20206.3 57351.4 57917.7 58521.8 59111.7 60157.0 80660.0 81303.0 82018.0 82820.6 82854.0 8127.7 8164.9 8199.4 8317.8 8440.3 12677.5 12783.4 13058.3 13318.0 13521.5 8676.4 11056.6 11183.6 11337.8 11543.4 11246.2 11270.6 11489.8 11693.1 11870.9 11198.7 11589.7 11834.5 11911.4 11931.9 8128.6 8306.8 8354.0 8423.1 8487.5 8993.9 10693.9 11496.8 11506.7 11843.7 09:16:16 INFO - PROCESS | 1654 | 09:16:16 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5686.70 Median:4927.22 stddev:3191.29 (64.8%) stddev-sans-first:3183.88 09:16:16 INFO - PROCESS | 1654 | Values: 1386.4 1501.4 1664.8 1827.7 1862.6 8407.7 8932.0 8985.4 9091.8 9093.3 7783.0 7988.1 8017.7 8532.9 8658.5 1957.1 2413.5 2419.9 2426.7 2431.9 2386.3 2398.8 2405.5 2426.9 2443.6 2404.1 2411.7 2420.9 2430.1 2430.1 2377.6 2388.1 2394.9 2397.9 2402.4 2367.1 2367.3 2371.5 2379.1 2382.3 8616.2 8881.2 8906.2 8936.7 8955.5 5181.7 5324.8 5355.5 5385.6 5428.8 3459.8 3464.7 3672.0 3682.7 3693.0 1047.3 1075.7 1087.3 1100.8 1110.1 11410.0 11520.4 11553.3 11606.2 11682.8 4529.0 4665.7 4823.5 4836.8 4853.6 9847.9 9900.9 9934.3 9937.7 10016.2 5351.2 5351.5 5387.5 5405.9 5408.5 4019.8 4380.1 4748.2 4942.3 4972.9 3934.4 3965.0 4034.8 4038.0 4046.3 1281.9 1283.3 1291.3 1300.8 1303.0 872.2 882.5 888.3 902.8 912.3 4921.9 5120.3 5520.6 5783.1 5950.8 866.7 877.8 899.0 916.7 927.9 3720.3 3876.9 3944.0 3956.2 3982.8 9721.8 10677.1 10687.7 10854.9 10933.4 10552.1 10870.9 10920.8 10921.1 10997.9 8089.2 8215.3 8256.3 8374.0 8384.8 5661.5 5725.2 5762.1 5845.1 5970.5 9813.9 9956.2 10044.8 10170.3 10218.5 10022.3 10076.0 10217.3 10245.5 10542.3 6531.8 6721.9 6756.7 7020.2 7210.9 8084.9 8189.4 8285.5 8524.4 8554.2 7399.5 7438.3 7444.9 7575.4 7693.2 7255.7 7305.7 7316.6 7412.5 7444.2 6928.2 7016.5 7042.0 7075.5 7114.8 4909.4 4914.3 4944.7 4959.9 5029.4 4140.5 4596.3 4932.5 5022.5 5062.5 09:16:16 INFO - PROCESS | 1654 | 09:16:16 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4439.67 Median:4923.92 stddev:1380.37 (28.0%) stddev-sans-first:1347.88 09:16:16 INFO - PROCESS | 1654 | Values: 245.8 302.4 310.0 314.7 316.5 4079.6 4522.2 5041.9 5136.7 5218.3 4319.4 4831.4 4971.6 5010.5 5192.6 3999.5 4010.2 4017.7 4027.9 4035.7 3680.7 3763.7 4037.8 4039.7 4055.6 3331.8 3867.1 3913.8 3944.4 3976.1 3846.3 3920.4 3924.7 3935.9 3937.2 3437.9 3457.7 3459.3 3465.0 3476.3 3855.8 4258.0 4641.5 4817.6 5008.9 4469.5 4483.0 4494.0 4510.8 4522.7 4048.4 4500.5 4951.3 5400.5 5452.2 3426.7 3806.7 3827.4 3829.8 3849.1 4778.2 4888.4 5419.9 5642.9 5671.1 3780.6 3795.8 3807.0 3837.8 3847.4 3256.5 3853.8 3893.4 3894.5 3904.1 3944.4 4278.9 4480.9 4488.4 4613.9 5355.0 5402.2 5446.4 5448.4 5504.9 1120.5 1127.3 1135.3 1143.0 1211.2 766.7 845.9 897.8 904.1 907.5 5153.4 5209.9 5224.6 5237.2 5238.4 4535.9 4558.7 5284.9 5385.2 5716.3 4770.0 4789.9 5231.8 5282.3 5302.6 2588.6 2971.0 2998.2 3005.7 3021.6 5125.7 5571.6 5721.9 5858.4 5886.6 4896.5 5776.5 5791.0 5808.3 5846.2 5699.3 5849.5 5928.5 5941.7 6016.0 5337.4 5635.4 5686.7 5695.4 5700.8 5314.9 5665.8 5668.6 5670.3 5757.4 5224.8 5939.9 5980.8 5985.3 6008.5 3221.0 3759.0 3848.5 3852.4 3860.9 4756.6 5738.3 5747.5 5750.9 5777.0 4355.8 4655.7 5604.8 5604.8 5676.7 5594.3 5595.4 5596.5 5621.6 5660.7 4476.5 5119.3 5240.0 5342.6 5586.4 5266.1 5399.6 5483.3 5498.3 5645.4 5126.4 5199.8 5375.3 5384.6 5397.8 09:16:16 INFO - PROCESS | 1654 | 09:16:16 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:25536.20 Median:22479.66 stddev:41035.19 (182.5%) stddev-sans-first:41108.00 09:16:16 INFO - PROCESS | 1654 | Values: 722.0 737.0 753.2 757.8 769.3 13296.0 15124.0 15806.6 16497.8 16579.3 14549.8 14933.9 14968.8 14975.9 15077.0 690.2 717.1 842.8 861.4 865.5 709.4 845.5 872.2 878.1 881.4 864.3 865.0 881.9 917.2 918.0 720.3 905.9 910.2 913.5 917.7 551.5 652.5 668.1 674.1 675.2 15224.8 15272.7 15282.2 15291.8 15299.4 13727.9 14051.6 14072.2 14097.6 14431.6 12265.6 12519.3 12565.4 12655.7 13060.7 3381.8 3460.4 3530.9 3532.9 3572.5 102224.5 120560.0 128790.4 129712.0 130181.3 10734.2 10992.8 11019.9 11115.8 11135.1 22349.0 22479.7 22479.7 22487.3 22491.1 7656.5 7770.1 7773.9 8007.1 8008.9 4286.2 4393.4 4402.3 4444.6 4539.3 3429.8 3503.5 3542.3 3546.5 3567.3 619.1 631.4 632.1 642.6 645.9 589.8 603.3 619.7 619.9 639.6 8596.0 8923.6 9286.0 9303.4 9326.1 538.5 568.4 578.9 595.6 632.4 4207.3 4516.7 4525.3 4538.7 4638.3 104079.0 128663.0 167841.0 168791.2 171314.0 122578.8 122701.0 131516.3 138799.6 140850.0 61590.4 82034.6 96857.0 126412.0 126617.0 9374.7 9989.7 10446.2 10463.3 10465.2 58696.0 63885.0 66490.7 67161.7 67837.0 99001.0 101914.4 105423.5 105850.9 107874.9 13423.1 13627.5 13804.4 14303.1 14445.2 14138.3 15130.5 15392.5 15906.6 15950.8 13450.2 13562.7 14380.9 15261.8 15272.7 13406.5 14018.6 14227.7 14846.0 14965.0 13150.5 13326.9 13928.7 13937.3 14545.1 11029.3 11199.6 11632.4 11852.5 11970.2 10721.8 11081.8 11632.2 11876.4 11910.8 09:16:16 INFO - PROCESS | 1654 | -------- Summary: end -------- 09:16:16 INFO - PROCESS | 1654 | 09:16:16 INFO - TEST-INFO | 1654: exit 0 09:16:16 INFO - TEST-OK | dromaeo_css | took 1117446ms 09:16:16 INFO - TEST-START | kraken 09:16:16 INFO - operating with platform_type : mac_ 09:16:16 INFO - Initialising browser for kraken test... 09:16:16 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpaUqjCB/profile http://localhost:49267/getInfo.html) 09:16:19 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 09:16:19 INFO - PROCESS | 1660 | colorDepth:24 09:16:19 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 09:16:19 INFO - PROCESS | 1660 | __metrics 09:16:19 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:16:19 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:16:19 INFO - TEST-INFO | 1660: exit 0 09:16:19 INFO - Browser initialized. 09:16:19 INFO - Running cycle 1/1 for kraken test... 09:16:19 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpaUqjCB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:16:31 INFO - PROCESS | 1661 | RSS: Main: 219435008 09:16:31 INFO - PROCESS | 1661 | 09:16:34 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 09:16:35 INFO - PROCESS | 1661 | RSS: Main: 269524992 09:16:35 INFO - PROCESS | 1661 | 09:16:38 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 09:16:38 INFO - PROCESS | 1661 | RSS: Main: 280305664 09:16:38 INFO - PROCESS | 1661 | 09:16:41 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 09:16:42 INFO - PROCESS | 1661 | RSS: Main: 377995264 09:16:42 INFO - PROCESS | 1661 | 09:16:44 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 09:16:45 INFO - PROCESS | 1661 | RSS: Main: 280436736 09:16:45 INFO - PROCESS | 1661 | 09:16:47 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:16:47 INFO - PROCESS | 1661 | RSS: Main: 281391104 09:16:47 INFO - PROCESS | 1661 | 09:16:50 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 09:16:51 INFO - PROCESS | 1661 | RSS: Main: 320262144 09:16:51 INFO - PROCESS | 1661 | 09:16:54 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 09:16:54 INFO - PROCESS | 1661 | RSS: Main: 318066688 09:16:54 INFO - PROCESS | 1661 | 09:16:57 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 09:16:57 INFO - PROCESS | 1661 | RSS: Main: 317362176 09:16:57 INFO - PROCESS | 1661 | 09:16:59 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:17:00 INFO - PROCESS | 1661 | RSS: Main: 291205120 09:17:00 INFO - PROCESS | 1661 | 09:17:02 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:17:02 INFO - PROCESS | 1661 | RSS: Main: 297803776 09:17:02 INFO - PROCESS | 1661 | 09:17:04 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:17:05 INFO - PROCESS | 1661 | RSS: Main: 300122112 09:17:05 INFO - PROCESS | 1661 | 09:17:08 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:17:09 INFO - PROCESS | 1661 | RSS: Main: 311533568 09:17:09 INFO - PROCESS | 1661 | 09:17:11 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:17:12 INFO - PROCESS | 1661 | RSS: Main: 311398400 09:17:12 INFO - PROCESS | 1661 | 09:17:14 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 09:17:14 INFO - PROCESS | 1661 | RSS: Main: 354770944 09:17:14 INFO - PROCESS | 1661 | 09:17:14 INFO - PROCESS | 1661 | __start_tp_report 09:17:14 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 09:17:14 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 09:17:14 INFO - PROCESS | 1661 | |i|pagename|runs| 09:17:14 INFO - PROCESS | 1661 | |0;ai-astar;115;114;114;119;164;158;112;113;113;115 09:17:14 INFO - PROCESS | 1661 | |1;audio-beat-detection;144;110;110;142;110;109;109;108;139;109 09:17:14 INFO - PROCESS | 1661 | |2;audio-dft;185;183;183;183;184;181;183;184;182;182 09:17:14 INFO - PROCESS | 1661 | |3;audio-fft;81;60;83;112;86;58;58;58;82;61 09:17:14 INFO - PROCESS | 1661 | |4;audio-oscillator;87;71;95;82;98;100;116;67;69;92 09:17:14 INFO - PROCESS | 1661 | |5;imaging-gaussian-blur;86;84;86;83;86;83;90;87;86;79 09:17:14 INFO - PROCESS | 1661 | |6;imaging-darkroom;93;92;92;92;93;93;93;93;92;92 09:17:14 INFO - PROCESS | 1661 | |7;imaging-desaturate;81;85;84;94;84;84;86;84;87;83 09:17:14 INFO - PROCESS | 1661 | |8;json-parse-financial;57;56;56;55;57;60;58;58;59;58 09:17:14 INFO - PROCESS | 1661 | |9;json-stringify-tinderbox;72;69;76;72;74;71;71;70;73;70 09:17:14 INFO - PROCESS | 1661 | |10;stanford-crypto-aes;82;83;83;81;81;84;82;83;84;84 09:17:14 INFO - PROCESS | 1661 | |11;stanford-crypto-ccm;140;133;144;150;149;153;143;144;171;153 09:17:14 INFO - PROCESS | 1661 | |12;stanford-crypto-pbkdf2;166;160;163;162;164;166;165;164;164;164 09:17:14 INFO - PROCESS | 1661 | |13;stanford-crypto-sha256-iterative;67;67;68;66;68;67;64;66;66;67 09:17:14 INFO - PROCESS | 1661 | __end_tp_report 09:17:14 INFO - PROCESS | 1661 | __start_cc_report 09:17:14 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1925 09:17:14 INFO - PROCESS | 1661 | __end_cc_report 09:17:14 INFO - PROCESS | 1661 | __startTimestamp1478017034512__endTimestamp 09:17:14 INFO - PROCESS | 1661 | 09:17:14 INFO - PROCESS | 1661 | ------- Summary: start ------- 09:17:14 INFO - PROCESS | 1661 | Number of tests: 14 09:17:14 INFO - PROCESS | 1661 | 09:17:14 INFO - PROCESS | 1661 | [#0] ai-astar Cycles:10 Average:123.70 Median:115.00 stddev:19.80 (17.2%) stddev-sans-first:20.75 09:17:14 INFO - PROCESS | 1661 | Values: 115.0 114.0 114.0 119.0 164.0 158.0 112.0 113.0 113.0 115.0 09:17:14 INFO - PROCESS | 1661 | 09:17:14 INFO - PROCESS | 1661 | [#1] audio-beat-detection Cycles:10 Average:119.00 Median:110.00 stddev:15.70 (14.3%) stddev-sans-first:13.80 09:17:14 INFO - PROCESS | 1661 | Values: 144.0 110.0 110.0 142.0 110.0 109.0 109.0 108.0 139.0 109.0 09:17:14 INFO - PROCESS | 1661 | 09:17:14 INFO - PROCESS | 1661 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.00 stddev:1.15 (0.6%) stddev-sans-first:0.97 09:17:14 INFO - PROCESS | 1661 | Values: 185.0 183.0 183.0 183.0 184.0 181.0 183.0 184.0 182.0 182.0 09:17:14 INFO - PROCESS | 1661 | 09:17:14 INFO - PROCESS | 1661 | [#3] audio-fft Cycles:10 Average:73.90 Median:71.00 stddev:18.00 (25.3%) stddev-sans-first:18.90 09:17:14 INFO - PROCESS | 1661 | Values: 81.0 60.0 83.0 112.0 86.0 58.0 58.0 58.0 82.0 61.0 09:17:14 INFO - PROCESS | 1661 | 09:17:14 INFO - PROCESS | 1661 | [#4] audio-oscillator Cycles:10 Average:87.70 Median:84.50 stddev:15.71 (18.6%) stddev-sans-first:16.66 09:17:14 INFO - PROCESS | 1661 | Values: 87.0 71.0 95.0 82.0 98.0 100.0 116.0 67.0 69.0 92.0 09:17:14 INFO - PROCESS | 1661 | 09:17:14 INFO - PROCESS | 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:85.00 Median:86.00 stddev:2.94 (3.4%) stddev-sans-first:3.10 09:17:14 INFO - PROCESS | 1661 | Values: 86.0 84.0 86.0 83.0 86.0 83.0 90.0 87.0 86.0 79.0 09:17:14 INFO - PROCESS | 1661 | 09:17:14 INFO - PROCESS | 1661 | [#6] imaging-darkroom Cycles:10 Average:92.50 Median:93.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 09:17:14 INFO - PROCESS | 1661 | Values: 93.0 92.0 92.0 92.0 93.0 93.0 93.0 93.0 92.0 92.0 09:17:14 INFO - PROCESS | 1661 | 09:17:14 INFO - PROCESS | 1661 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:84.50 stddev:3.49 (4.1%) stddev-sans-first:3.35 09:17:14 INFO - PROCESS | 1661 | Values: 81.0 85.0 84.0 94.0 84.0 84.0 86.0 84.0 87.0 83.0 09:17:14 INFO - PROCESS | 1661 | 09:17:14 INFO - PROCESS | 1661 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:58.00 stddev:1.51 (2.6%) stddev-sans-first:1.59 09:17:14 INFO - PROCESS | 1661 | Values: 57.0 56.0 56.0 55.0 57.0 60.0 58.0 58.0 59.0 58.0 09:17:14 INFO - PROCESS | 1661 | 09:17:14 INFO - PROCESS | 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:72.00 stddev:2.10 (2.9%) stddev-sans-first:2.22 09:17:14 INFO - PROCESS | 1661 | Values: 72.0 69.0 76.0 72.0 74.0 71.0 71.0 70.0 73.0 70.0 09:17:14 INFO - PROCESS | 1661 | 09:17:14 INFO - PROCESS | 1661 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.16 (1.4%) stddev-sans-first:1.20 09:17:14 INFO - PROCESS | 1661 | Values: 82.0 83.0 83.0 81.0 81.0 84.0 82.0 83.0 84.0 84.0 09:17:14 INFO - PROCESS | 1661 | 09:17:14 INFO - PROCESS | 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:149.50 stddev:10.17 (6.8%) stddev-sans-first:10.36 09:17:14 INFO - PROCESS | 1661 | Values: 140.0 133.0 144.0 150.0 149.0 153.0 143.0 144.0 171.0 153.0 09:17:14 INFO - PROCESS | 1661 | 09:17:14 INFO - PROCESS | 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.80 Median:164.00 stddev:1.81 (1.1%) stddev-sans-first:1.74 09:17:14 INFO - PROCESS | 1661 | Values: 166.0 160.0 163.0 162.0 164.0 166.0 165.0 164.0 164.0 164.0 09:17:14 INFO - PROCESS | 1661 | 09:17:14 INFO - PROCESS | 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.17 (1.8%) stddev-sans-first:1.24 09:17:14 INFO - PROCESS | 1661 | Values: 67.0 67.0 68.0 66.0 68.0 67.0 64.0 66.0 66.0 67.0 09:17:14 INFO - PROCESS | 1661 | -------- Summary: end -------- 09:17:14 INFO - PROCESS | 1661 | 09:17:15 INFO - TEST-INFO | 1661: exit 0 09:17:15 INFO - TEST-OK | kraken | took 58487ms 09:17:15 INFO - SUITE-END | took 1175s 09:17:15 INFO - Completed test suite (00:19:36) 09:17:15 INFO - javascript benchmark 09:17:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3252.7072563469283, 3306.818125003124, 3336.33273345331, 3338.0987133473946, 3391.050505858359, 5667.801626943058, 5728.484436400723, 5759.280089988752, 5762.0, 5764.625299355539, 5738.512226460756, 5754.0, 5765.423457654232, 5766.423357664242, 5776.480116789488, 5203.60972927032, 5214.426413094557, 5218.843434696965, 5235.842924712265, 5251.632385733, 4412.514623391425, 5130.666506677054, 5152.793888244466, 5289.68261904287, 5318.335208098988, 4298.957010429903, 5161.793528258884, 5199.740012999354, 5236.842894713165, 5238.47615238475, 5221.686698798084, 5277.234800953878, 5332.706701131437, 5335.813246536352, 5342.038433082043, 5185.351831021122, 5227.398849132361, 5251.369835619712, 5268.5521730652945, 5291.603129765244, 4628.560286772751, 5501.944980550184, 5609.467100625434, 5617.21359009739, 5647.576431767634, 6117.736059405531, 6170.136180934673, 6174.536909731788, 6185.319614842364, 6194.318624951252, 6162.84592885177, 6235.532335074888, 6241.719122639447, 6241.906371404432, 6252.5935814171935, 5689.118186681112, 5744.770209191585, 5784.421557844182, 5823.79616713413, 5858.326292476378, 6232.844178895564, 6241.687915604201, 6242.65665388408, 6253.937460625336, 6262.530310226751, 6200.751969921243, 6204.720787564571, 6206.627602343874, 6207.0, 6211.875762484816, 6102.298235702862, 6105.572609917263, 6133.8855759873895, 6136.151476879633, 6223.595466294767, 5275.894482110336, 6165.722542485599, 6234.251889773256, 6234.594751341148, 6269.435750782452, 6215.471684906744, 6280.466160376328, 6281.811545653638, 6288.245410550671, 6295.276043254993, 4792.017636384602, 4897.1674815281485, 4948.158813001726, 4964.975175124174, 4984.675996060245, 4342.1532801103485, 4434.512203657595, 4435.334699795057, 4444.266695995189, 4494.213512635276, 5798.768049278066, 5799.246098007232, 5803.419658034163, 5803.622764520293, 5809.157672137517, 6295.307516173218, 6296.401841825019, 6307.022411526221, 6316.589421687576, 6323.494120470444, 4601.976990115028, 4776.904461910743, 5713.085906254979, 5728.198052272685, 5794.971025144847, 4192.580741925783, 4451.376807246988, 5408.242846001563, 5436.0, 5436.537894278951, 5891.734871930859, 6316.178896743394, 6316.463100636497, 6330.240371155399, 6335.461485773761, 6144.56988010835, 6163.445289923929, 6233.625982441068, 6242.781502647385, 6245.313015568375, 6190.566660333913, 6227.844303892439, 6230.813075607739, 6271.466925311217, 6273.99616061428, 6156.938430615815, 6163.876722465615, 6169.50643948474, 6173.6913154343, 6176.4441200292185, 6154.353792851865, 6187.535934804818, 6198.535109866688, 6270.811875643738, 6293.779717709858, 5984.58107932458, 6021.006533921854, 6041.093835924647, 6075.1191077294425, 6123.112148738319, 6119.228375855631, 6135.202423685071, 6146.877062458815, 6154.876902461836, 6160.10678451631, 5875.3243377012195, 5984.670843103671, 6005.759769609167, 6034.366391528826, 6040.6979651018155, 5200.167973124282, 6011.759529618941, 6061.0, 6090.299615544269, 6131.84670383244, 5017.598592112549, 6042.456178943916, 6054.182685337423, 6089.147519347206, 6104.633721976696], "value": 5651.33982637509, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.980759539147, 504.5181851331976, 509.236145781328, 529.7642549065667, 564.4778579813672, 31616.20959476014, 42500.0, 43689.126217475634, 43791.78104109483, 43831.34252986208, 44565.331520027226, 44921.550784492145, 45122.774386128025, 45134.0, 45187.32219016717, 9778.755531111708, 9974.850377244347, 9985.151262142726, 9993.400395976229, 10002.649907253248, 9802.754931126743, 9920.40477571348, 9930.950345248264, 9931.255155863302, 9942.850857237147, 9816.312858099936, 9859.90140098597, 9934.850977235346, 9951.55218015191, 9968.95015524925, 9886.555105020256, 9915.504224788732, 9927.751806204831, 9933.652322168726, 9942.254330925209, 8378.622961966665, 9798.020197980144, 9809.509524523744, 9904.316266234757, 9919.156871665917, 41782.955426114284, 42017.369739453934, 42179.36730949038, 42249.36625950583, 42279.788601056796, 3252.317013427183, 3378.4425569780956, 3405.9659403405894, 3412.351653185887, 3427.8114703691285, 29832.0, 30925.381492370252, 31529.36941261162, 32581.83709081463, 32920.670793292236, 2702.8783704733137, 3141.0419821954297, 3202.4876019836715, 3233.4988076848126, 3233.757468189872, 503457.0, 505729.0, 511293.0, 511352.4432377814, 512642.0, 61320.69339653273, 61613.38386616166, 61707.38292617106, 61717.0, 61758.764824703256, 30548.694513054586, 35052.474212886824, 35684.75103371369, 37593.436098458544, 66789.99815002682, 17544.561385965197, 17718.379856704953, 17724.46826595204, 17744.3789467368, 17793.288268469376, 13390.93304533471, 13469.12450690702, 13475.528356507475, 13478.663033424047, 13492.5277615283, 19498.31755888537, 19814.108365123604, 19853.305134320228, 19889.403317900196, 19890.403287901387, 7787.338076263468, 7851.803704907423, 7852.60736963161, 7895.328897043701, 7927.326177274881, 822.9465084769471, 836.3727204596553, 912.5346073502561, 1034.1984961654628, 1046.68076236747, 29319.97380091729, 30182.943596974, 30372.84813575918, 31014.0, 31227.219319517193, 852.5907564369013, 889.0087552379051, 921.8847644044495, 1070.769784496337, 1073.7745073534488, 12939.805902911465, 16989.830101698826, 17097.401590944257, 17348.739768903477, 17496.47510574685, 695650.0, 696403.0, 698172.0, 698387.0, 698656.0, 56671.0, 57040.85918281611, 57149.14276285859, 57314.7134264326, 57382.42617573855, 1236.758832027746, 1277.163457935054, 1278.360819590205, 1278.5844600504872, 1280.782267014591, 27309.72690273072, 27931.58102628503, 33388.66611333856, 33470.497942531365, 33969.49045764365, 58289.70855145697, 59228.0, 59312.0, 59369.10946335722, 59379.703101484214, 665651.0, 670667.0, 670819.0, 671436.0, 672628.0, 22766.772332276465, 27376.315592110357, 27878.30304242329, 27912.0, 28424.715752842207, 40552.391714124904, 49578.0, 49766.50233497618, 50110.24834627556, 50234.0, 39704.80147599243, 40822.79588602038, 40857.79571102125, 41543.0, 42423.0, 39986.00034999148, 40205.597944020185, 40834.38748418835, 41956.3706544396, 42270.36594451024, 31347.21631959128, 39464.01339966409, 39626.60373396344, 39823.0, 42051.57948420599, 34064.31871362509, 35924.64075359213, 36498.08754781152, 36552.0, 37341.2531749358, 25850.482990340464, 26153.346166345233, 26333.736662633128, 26434.942602295694, 26829.0], "value": 20366.971155357955, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.9585946927012, 378.75570257184137, 388.4445243302077, 397.658014107867, 406.5467004290217, 15839.762403563942, 18619.720704189433, 19489.805101949012, 19577.119029643665, 19704.605907881833, 20108.89945550274, 20239.696404553943, 20934.267300644442, 21441.356759297207, 21626.24308149215, 5640.7461664225, 5952.6130801497875, 5972.0, 6162.815115546518, 6239.438450539451, 6129.754809807602, 6185.195924529805, 6213.596116252452, 6245.188125543673, 6247.06294055893, 5955.731992060346, 6205.10026046223, 6254.530910181755, 6323.272823625273, 6365.777197798078, 6169.3522180170885, 6230.5638605297645, 6269.655168965705, 6316.147320111772, 6330.905036424458, 6098.481629061535, 6164.476019538344, 6182.103594978747, 6182.876342473125, 6185.628862268279, 11963.222390544586, 12352.691182720504, 13145.342732863319, 13232.536861209908, 13314.533991310258, 2217.5121473275854, 2247.2471721973156, 2317.9304620861403, 2355.7644235576477, 2902.6226590543306, 9899.15857152143, 10024.949875250577, 10192.388456692623, 10578.206634502443, 10653.307535010277, 1856.3781133320354, 1888.055972013993, 1956.9706454403054, 1975.2987689370211, 1975.5752513209586, 113278.63688860198, 115852.0, 128847.0, 129353.35323323417, 134913.65086349208, 7660.502067365604, 9869.11177993984, 10193.643222487177, 10228.437435941094, 11319.26424782403, 12501.187422817487, 12619.0, 12626.368681565886, 12635.747285054247, 12638.494460221487, 6134.478569321568, 7625.771226863203, 7626.69493220276, 7710.228977102357, 7729.497582657222, 7642.885356719654, 7650.885236721454, 7662.118856331482, 7792.064952205772, 7811.023622047244, 3941.8620348288246, 3944.9605503944595, 3956.1692044670367, 4024.2353952748886, 4035.1727895781296, 1763.8147994460396, 1807.0193490222657, 1909.9140538675515, 1928.8746231494908, 1961.7322654120235, 796.8207153390441, 969.7769513012047, 980.4901451245313, 982.4841957972122, 1003.6938733686296, 20763.480912977295, 22225.888870555544, 22297.888510557343, 22349.770762607888, 22385.888070559544, 912.4069354919222, 920.9861852072224, 944.0653752784693, 953.6137864165024, 955.5938726041404, 9519.762005949768, 11698.667662806625, 11850.407479625985, 11912.40437978115, 11921.940390297994, 598665.0, 603492.0, 609203.9539802272, 615430.0, 616284.0, 122205.0, 131137.0, 132416.37918104057, 138816.0, 155294.447055528, 825.6738588257605, 959.467495539982, 1004.9547770350351, 1038.5897570459626, 1039.9012093851072, 13865.653358666113, 14585.885046668385, 20137.798622013594, 20138.59722805565, 20206.29277975264, 57351.426485734606, 57917.710411447675, 58521.82956340764, 59111.704441477516, 60157.0, 80660.0, 81303.0, 82018.0, 82820.58589707012, 82854.0, 8127.715529956423, 8164.918350816416, 8199.426040177368, 8317.750467485985, 8440.282575981111, 12677.492900283885, 12783.360831958178, 13058.281794501394, 13318.0, 13521.526746563823, 8676.392652514263, 11056.613018544313, 11183.552657893593, 11337.829932551183, 11543.36511491876, 11246.212765106364, 11270.605528806453, 11489.770204596029, 11693.123015774021, 11870.881291186977, 11198.664040078811, 11589.710257243636, 11834.52661893549, 11911.404429778304, 11931.880681193425, 8128.634211460617, 8306.83386332258, 8354.0, 8423.11557286476, 8487.533185674847, 8993.865092023494, 10693.9465302673, 11496.770064598828, 11506.712332191762, 11843.70390740204], "value": 9424.670368656947, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.4315630591457, 1501.4369611395728, 1664.750287456882, 1827.661882551727, 1862.6274745050985, 8407.747767566967, 8931.972823125343, 8985.415947963378, 9091.818163636723, 9093.272538196945, 7782.96108519458, 7988.121306656263, 8017.67929282828, 8532.91467085329, 8658.523781192032, 1957.1290775604825, 2413.4811015631635, 2419.9153029643967, 2426.7209270933804, 2431.8905649245826, 2386.284114765572, 2398.760123987596, 2405.5429468401035, 2426.8543887366727, 2443.5723748344058, 2404.0744313439277, 2411.6623672685837, 2420.9031638734427, 2430.0887167312258, 2430.1251549442186, 2377.5839228135005, 2388.1163969331283, 2394.856308621488, 2397.8681172535503, 2402.435427674486, 2367.088670861731, 2367.2779802160335, 2371.513839662865, 2379.0602711928864, 2382.2614989353183, 8616.224539791448, 8881.156290152425, 8906.198442140174, 8936.687215947475, 8955.507447090407, 5181.663191892552, 5324.787008519655, 5355.518003379676, 5385.569154467633, 5428.83713488596, 3459.7924124552605, 3464.7401444891734, 3672.0085576894357, 3682.668559829628, 3693.021349342426, 1047.3422336075698, 1075.714935542082, 1087.33129125588, 1100.779844031197, 1110.134095405585, 11410.030147437477, 11520.423978801111, 11553.30680159193, 11606.187566870323, 11682.766344673144, 4529.0, 4665.650076244296, 4823.517648235219, 4836.758162091881, 4853.563179313879, 9847.852282215772, 9900.851487227697, 9934.254930880214, 9937.652182173733, 10016.248781341428, 5351.170568561879, 5351.491608297206, 5387.515123638891, 5405.864853378618, 5408.486193811582, 4019.7667444845947, 4380.0582874682095, 4748.19280722278, 4942.332785074041, 4972.875678108004, 3934.409838524187, 3964.960350396517, 4034.8184331705143, 4037.959620403817, 4046.291898917678, 1281.9038572106942, 1283.332667013148, 1291.3156027305542, 1300.830891984036, 1302.9934850325687, 872.1714371347246, 882.4705176893813, 888.2982443869271, 902.7923577577194, 912.2884150362728, 4921.901561968741, 5120.308758317654, 5520.558355331564, 5783.074708046776, 5950.761969521257, 866.6663334616218, 877.7937184761576, 898.9796580880748, 916.6974898283684, 927.8840144981878, 3720.3489389356755, 3876.9224615507533, 3944.013996500875, 3956.248312820555, 3982.8406863725127, 9721.805563888682, 10677.145828333714, 10687.679369618923, 10854.891451085547, 10933.398663073449, 10552.103071239031, 10870.945645271722, 10920.781584368267, 10921.12630989519, 10997.945010275058, 8089.150639182919, 8215.34277257818, 8256.339492840678, 8373.958130209432, 8384.790380240544, 5661.518770904519, 5725.19847221381, 5762.135679648086, 5845.1232315151365, 5970.462658360769, 9813.901860981585, 9956.153726933291, 10044.799104018024, 10170.338927969658, 10218.540165692413, 10022.298439109192, 10076.0, 10217.33587316822, 10245.538950747085, 10542.314749541256, 6531.836704082436, 6721.899171512334, 6756.6959486822225, 7020.192677841909, 7210.9278907210255, 8084.87872681922, 8189.426740128134, 8285.50286982783, 8524.36067294943, 8554.18735220153, 7399.519031262951, 7438.330550250504, 7444.888326674996, 7575.431842611716, 7693.230676932262, 7255.709771609288, 7305.744298949511, 7316.597587132759, 7412.518186317872, 7444.218357072429, 6928.203256625553, 7016.543924644881, 7042.0, 7075.5047146699235, 7114.786556403316, 4909.361782968192, 4914.311996320446, 4944.728039957837, 4959.851204463872, 5029.44676085623, 4140.523839758466, 4596.264597664492, 4932.53140951609, 5022.472640372708, 5062.468440813662], "value": 4575.934018786184, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [245.83160535033502, 302.35598175885366, 309.96900309969, 314.718327097248, 316.52679244529435, 4079.5716449772754, 4522.186006518826, 5041.899162016757, 5136.691798492093, 5218.26944227808, 4319.352097185424, 4831.444383895853, 4971.602271818246, 5010.549050585447, 5192.558632516231, 3999.540052893911, 4010.19796040793, 4017.6986725995666, 4027.919441611173, 4035.6771458283265, 3680.742348035625, 3763.6612704856557, 4037.7577345359227, 4039.656629186523, 4055.614716601918, 3331.8172048922647, 3867.149227170018, 3913.7651740895494, 3944.4280579315982, 3976.125252444472, 3846.2692088503236, 3920.4315374270714, 3924.7448915820382, 3935.9016024599614, 3937.232239713257, 3437.9484307735406, 3457.6888080072663, 3459.290845376692, 3465.047112044183, 3476.28736109097, 3855.7879316637573, 4258.041940563379, 4641.535846415365, 4817.578814249805, 5008.949910500921, 4469.463664360265, 4482.9551704482865, 4494.0, 4510.751908645023, 4522.68341216115, 4048.4332193492933, 4500.459944806644, 4951.331570238044, 5400.540954018913, 5452.209429632681, 3426.6573342665783, 3806.7335286529956, 3827.445020472044, 3829.8468061277517, 3849.095462566295, 4778.2115950868065, 4888.388951381077, 5419.918701219485, 5642.858928526779, 5671.092625179993, 3780.5652349980105, 3795.8291876865605, 3806.980965095157, 3837.846486140523, 3847.3844184930276, 3256.46268365717, 3853.8265778040054, 3893.357595996629, 3894.4547763313158, 3904.1020565270146, 3944.3689009758873, 4278.935815962763, 4480.910381792346, 4488.438945131858, 4613.938794077381, 5354.955783622234, 5402.243685883979, 5446.373667028263, 5448.42791506894, 5504.862378440491, 1120.456578559398, 1127.2898074213358, 1135.3358285402967, 1142.9998751092794, 1211.249025604131, 766.7469734987441, 845.9323254139654, 897.7620930453435, 904.0597778310615, 907.4645958884158, 5153.407358153785, 5209.895802083937, 5224.604007395147, 5237.214417837278, 5238.371395432497, 4535.931961020588, 4558.658100642465, 5284.920726189111, 5385.246065550826, 5716.314042314949, 4770.022145460172, 4789.880252993703, 5231.790728370898, 5282.339707536558, 5302.575793936476, 2588.6021548363674, 2970.9554356684666, 2998.205475548981, 3005.6844031376827, 3021.6222972128485, 5125.666831655931, 5571.60998730085, 5721.885562288731, 5858.443447872445, 5886.6173698709445, 4896.510348965075, 5776.451237132465, 5790.971045144832, 5808.30300363959, 5846.181534585162, 5699.2590963174525, 5849.473547380756, 5928.525717942554, 5941.70291485424, 6015.969920150371, 5337.439568845215, 5635.408282130317, 5686.744096515749, 5695.430456954271, 5700.771969121189, 5314.946850531445, 5665.773369065191, 5668.603197776116, 5670.291213598301, 5757.395473475225, 5224.817131400383, 5939.91090133657, 5980.803839232084, 5985.264273360851, 6008.459238668541, 3220.9838950805097, 3759.0, 3848.5381754189675, 3852.3643598805884, 3860.9034774130873, 4756.643251756202, 5738.340090889601, 5747.48272655463, 5750.878578677118, 5776.971115144397, 4355.803988820448, 4655.743934083658, 5604.775808967595, 5604.775808967759, 5676.687782171855, 5594.272744543184, 5595.356533998643, 5596.468335508121, 5621.634593751393, 5660.7169641518585, 4476.5299643538265, 5119.257707632447, 5240.0, 5342.626016178986, 5586.357568879631, 5266.07843627356, 5399.568034557147, 5483.341998960151, 5498.340199175965, 5645.4072322405555, 5126.384833819965, 5199.818006369759, 5375.274337964481, 5384.600003999067, 5397.78408863641], "value": 3994.2553571392327, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.9855602887939, 737.0, 753.1527032088899, 757.7953952432844, 769.2576663519702, 13296.0, 15124.016938898963, 15806.604834879105, 16497.83502164978, 16579.25393357299, 14549.781753273683, 14933.92533037336, 14968.775468367983, 14975.850241497581, 15077.019993700402, 690.2407351912906, 717.0785540580355, 842.7977285451478, 861.4357595774777, 865.5023361567092, 709.4359983812856, 845.5096044294295, 872.2324354567971, 878.0999475537593, 881.4446898453965, 864.2567392042838, 865.0398058155442, 881.9250363719092, 917.1928702741611, 918.0406475233397, 720.3121019426435, 905.9184673379394, 910.167197014734, 913.5021413329684, 917.7338571814166, 551.4981366956051, 652.5399593286721, 668.1080757189159, 674.1169068520254, 675.1729131813489, 15224.771628425582, 15272.694546109016, 15282.159481228528, 15291.770623440658, 15299.388024479007, 13727.931360343135, 14051.64870878226, 14072.22602756848, 14097.577072687836, 14431.567052988426, 12265.603134620738, 12519.326853762139, 12565.371731413392, 12655.683607909783, 13060.738785224337, 3381.7994611912663, 3460.411730005905, 3530.858765649371, 3532.8586856525967, 3572.4641303804638, 102224.48887755514, 120560.0, 128790.3560482201, 129712.0, 130181.34909325487, 10734.2486025979, 10992.84575119601, 11019.944900275448, 11115.777684446266, 11135.05352045069, 22349.0, 22479.66280505794, 22479.66280505794, 22487.32538023862, 22491.100355985578, 7656.502327348704, 7770.10643775973, 7773.883391749128, 8007.119216886138, 8008.919910800934, 4286.207051695446, 4393.406890069864, 4402.25161722508, 4444.622207112367, 4539.341795439643, 3429.7599168058496, 3503.5095086687884, 3542.3092496962845, 3546.4857595648486, 3567.304375646724, 619.123939625425, 631.425402883374, 632.1497585747163, 642.5662677692538, 645.9483241340776, 589.7581991383598, 603.2820943077724, 619.7397093220858, 619.8543342314553, 639.6449970266453, 8595.957020214859, 8923.553822308988, 9285.978542360335, 9303.441793492277, 9326.067393260755, 538.526097034607, 568.4400865147826, 578.9015867302485, 595.6455908734296, 632.4213344789558, 4207.305794543866, 4516.728996260234, 4525.253333200051, 4538.682292239511, 4638.281066434708, 104079.0, 128663.0, 167841.0, 168791.15604421898, 171314.0, 122578.77421225673, 122701.0, 131516.3424182873, 138799.6120038807, 140850.0, 61590.38409615936, 82034.58982705048, 96857.0, 126411.99999999817, 126617.0, 9374.67188648394, 9989.700308990741, 10446.216533760151, 10463.267571269938, 10465.215108866712, 58696.0, 63885.0, 66490.67546622553, 67161.66419167873, 67837.0, 99001.0, 101914.35642327003, 105423.54109189066, 105850.94149058411, 107874.92125078649, 13423.060385772902, 13627.454901803816, 13804.447822087406, 14303.141811491343, 14445.205513696848, 14138.293085345897, 15130.470433534774, 15392.461263855712, 15906.602334941255, 15950.760738588699, 13450.192988420726, 13562.660933476742, 14380.85853359023, 15261.771073434129, 15272.694546109238, 13406.530771422953, 14018.649533761329, 14227.715445691236, 14846.0188920499, 14965.0, 13150.539731109366, 13326.866731332562, 13928.72142557123, 13937.30313484342, 14545.127292362493, 11029.283096598696, 11199.552017919192, 11632.360220187971, 11852.525898963944, 11970.221935574507, 10721.839172412576, 11081.778364432828, 11632.18574699763, 11876.406179691154, 11910.761784764429], "value": 7888.756855775682, "unit": "score"}], "name": "dromaeo_css", "value": 7340.393723122827, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 119.0, 164.0, 158.0, 112.0, 113.0, 113.0, 115.0], "value": 123.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 110.0, 110.0, 142.0, 110.0, 109.0, 109.0, 108.0, 139.0, 109.0], "value": 119.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 183.0, 183.0, 184.0, 181.0, 183.0, 184.0, 182.0, 182.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 83.0, 112.0, 86.0, 58.0, 58.0, 58.0, 82.0, 61.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 95.0, 82.0, 98.0, 100.0, 116.0, 67.0, 69.0, 92.0], "value": 87.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 83.0, 86.0, 83.0, 90.0, 87.0, 86.0, 79.0], "value": 85.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 92.0, 92.0, 93.0, 93.0, 93.0, 93.0, 92.0, 92.0], "value": 92.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 84.0, 94.0, 84.0, 84.0, 86.0, 84.0, 87.0, 83.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 55.0, 57.0, 60.0, 58.0, 58.0, 59.0, 58.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 76.0, 72.0, 74.0, 71.0, 71.0, 70.0, 73.0, 70.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 81.0, 81.0, 84.0, 82.0, 83.0, 84.0, 84.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 133.0, 144.0, 150.0, 149.0, 153.0, 143.0, 144.0, 171.0, 153.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 160.0, 163.0, 162.0, 164.0, 166.0, 165.0, 164.0, 164.0, 164.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 66.0, 68.0, 67.0, 64.0, 66.0, 66.0, 67.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1440.3, "alertThreshold": 2.0}]} 09:17:15 INFO - Return code: 0 09:17:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:17:15 INFO - # TBPL SUCCESS # 09:17:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:17:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:17:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:17:15 INFO - 2016-11-01 09:17:15.827 screenresolution[1665:9829] starting screenresolution argv=screenresolution get 09:17:15 INFO - 2016-11-01 09:17:15.829 screenresolution[1665:9829] Display 0: 1600x1200x32@60 09:17:15 INFO - 2016-11-01 09:17:15.835 screenresolution[1666:9832] starting screenresolution argv=screenresolution list 09:17:15 INFO - Available Modes on Display 0 09:17:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:17:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:17:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:17:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:17:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:17:16 INFO - Intel Iris: 09:17:16 INFO - Chipset Model: Intel Iris 09:17:16 INFO - Type: GPU 09:17:16 INFO - Bus: Built-In 09:17:16 INFO - VRAM (Dynamic, Max): 1536 MB 09:17:16 INFO - Vendor: Intel (0x8086) 09:17:16 INFO - Device ID: 0x0a2e 09:17:16 INFO - Revision ID: 0x0009 09:17:16 INFO - Displays: 09:17:16 INFO - Display: 09:17:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:17:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:17:16 INFO - Display Serial Number: 1600x1200 60 09:17:16 INFO - Main Display: Yes 09:17:16 INFO - Mirror: Off 09:17:16 INFO - Online: Yes 09:17:16 INFO - Rotation: Supported 09:17:16 INFO - Return code: 0 09:17:16 INFO - Running post-action listener: _resource_record_post_action 09:17:16 INFO - [mozharness: 2016-11-01 16:17:16.071006Z] Finished run-tests step (success) 09:17:16 INFO - Running post-run listener: _resource_record_post_run 09:17:16 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 38503424; Write bytes: 663548416; Read time: 379; Write time: 1775 09:17:16 INFO - TinderboxPrint: CPU usage
53.4% 09:17:16 INFO - TinderboxPrint: I/O read bytes / time
38,503,424 / 379 09:17:16 INFO - TinderboxPrint: I/O write bytes / time
663,548,416 / 1,775 09:17:16 INFO - TinderboxPrint: CPU idle
2,254.7 (46.6%) 09:17:16 INFO - TinderboxPrint: CPU system
969.8 (20.0%) 09:17:16 INFO - TinderboxPrint: CPU user
1,613.2 (33.3%) 09:17:16 INFO - TinderboxPrint: Swap in / out
401,838,080 / 0 09:17:16 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 355523072; Write bytes: 355477504; Read time: 27869; Write time: 618 09:17:16 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 37528576; Write bytes: 297867776; Read time: 360; Write time: 1123 09:17:16 INFO - Running post-run listener: _upload_blobber_files 09:17:16 INFO - Blob upload gear active. 09:17:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:17:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:17:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:17:16 INFO - (blobuploader) - INFO - Open directory for files ... 09:17:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:17:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:17:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:17 INFO - (blobuploader) - INFO - Done attempting. 09:17:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:17:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:17:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:18 INFO - (blobuploader) - INFO - Done attempting. 09:17:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:17:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:17:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:21 INFO - (blobuploader) - INFO - Done attempting. 09:17:21 INFO - (blobuploader) - INFO - Iteration through files over. 09:17:21 INFO - Return code: 0 09:17:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:17:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:17:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2355679fad229e944932021583df71230e9d602bbdb1c91502239c69d3942aeed9fbe97fd50517f1b2eac6bcf8cced772f7061990d5d26ee2fe4f4e67dfb44a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45c0d5b4dc0ea217f382c5c0b45ce2c91ff75548e517db51e170cb558138eba9222d2d3580fe6e2f670759637cf65a1ec3ad60ea6728d51772cb99bdcad0f806", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5cb33b71e8d3b968b8e5470b4741d439ec6d318485743e9ef00ada7000891ac445b4f005c8027e09201f55a9b59748091223b447f6bfb26154d8fd660cfe9acd"} 09:17:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:17:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:17:21 INFO - Contents: 09:17:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2355679fad229e944932021583df71230e9d602bbdb1c91502239c69d3942aeed9fbe97fd50517f1b2eac6bcf8cced772f7061990d5d26ee2fe4f4e67dfb44a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45c0d5b4dc0ea217f382c5c0b45ce2c91ff75548e517db51e170cb558138eba9222d2d3580fe6e2f670759637cf65a1ec3ad60ea6728d51772cb99bdcad0f806", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5cb33b71e8d3b968b8e5470b4741d439ec6d318485743e9ef00ada7000891ac445b4f005c8027e09201f55a9b59748091223b447f6bfb26154d8fd660cfe9acd"} 09:17:21 INFO - Running post-run listener: copy_logs_to_upload_dir 09:17:21 INFO - Copying logs to upload dir... 09:17:21 INFO - mkdir: /builds/slave/test/build/upload/logs 09:17:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.087290 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-01 09:17:21.346658) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-01 09:17:21.349872) ========= 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.UVHApgBT1f/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.G9IH9LxQSN/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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/2355679fad229e944932021583df71230e9d602bbdb1c91502239c69d3942aeed9fbe97fd50517f1b2eac6bcf8cced772f7061990d5d26ee2fe4f4e67dfb44a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45c0d5b4dc0ea217f382c5c0b45ce2c91ff75548e517db51e170cb558138eba9222d2d3580fe6e2f670759637cf65a1ec3ad60ea6728d51772cb99bdcad0f806", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5cb33b71e8d3b968b8e5470b4741d439ec6d318485743e9ef00ada7000891ac445b4f005c8027e09201f55a9b59748091223b447f6bfb26154d8fd660cfe9acd"} build_url:https://queue.taskcluster.net/v1/task/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011152 build_url: 'https://queue.taskcluster.net/v1/task/UBYGj5y1S1e8gm1WUaJJ0A/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2355679fad229e944932021583df71230e9d602bbdb1c91502239c69d3942aeed9fbe97fd50517f1b2eac6bcf8cced772f7061990d5d26ee2fe4f4e67dfb44a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45c0d5b4dc0ea217f382c5c0b45ce2c91ff75548e517db51e170cb558138eba9222d2d3580fe6e2f670759637cf65a1ec3ad60ea6728d51772cb99bdcad0f806", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5cb33b71e8d3b968b8e5470b4741d439ec6d318485743e9ef00ada7000891ac445b4f005c8027e09201f55a9b59748091223b447f6bfb26154d8fd660cfe9acd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-01 09:17:21.382843) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 09:17:21.383166) ========= 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.UVHApgBT1f/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.G9IH9LxQSN/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005132 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 09:17:21.432190) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-01 09:17:21.432549) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-01 09:17:21.432912) ========= ========= Total master_lag: 0.46 =========