builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0142 starttime: 1475246120.48 results: success (0) buildid: 20160930013320 builduid: aa5c9bca12eb4c9481f5747ff57287d7 revision: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:20.477319) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:20.477744) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:20.478023) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:21.210204) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:21.210475) ========= 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.NOctr2xlSG/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.Zp8E3jjDo0/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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-09-30 07:35:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 26.2M=0s 2016-09-30 07:35:21 (26.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.592630 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:21.838468) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:21.838759) ========= 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.NOctr2xlSG/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.Zp8E3jjDo0/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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.033676 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:21.895589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 07:35:21.895894) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 --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 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NOctr2xlSG/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.Zp8E3jjDo0/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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-09-30 07:35:21,973 truncating revision to first 12 chars 2016-09-30 07:35:21,973 Setting DEBUG logging. 2016-09-30 07:35:21,973 attempt 1/10 2016-09-30 07:35:21,973 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/805d5fc3d66c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 07:35:23,080 unpacking tar archive at: mozilla-aurora-805d5fc3d66c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.387871 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 07:35:23.305131) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:23.308502) ========= script_repo_revision: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:23.308949) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:23.309238) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 07:35:23.340755) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-09-30 07:35:23.341039) ========= /tools/buildbot/bin/python 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', '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.NOctr2xlSG/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.Zp8E3jjDo0/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 07:35:23 INFO - MultiFileLogger online at 20160930 07:35:23 in /builds/slave/test 07:35:23 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 07:35:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:35:23 INFO - {'append_to_log': False, 07:35:23 INFO - 'base_work_dir': '/builds/slave/test', 07:35:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:35:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:35:23 INFO - 'branch': 'Mozilla-Aurora', 07:35:23 INFO - 'buildbot_json_path': 'buildprops.json', 07:35:23 INFO - 'config_files': ('talos/mac_config.py',), 07:35:23 INFO - 'default_actions': ('clobber', 07:35:23 INFO - 'read-buildbot-config', 07:35:23 INFO - 'download-and-extract', 07:35:23 INFO - 'populate-webroot', 07:35:23 INFO - 'create-virtualenv', 07:35:23 INFO - 'install', 07:35:23 INFO - 'run-tests'), 07:35:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:35:23 INFO - 'download_minidump_stackwalk': True, 07:35:23 INFO - 'download_symbols': 'ondemand', 07:35:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:35:23 INFO - 'tooltool.py': '/tools/tooltool.py', 07:35:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:35:23 INFO - '/tools/misc-python/virtualenv.py')}, 07:35:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:35:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:35:23 INFO - 'installer_path': 'installer.exe', 07:35:23 INFO - 'log_level': 'info', 07:35:23 INFO - 'log_name': 'talos', 07:35:23 INFO - 'log_to_console': True, 07:35:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:35:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:35:23 INFO - 'opt_config_files': (), 07:35:23 INFO - 'pip_index': False, 07:35:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:35:23 INFO - 'cmd': ('bash', 07:35:23 INFO - '-c', 07:35:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:35:23 INFO - 'enabled': True, 07:35:23 INFO - 'halt_on_failure': False, 07:35:23 INFO - 'name': 'check_screen_resolution'},), 07:35:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:35:23 INFO - 'cmd': ('bash', 07:35:23 INFO - '-c', 07:35:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:35:23 INFO - 'enabled': True, 07:35:23 INFO - 'halt_on_failure': False, 07:35:23 INFO - 'name': 'check_screen_resolution'},), 07:35:23 INFO - 'run_cmd_checks_enabled': True, 07:35:23 INFO - 'sps_profile': False, 07:35:23 INFO - 'sps_profile_interval': 0, 07:35:23 INFO - 'suite': 'dromaeojs', 07:35:23 INFO - 'system_bits': '32', 07:35:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:35:23 INFO - 'title': 't-yosemite-r7-0142', 07:35:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:35:23 INFO - 'use_talos_json': True, 07:35:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:35:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:35:23 INFO - 'work_dir': 'build'} 07:35:23 INFO - [mozharness: 2016-09-30 14:35:23.542808Z] Running clobber step. 07:35:23 INFO - Running pre-action listener: _resource_record_pre_action 07:35:23 INFO - Running main action method: clobber 07:35:23 INFO - rmtree: /builds/slave/test/build 07:35:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:35:25 INFO - Running post-action listener: _resource_record_post_action 07:35:25 INFO - [mozharness: 2016-09-30 14:35:25.780476Z] Finished clobber step (success) 07:35:25 INFO - [mozharness: 2016-09-30 14:35:25.780550Z] Running read-buildbot-config step. 07:35:25 INFO - Running pre-action listener: _resource_record_pre_action 07:35:25 INFO - Running main action method: read_buildbot_config 07:35:25 INFO - Using buildbot properties: 07:35:25 INFO - { 07:35:25 INFO - "project": "", 07:35:25 INFO - "product": "firefox", 07:35:25 INFO - "script_repo_revision": "production", 07:35:25 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:35:25 INFO - "repository": "", 07:35:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:35:25 INFO - "buildid": "20160930013320", 07:35:25 INFO - "pgo_build": "False", 07:35:25 INFO - "basedir": "/builds/slave/test", 07:35:25 INFO - "buildnumber": 58, 07:35:25 INFO - "slavename": "t-yosemite-r7-0142", 07:35:25 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:35:25 INFO - "platform": "yosemite_r7", 07:35:25 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:35:25 INFO - "branch": "mozilla-aurora", 07:35:25 INFO - "repo_path": "releases/mozilla-aurora", 07:35:25 INFO - "revision": "805d5fc3d66c4fa585a3de407b1e0b055f78eb58", 07:35:25 INFO - "stage_platform": "macosx64", 07:35:25 INFO - "builduid": "aa5c9bca12eb4c9481f5747ff57287d7", 07:35:25 INFO - "slavebuilddir": "test" 07:35:25 INFO - } 07:35:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 07:35:25 INFO - Running post-action listener: _resource_record_post_action 07:35:25 INFO - [mozharness: 2016-09-30 14:35:25.784021Z] Finished read-buildbot-config step (success) 07:35:25 INFO - [mozharness: 2016-09-30 14:35:25.784108Z] Running download-and-extract step. 07:35:25 INFO - Running pre-action listener: _resource_record_pre_action 07:35:25 INFO - Running main action method: download_and_extract 07:35:25 INFO - mkdir: /builds/slave/test/build/tests 07:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:25 INFO - trying https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 07:35:25 INFO - Downloading https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/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 07:35:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/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 07:35:26 INFO - Downloaded 1199 bytes. 07:35:26 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:35:26 INFO - Using the following test package requirements: 07:35:26 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:35:26 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 07:35:26 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 07:35:26 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'jsshell-mac.zip'], 07:35:26 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 07:35:26 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:35:26 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 07:35:26 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 07:35:26 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 07:35:26 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:35:26 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 07:35:26 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:35:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:35:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:35:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:35:27 INFO - Expected file size: 16433807 07:35:34 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 07:35:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:35:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:35:34 INFO - Fetch https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:35:35 INFO - Expected file size: 16433807 07:35:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 07:35:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:35:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 07:35:42 INFO - Expected file size: 14414059 07:35: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')]} 07:35:43 INFO - trying https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:35:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 07:35:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/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 07:35:46 INFO - Downloaded 115275136 bytes. 07:35:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:35:46 INFO - mkdir: /builds/slave/test/properties 07:35:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:35:46 INFO - Writing to file /builds/slave/test/properties/build_url 07:35:46 INFO - Contents: 07:35:46 INFO - build_url:https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:35:47 INFO - Running post-action listener: _resource_record_post_action 07:35:47 INFO - Running post-action listener: set_extra_try_arguments 07:35:47 INFO - [mozharness: 2016-09-30 14:35:47.352990Z] Finished download-and-extract step (success) 07:35:47 INFO - [mozharness: 2016-09-30 14:35:47.353108Z] Running populate-webroot step. 07:35:47 INFO - Running pre-action listener: _resource_record_pre_action 07:35:47 INFO - Running main action method: populate_webroot 07:35:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:35:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:35:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:35:47 INFO - '--tppagecycles', 07:35:47 INFO - '7'], 07:35:47 INFO - 'tests': ['tsvgm']}}, 07:35:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:35:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:35:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:35:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:35:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:35:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:35:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:47 INFO - 'talos_options': ['--disable-e10s'], 07:35:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:47 INFO - 'talos_options': ['--disable-e10s'], 07:35:47 INFO - 'tests': ['damp', 'tps']}, 07:35:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:47 INFO - 'tests': ['damp', 'tps']}, 07:35:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:35:47 INFO - 'tests': ['dromaeo_dom']}, 07:35:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:35:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:35:47 INFO - 'tests': ['basic_compositor_video']}, 07:35:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:35:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:35:47 INFO - 'tests': ['a11yr', 07:35:47 INFO - 'ts_paint', 07:35:47 INFO - 'tpaint', 07:35:47 INFO - 'sessionrestore', 07:35:47 INFO - 'sessionrestore_no_auto_restore', 07:35:47 INFO - 'tabpaint']}, 07:35:47 INFO - 'other-e10s': {'tests': ['a11yr', 07:35:47 INFO - 'ts_paint', 07:35:47 INFO - 'tpaint', 07:35:47 INFO - 'sessionrestore', 07:35:47 INFO - 'sessionrestore_no_auto_restore', 07:35:47 INFO - 'tabpaint']}, 07:35:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:35:47 INFO - 'ts_paint', 07:35:47 INFO - 'tpaint', 07:35:47 INFO - 'sessionrestore', 07:35:47 INFO - 'sessionrestore_no_auto_restore', 07:35:47 INFO - 'tabpaint']}, 07:35:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:35:47 INFO - 'ts_paint', 07:35:47 INFO - 'tpaint', 07:35:47 INFO - 'sessionrestore', 07:35:47 INFO - 'sessionrestore_no_auto_restore', 07:35:47 INFO - 'tabpaint']}, 07:35:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:35:47 INFO - 'tests': ['a11yr', 07:35:47 INFO - 'ts_paint', 07:35:47 INFO - 'tpaint', 07:35:47 INFO - 'sessionrestore', 07:35:47 INFO - 'sessionrestore_no_auto_restore', 07:35:47 INFO - 'tabpaint']}, 07:35:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:35:47 INFO - 'tests': ['a11yr', 07:35:47 INFO - 'ts_paint', 07:35:47 INFO - 'tpaint', 07:35:47 INFO - 'sessionrestore', 07:35:47 INFO - 'sessionrestore_no_auto_restore', 07:35:47 INFO - 'tabpaint']}, 07:35:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:35:47 INFO - 'tests': ['tsvgx', 07:35:47 INFO - 'tsvgr_opacity', 07:35:47 INFO - 'tart', 07:35:47 INFO - 'tscrollx', 07:35:47 INFO - 'cart']}, 07:35:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:35:47 INFO - 'tsvgr_opacity', 07:35:47 INFO - 'tart', 07:35:47 INFO - 'tscrollx', 07:35:47 INFO - 'cart']}, 07:35:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:47 INFO - 'talos_options': ['--disable-e10s'], 07:35:47 INFO - 'tests': ['tp5o']}, 07:35:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:47 INFO - 'tests': ['tp5o']}, 07:35:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:47 INFO - 'talos_options': ['--disable-e10s', 07:35:47 INFO - '--xperf_path', 07:35:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:47 INFO - 'tests': ['tp5n']}, 07:35:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:47 INFO - 'talos_options': ['--xperf_path', 07:35:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:47 INFO - 'tests': ['tp5n']}}, 07:35:47 INFO - 'talos.zip': {'path': '', 07:35:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:35:47 INFO - Running post-action listener: _resource_record_post_action 07:35:47 INFO - [mozharness: 2016-09-30 14:35:47.371963Z] Finished populate-webroot step (success) 07:35:47 INFO - [mozharness: 2016-09-30 14:35:47.372102Z] Running create-virtualenv step. 07:35:47 INFO - Running pre-action listener: _resource_record_pre_action 07:35:47 INFO - Running main action method: create_virtualenv 07:35:47 INFO - Creating virtualenv /builds/slave/test/build/venv 07:35:47 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 07:35:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:35:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:35:47 INFO - Using real prefix '/tools/python27' 07:35:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:35:48 INFO - Installing distribute.............................................................................................................................................................................................done. 07:35:51 INFO - Installing pip.................done. 07:35:51 INFO - Return code: 0 07:35:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d367490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb772c8e0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d17bd30>, '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 0x10cfe1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d173b20>, '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.NOctr2xlSG/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.Zp8E3jjDo0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 07:35:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:35:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NOctr2xlSG/Render', 07:35:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:51 INFO - 'HOME': '/Users/cltbld', 07:35:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:51 INFO - 'LOGNAME': 'cltbld', 07:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:51 INFO - 'MOZ_NO_REMOTE': '1', 07:35:51 INFO - 'NO_EM_RESTART': '1', 07:35:51 INFO - 'PAGER': '/bin/cat', 07:35:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:51 INFO - 'PWD': '/builds/slave/test', 07:35:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:51 INFO - 'SHELL': '/bin/bash', 07:35:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zp8E3jjDo0/Listeners', 07:35:51 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 07:35:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:51 INFO - 'USER': 'cltbld', 07:35:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:51 INFO - 'XPC_FLAGS': '0x0', 07:35:51 INFO - 'XPC_SERVICE_NAME': '0', 07:35:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:51 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 07:35:51 INFO - Cleaning up... 07:35:51 INFO - Return code: 0 07:35:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d367490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb772c8e0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d17bd30>, '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 0x10cfe1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d173b20>, '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.NOctr2xlSG/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.Zp8E3jjDo0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 07:35:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:35:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NOctr2xlSG/Render', 07:35:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:51 INFO - 'HOME': '/Users/cltbld', 07:35:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:51 INFO - 'LOGNAME': 'cltbld', 07:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:51 INFO - 'MOZ_NO_REMOTE': '1', 07:35:51 INFO - 'NO_EM_RESTART': '1', 07:35:51 INFO - 'PAGER': '/bin/cat', 07:35:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:51 INFO - 'PWD': '/builds/slave/test', 07:35:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:51 INFO - 'SHELL': '/bin/bash', 07:35:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zp8E3jjDo0/Listeners', 07:35:51 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 07:35:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:51 INFO - 'USER': 'cltbld', 07:35:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:51 INFO - 'XPC_FLAGS': '0x0', 07:35:51 INFO - 'XPC_SERVICE_NAME': '0', 07:35:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:51 INFO - Downloading/unpacking psutil>=3.1.1 07:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:35:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:54 INFO - Installing collected packages: psutil 07:35:54 INFO - Running setup.py install for psutil 07:35:55 INFO - building 'psutil._psutil_osx' extension 07:35:55 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 07:35:55 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 07:35:55 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 07:35:55 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 07:35:55 INFO - building 'psutil._psutil_posix' extension 07:35:55 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 07:35:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:35:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:35:55 INFO - ^ 07:35:55 INFO - 1 warning generated. 07:35:55 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 07:35:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:35:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:35:56 INFO - Successfully installed psutil 07:35:56 INFO - Cleaning up... 07:35:56 INFO - Return code: 0 07:35:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d367490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb772c8e0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d17bd30>, '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 0x10cfe1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d173b20>, '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.NOctr2xlSG/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.Zp8E3jjDo0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 07:35:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:35:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NOctr2xlSG/Render', 07:35:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:56 INFO - 'HOME': '/Users/cltbld', 07:35:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:56 INFO - 'LOGNAME': 'cltbld', 07:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:56 INFO - 'MOZ_NO_REMOTE': '1', 07:35:56 INFO - 'NO_EM_RESTART': '1', 07:35:56 INFO - 'PAGER': '/bin/cat', 07:35:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:56 INFO - 'PWD': '/builds/slave/test', 07:35:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:56 INFO - 'SHELL': '/bin/bash', 07:35:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zp8E3jjDo0/Listeners', 07:35:56 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 07:35:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:56 INFO - 'USER': 'cltbld', 07:35:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:56 INFO - 'XPC_FLAGS': '0x0', 07:35:56 INFO - 'XPC_SERVICE_NAME': '0', 07:35:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:35:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:36:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:36:00 INFO - Installing collected packages: mozsystemmonitor 07:36:00 INFO - Running setup.py install for mozsystemmonitor 07:36:00 INFO - Successfully installed mozsystemmonitor 07:36:00 INFO - Cleaning up... 07:36:00 INFO - Return code: 0 07:36:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d367490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb772c8e0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d17bd30>, '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 0x10cfe1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d173b20>, '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.NOctr2xlSG/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.Zp8E3jjDo0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 07:36:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:36:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:36:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NOctr2xlSG/Render', 07:36:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:00 INFO - 'HOME': '/Users/cltbld', 07:36:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:00 INFO - 'LOGNAME': 'cltbld', 07:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:00 INFO - 'MOZ_NO_REMOTE': '1', 07:36:00 INFO - 'NO_EM_RESTART': '1', 07:36:00 INFO - 'PAGER': '/bin/cat', 07:36:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:00 INFO - 'PWD': '/builds/slave/test', 07:36:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:00 INFO - 'SHELL': '/bin/bash', 07:36:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zp8E3jjDo0/Listeners', 07:36:00 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 07:36:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:00 INFO - 'USER': 'cltbld', 07:36:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:00 INFO - 'XPC_FLAGS': '0x0', 07:36:00 INFO - 'XPC_SERVICE_NAME': '0', 07:36:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:00 INFO - Downloading/unpacking jsonschema==2.5.1 07:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:36:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:36:02 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 07:36:02 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 07:36:02 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 07:36:02 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 07:36:02 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 07:36:02 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 07:36:03 INFO - Downloading functools32-3.2.3-2.tar.gz 07:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:36:03 INFO - warning: no files found matching '*.txt' 07:36:03 INFO - no previously-included directories found matching 'build' 07:36:03 INFO - no previously-included directories found matching 'dist' 07:36:03 INFO - no previously-included directories found matching '.git*' 07:36:03 INFO - Installing collected packages: jsonschema, functools32 07:36:03 INFO - Running setup.py install for functools32 07:36:03 INFO - warning: no files found matching '*.txt' 07:36:03 INFO - no previously-included directories found matching 'build' 07:36:03 INFO - no previously-included directories found matching 'dist' 07:36:03 INFO - no previously-included directories found matching '.git*' 07:36:03 INFO - Successfully installed jsonschema functools32 07:36:03 INFO - Cleaning up... 07:36:03 INFO - Return code: 0 07:36:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:36:03 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')]} 07:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:03 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')]} 07:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:03 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 0x10d367490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb772c8e0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d17bd30>, '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 0x10cfe1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d173b20>, '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.NOctr2xlSG/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.Zp8E3jjDo0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 07:36:03 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 07:36:03 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 07:36:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NOctr2xlSG/Render', 07:36:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:03 INFO - 'HOME': '/Users/cltbld', 07:36:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:03 INFO - 'LOGNAME': 'cltbld', 07:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:03 INFO - 'MOZ_NO_REMOTE': '1', 07:36:03 INFO - 'NO_EM_RESTART': '1', 07:36:03 INFO - 'PAGER': '/bin/cat', 07:36:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:03 INFO - 'PWD': '/builds/slave/test', 07:36:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:03 INFO - 'SHELL': '/bin/bash', 07:36:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zp8E3jjDo0/Listeners', 07:36:03 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 07:36:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:03 INFO - 'USER': 'cltbld', 07:36:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:03 INFO - 'XPC_FLAGS': '0x0', 07:36:03 INFO - 'XPC_SERVICE_NAME': '0', 07:36:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:36:04 INFO - Cleaning up... 07:36:04 INFO - Return code: 0 07:36:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:36:04 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')]} 07:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:04 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')]} 07:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:04 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 0x10d367490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb772c8e0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d17bd30>, '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 0x10cfe1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d173b20>, '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.NOctr2xlSG/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.Zp8E3jjDo0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 07:36:04 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 07:36:04 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 07:36:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NOctr2xlSG/Render', 07:36:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:04 INFO - 'HOME': '/Users/cltbld', 07:36:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:04 INFO - 'LOGNAME': 'cltbld', 07:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:04 INFO - 'MOZ_NO_REMOTE': '1', 07:36:04 INFO - 'NO_EM_RESTART': '1', 07:36:04 INFO - 'PAGER': '/bin/cat', 07:36:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:04 INFO - 'PWD': '/builds/slave/test', 07:36:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:04 INFO - 'SHELL': '/bin/bash', 07:36:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zp8E3jjDo0/Listeners', 07:36:04 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 07:36:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:04 INFO - 'USER': 'cltbld', 07:36:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:04 INFO - 'XPC_FLAGS': '0x0', 07:36:04 INFO - 'XPC_SERVICE_NAME': '0', 07:36:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:04 INFO - Downloading/unpacking blobuploader==1.2.4 07:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:06 INFO - Downloading blobuploader-1.2.4.tar.gz 07:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:36:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:36:06 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 07:36:06 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 07:36:06 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 07:36:06 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 07:36:06 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 07:36:06 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 07:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:36:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:36:07 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 07:36:07 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 07:36:07 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 07:36:07 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 07:36:07 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 07:36:07 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 07:36:07 INFO - Downloading docopt-0.6.1.tar.gz 07:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:36:08 INFO - Installing collected packages: blobuploader, requests, docopt 07:36:08 INFO - Running setup.py install for blobuploader 07:36:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:36:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:36:08 INFO - Running setup.py install for requests 07:36:08 INFO - Running setup.py install for docopt 07:36:08 INFO - Successfully installed blobuploader requests docopt 07:36:08 INFO - Cleaning up... 07:36:08 INFO - Return code: 0 07:36:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:08 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 0x10d367490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb772c8e0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d17bd30>, '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 0x10cfe1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d173b20>, '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.NOctr2xlSG/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.Zp8E3jjDo0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 07:36:08 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 07:36:08 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 07:36:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NOctr2xlSG/Render', 07:36:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:08 INFO - 'HOME': '/Users/cltbld', 07:36:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:08 INFO - 'LOGNAME': 'cltbld', 07:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:08 INFO - 'MOZ_NO_REMOTE': '1', 07:36:08 INFO - 'NO_EM_RESTART': '1', 07:36:08 INFO - 'PAGER': '/bin/cat', 07:36:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:08 INFO - 'PWD': '/builds/slave/test', 07:36:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:08 INFO - 'SHELL': '/bin/bash', 07:36:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zp8E3jjDo0/Listeners', 07:36:08 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 07:36:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:08 INFO - 'USER': 'cltbld', 07:36:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:08 INFO - 'XPC_FLAGS': '0x0', 07:36:08 INFO - 'XPC_SERVICE_NAME': '0', 07:36:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:09 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-et2hZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:09 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-Qr5xb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:09 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-GnXnO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:09 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-DNXdXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:09 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-rQFrxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:09 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-J6Riwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:09 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-L98m3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:09 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-fitOxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:10 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-H_pkSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:10 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-JXKK5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:10 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-jq2D0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:10 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-trsBqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:10 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-pouVwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:10 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-qGVItp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:10 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-o8zoAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:10 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-2QXeCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:10 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-f0_UmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:36:10 INFO - Running setup.py install for manifestparser 07:36:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for mozcrash 07:36:11 INFO - Running setup.py install for mozdebug 07:36:11 INFO - Running setup.py install for mozdevice 07:36:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for mozfile 07:36:11 INFO - Running setup.py install for mozhttpd 07:36:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for mozinfo 07:36:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Running setup.py install for mozInstall 07:36:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Running setup.py install for mozleak 07:36:12 INFO - Running setup.py install for mozlog 07:36:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Running setup.py install for moznetwork 07:36:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Running setup.py install for mozprocess 07:36:12 INFO - Running setup.py install for mozprofile 07:36:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Running setup.py install for mozrunner 07:36:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:36:13 INFO - Running setup.py install for mozscreenshot 07:36:13 INFO - Running setup.py install for moztest 07:36:13 INFO - Running setup.py install for mozversion 07:36:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:36:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:36:13 INFO - Cleaning up... 07:36:13 INFO - Return code: 0 07:36:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:13 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')]} 07:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:13 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')]} 07:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:13 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 0x10d367490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb772c8e0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d17bd30>, '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 0x10cfe1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d173b20>, '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.NOctr2xlSG/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.Zp8E3jjDo0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 07:36:13 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 07:36:13 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 07:36:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NOctr2xlSG/Render', 07:36:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:13 INFO - 'HOME': '/Users/cltbld', 07:36:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:13 INFO - 'LOGNAME': 'cltbld', 07:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:13 INFO - 'MOZ_NO_REMOTE': '1', 07:36:13 INFO - 'NO_EM_RESTART': '1', 07:36:13 INFO - 'PAGER': '/bin/cat', 07:36:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:13 INFO - 'PWD': '/builds/slave/test', 07:36:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:13 INFO - 'SHELL': '/bin/bash', 07:36:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zp8E3jjDo0/Listeners', 07:36:13 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 07:36:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:13 INFO - 'USER': 'cltbld', 07:36:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:13 INFO - 'XPC_FLAGS': '0x0', 07:36:13 INFO - 'XPC_SERVICE_NAME': '0', 07:36:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:13 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-OQsYOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:13 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)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:13 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-i7FLwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:14 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:14 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-LChlhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:14 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:14 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-sqRBN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:14 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:14 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-tkUtS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:14 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:14 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-RnNZXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:14 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:14 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-VqSBOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:14 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:14 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-78u0Hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:14 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:14 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-fArB5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:14 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:14 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-_CoptI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:14 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)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:14 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-qsz3VS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:15 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)) 07:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:15 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-4HtUxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:15 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)) 07:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:15 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-RkNdae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:15 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)) 07:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:15 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-lEcZJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:15 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)) 07:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:15 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-CqA21U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:15 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)) 07:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:15 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-Ne7ZPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:15 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)) 07:36:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:15 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-cGvACe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:15 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)) 07:36:15 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)) 07:36:15 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)) 07:36:15 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)) 07:36:15 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)) 07:36:15 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)) 07:36:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:18 INFO - Downloading blessings-1.6.tar.gz 07:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:36:18 INFO - Installing collected packages: blessings 07:36:18 INFO - Running setup.py install for blessings 07:36:18 INFO - Successfully installed blessings 07:36:18 INFO - Cleaning up... 07:36:18 INFO - Return code: 0 07:36:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:36:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:18 INFO - Reading from file tmpfile_stdout 07:36:18 INFO - Current package versions: 07:36:18 INFO - blessings == 1.6 07:36:18 INFO - blobuploader == 1.2.4 07:36:18 INFO - docopt == 0.6.1 07:36:18 INFO - functools32 == 3.2.3-2 07:36:18 INFO - jsonschema == 2.5.1 07:36:18 INFO - manifestparser == 1.1 07:36:18 INFO - mozInstall == 1.12 07:36:18 INFO - mozcrash == 0.17 07:36:18 INFO - mozdebug == 0.1 07:36:18 INFO - mozdevice == 0.48 07:36:18 INFO - mozfile == 1.2 07:36:18 INFO - mozhttpd == 0.7 07:36:18 INFO - mozinfo == 0.9 07:36:18 INFO - mozleak == 0.1 07:36:18 INFO - mozlog == 3.4 07:36:18 INFO - moznetwork == 0.27 07:36:18 INFO - mozprocess == 0.23 07:36:18 INFO - mozprofile == 0.28 07:36:18 INFO - mozrunner == 6.12 07:36:18 INFO - mozscreenshot == 0.1 07:36:18 INFO - mozsystemmonitor == 0.3 07:36:18 INFO - moztest == 0.7 07:36:18 INFO - mozversion == 1.4 07:36:18 INFO - psutil == 3.1.1 07:36:18 INFO - requests == 1.2.3 07:36:18 INFO - wsgiref == 0.1.2 07:36:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:18 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')]} 07:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:18 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')]} 07:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:18 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 0x10d367490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb772c8e0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d17bd30>, '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 0x10cfe1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d173b20>, '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.NOctr2xlSG/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.Zp8E3jjDo0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 07:36:18 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 07:36:18 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 07:36:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NOctr2xlSG/Render', 07:36:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:18 INFO - 'HOME': '/Users/cltbld', 07:36:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:18 INFO - 'LOGNAME': 'cltbld', 07:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:18 INFO - 'MOZ_NO_REMOTE': '1', 07:36:18 INFO - 'NO_EM_RESTART': '1', 07:36:18 INFO - 'PAGER': '/bin/cat', 07:36:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:18 INFO - 'PWD': '/builds/slave/test', 07:36:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:18 INFO - 'SHELL': '/bin/bash', 07:36:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zp8E3jjDo0/Listeners', 07:36:18 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 07:36:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:18 INFO - 'USER': 'cltbld', 07:36:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:18 INFO - 'XPC_FLAGS': '0x0', 07:36:18 INFO - 'XPC_SERVICE_NAME': '0', 07:36:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:19 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)) 07:36:19 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)) 07:36:19 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)) 07:36:19 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)) 07:36:19 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)) 07:36:19 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)) 07:36:19 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)) 07:36:19 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)) 07:36:19 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)) 07:36:19 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)) 07:36:19 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)) 07:36:19 INFO - Cleaning up... 07:36:19 INFO - Return code: 0 07:36:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d367490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d2dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb772c8e0c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d17bd30>, '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 0x10cfe1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d173b20>, '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.NOctr2xlSG/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.Zp8E3jjDo0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 07:36:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:36:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NOctr2xlSG/Render', 07:36:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:19 INFO - 'HOME': '/Users/cltbld', 07:36:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:19 INFO - 'LOGNAME': 'cltbld', 07:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:19 INFO - 'MOZ_NO_REMOTE': '1', 07:36:19 INFO - 'NO_EM_RESTART': '1', 07:36:19 INFO - 'PAGER': '/bin/cat', 07:36:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:19 INFO - 'PWD': '/builds/slave/test', 07:36:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:19 INFO - 'SHELL': '/bin/bash', 07:36:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zp8E3jjDo0/Listeners', 07:36:19 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 07:36:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:19 INFO - 'USER': 'cltbld', 07:36:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:19 INFO - 'XPC_FLAGS': '0x0', 07:36:19 INFO - 'XPC_SERVICE_NAME': '0', 07:36:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:36:19 INFO - Cleaning up... 07:36:19 INFO - Return code: 0 07:36:19 INFO - Running post-action listener: _resource_record_post_action 07:36:19 INFO - Running post-action listener: _start_resource_monitoring 07:36:19 INFO - Starting resource monitoring. 07:36:19 INFO - [mozharness: 2016-09-30 14:36:19.369586Z] Finished create-virtualenv step (success) 07:36:19 INFO - [mozharness: 2016-09-30 14:36:19.370546Z] Running install step. 07:36:19 INFO - Running pre-action listener: _resource_record_pre_action 07:36:19 INFO - Running main action method: install 07:36:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:19 INFO - Reading from file tmpfile_stdout 07:36:19 INFO - Detecting whether we're running mozinstall >=1.0... 07:36:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:36:19 INFO - Reading from file tmpfile_stdout 07:36:19 INFO - Output received: 07:36:19 INFO - Usage: mozinstall [options] installer 07:36:19 INFO - Options: 07:36:19 INFO - -h, --help show this help message and exit 07:36:19 INFO - -d DEST, --destination=DEST 07:36:19 INFO - Directory to install application into. [default: 07:36:19 INFO - "/builds/slave/test"] 07:36:19 INFO - --app=APP Application being installed. [default: firefox] 07:36:19 INFO - mkdir: /builds/slave/test/build/application 07:36:19 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'] 07:36:19 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 07:36:51 INFO - Reading from file tmpfile_stdout 07:36:51 INFO - Output received: 07:36:51 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:36:51 INFO - Running post-action listener: _resource_record_post_action 07:36:51 INFO - [mozharness: 2016-09-30 14:36:51.886416Z] Finished install step (success) 07:36:51 INFO - [mozharness: 2016-09-30 14:36:51.886573Z] Running run-tests step. 07:36:51 INFO - Running pre-action listener: _resource_record_pre_action 07:36:51 INFO - Running main action method: run_tests 07:36:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:36:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:36:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:36:51 INFO - 2016-09-30 07:36:51.901 screenresolution[1647:8196] starting screenresolution argv=screenresolution get 07:36:51 INFO - 2016-09-30 07:36:51.903 screenresolution[1647:8196] Display 0: 1600x1200x32@60 07:36:51 INFO - 2016-09-30 07:36:51.909 screenresolution[1648:8198] starting screenresolution argv=screenresolution list 07:36:51 INFO - Available Modes on Display 0 07:36:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:36:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:36:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:36:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:36:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:36:52 INFO - Intel Iris: 07:36:52 INFO - Chipset Model: Intel Iris 07:36:52 INFO - Type: GPU 07:36:52 INFO - Bus: Built-In 07:36:52 INFO - VRAM (Dynamic, Max): 1536 MB 07:36:52 INFO - Vendor: Intel (0x8086) 07:36:52 INFO - Device ID: 0x0a2e 07:36:52 INFO - Revision ID: 0x0009 07:36:52 INFO - Displays: 07:36:52 INFO - Display: 07:36:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:36:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:36:52 INFO - Display Serial Number: 1600x1200 60 07:36:52 INFO - Main Display: Yes 07:36:52 INFO - Mirror: Off 07:36:52 INFO - Online: Yes 07:36:52 INFO - Rotation: Supported 07:36:52 INFO - Return code: 0 07:36:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:36:52 INFO - Python 2.7.3 07:36:52 INFO - Return code: 0 07:36:52 INFO - grabbing minidump binary from tooltool 07:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:52 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 0x10d17bd30>, '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 0x10cfe1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d173b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:36:52 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 07:36:52 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 07:36:52 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 07:36:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:36:52 INFO - Return code: 0 07:36:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:36:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:36:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:36:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:36:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:36:52 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/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0142', '--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 07:36:52 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/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0142 --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 07:36:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NOctr2xlSG/Render', 07:36:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:52 INFO - 'HOME': '/Users/cltbld', 07:36:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:52 INFO - 'LOGNAME': 'cltbld', 07:36:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:36:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:52 INFO - 'MOZ_NO_REMOTE': '1', 07:36:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:36:52 INFO - 'NO_EM_RESTART': '1', 07:36:52 INFO - 'PAGER': '/bin/cat', 07:36:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:52 INFO - 'PWD': '/builds/slave/test', 07:36:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:36:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:52 INFO - 'SHELL': '/bin/bash', 07:36:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zp8E3jjDo0/Listeners', 07:36:52 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 07:36:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:52 INFO - 'USER': 'cltbld', 07:36:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:52 INFO - 'XPC_FLAGS': '0x0', 07:36:52 INFO - 'XPC_SERVICE_NAME': '0', 07:36:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:52 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/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0142', '--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 07:36:52 INFO - mozversion application_buildid: 20160930013320 07:36:52 INFO - mozversion application_changeset: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 07:36:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:36:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:36:52 INFO - mozversion application_name: Firefox 07:36:52 INFO - mozversion application_remotingname: firefox-dev 07:36:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:36:52 INFO - mozversion application_vendor: Mozilla 07:36:52 INFO - mozversion application_version: 51.0a2 07:36:52 INFO - mozversion platform_buildid: 20160930013320 07:36:52 INFO - mozversion platform_changeset: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 07:36:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:36:52 INFO - mozversion platform_version: 51.0a2 07:36:52 INFO - using testdate: 1475246212 07:36:52 INFO - actual date: 1475246212 07:36:52 INFO - starting webserver on 'localhost:49271' 07:36:52 INFO - SUITE-START | Running 2 tests 07:36:52 INFO - TEST-START | dromaeo_css 07:36:52 INFO - operating with platform_type : mac_ 07:36:52 INFO - Initialising browser for dromaeo_css test... 07:36:52 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmp4xH86D/profile http://localhost:49271/getInfo.html) 07:36:54 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 07:36:54 INFO - PROCESS | 1658 | colorDepth:24 07:36:54 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 07:36:54 INFO - PROCESS | 1658 | __metrics 07:36:54 INFO - PROCESS | 1658 | 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" 07:36:54 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:36:55 INFO - TEST-INFO | 1658: exit 0 07:36:55 INFO - Browser initialized. 07:36:55 INFO - Running cycle 1/1 for dromaeo_css test... 07:36:55 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmp4xH86D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:07 INFO - PROCESS | 1661 | RSS: Main: 219357184 07:37:07 INFO - PROCESS | 1661 | 07:38:00 INFO - PROCESS | 1661 | 1475246280867 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] 07:40:10 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 07:40:12 INFO - PROCESS | 1661 | RSS: Main: 354041856 07:40:12 INFO - PROCESS | 1661 | 07:43:15 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 07:43:15 INFO - PROCESS | 1661 | RSS: Main: 352759808 07:43:15 INFO - PROCESS | 1661 | 07:46:18 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 07:46:18 INFO - PROCESS | 1661 | RSS: Main: 336941056 07:46:18 INFO - PROCESS | 1661 | 07:49:21 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 07:49:21 INFO - PROCESS | 1661 | RSS: Main: 322035712 07:49:21 INFO - PROCESS | 1661 | 07:52:25 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 07:52:25 INFO - PROCESS | 1661 | RSS: Main: 312983552 07:52:25 INFO - PROCESS | 1661 | 07:55:28 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 07:55:28 INFO - PROCESS | 1661 | RSS: Main: 435056640 07:55:28 INFO - PROCESS | 1661 | 07:55:28 INFO - PROCESS | 1661 | __start_tp_report 07:55:28 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 07:55:28 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 07:55:28 INFO - PROCESS | 1661 | |i|pagename|runs| 07:55:28 INFO - PROCESS | 1661 | |0;dojo.html;2938.720821521955;3365.697087262147;3366.007027926763;3370.5449764281816;3462.8961131166056;5764.077747560391;5796.07262837946;5802.941970580293;5810.535157187425;5850.561207909408;5687.516561092312;5728.79949201778;5813.2152159458465;5818.5926985111055;5825.737841797119;5237.188235823453;5284;5302.416734159239;5305.681659100447;5346.893062138755;5248.6063545234065;5264.736763161845;5353.812616558421;5358.437364076774;5362.624616276843;5319.547838433718;5348.545373643245;5349.251104845324;5355.812546560871;5364.5708343332635;5244.659097158673;5305.549028332577;5307.230451584499;5308.124159513675;5335.706536140511;5206.245094461282;5254.975279820436;5288.550473209782;5305.681659100428;5320.6275560710765;5792.88414231713;5825.679587622679;5883.911741323884;5892.675902825343;5901.7934372297195;6146.416090471398;6195.132681424604;6195.938040619581;6245.313015568284;6278.058291256302;6266.937330626681;6279.968600157015;6359.236891573041;6369.235691717024;6384.106225128486;5896.498797602209;5900.924229145164;5902.380250073724;5905.261842269716;5956.047032474783;6253.249610046732;6286.717097730613;6331.303556608769;6366.522510811707;6535.052417399451;6231.875362492725;6265;6265.8120256392385;6282.560220784501;6283.43449089575;6335.68321583919;6338.619682819046;6344.429001389804;6349.650769207646;6372.649504277217;4884.340614017134;6027.427394397525;6105.084237364342;6147.538934579924;6321.525885558602;6168.568200225941;6232.18981532407;6305.716242769086;6306.49548036156;6356.586821856565;4946.1344264753525;4957.925631115536;4969.82605608802;4970.826021089245;4978.8257410990445;4456.64443814555;4470.530594287618;4490.079533695584;4490.483594386622;4498.955010449919;4471.35165401015;5763.279590051244;5765.019946609086;5786.1610066540115;5877.823665290048;6339.524535659844;6350.872982540323;6357.904631430532;6362.172917520786;6385.138006369174;5121.564667003272;5592.657762137139;5809.3609702932645;5822.796202132905;5824.854378640483;5377.596680248997;5414.729263536808;5424.538914192259;5426.131818908955;5460.726963651801;6230.657313847782;6296.968515157395;6299.842503937438;6322.178116844781;6406.391392817675;6376.521760868046;6378.298387177314;6384.872302554016;6387.233531976192;6396.456301214449;6228.813135605939;6367.140436041075;6385.904211436925;6394.680265986589;6398.680065996588;5186.740662966912;5718.770464350185;6111.470193407107;6155.1075094112;6179.938200618116;6079.939200607937;6326.620402775849;6349.3650634937985;6359.872802544016;6373.3945275198785;5078.898422031612;6076.908846367396;6180.6600636965395;6189.752409903554;6244.781432649836;6038;6090.1169330445955;6098.878022439438;6124.930239974474;6202.379762023762;5953.58324917269;6036.215292012186;6064.272287325549;6092.294157635869;6107.226802228232;6192.318844927145;6197.566170368031;6210.503159747119;6212.720427580679;6227.906581401192;5817.650940943557;6000.309964354155;6026.096085587022;6051.667158306159;6058.606190597597 07:55:28 INFO - PROCESS | 1661 | |1;ext.html;483.67110364951816;516.256590509666;531.0467710459725;536.8443151486069;551.3879593651046;30016.69983300169;38958.220835583306;39995.600043999584;40104.39843402351;40183.59816401835;41758.747237582844;42091;42120.78939605298;42185.15629687405;42350.78824605873;8211.50730956143;9859.802803943916;9861.506924653775;9861.901380986206;9885.110340069392;8913.955430222872;9122.589483473259;11956.760864782698;12193.756124877496;12212.93893530531;12187.32969686667;12237.571684991028;12258.203216790924;12276.447559859827;12299.077569182302;8817.118288171132;12208.32854193019;12303.93848030754;12313.322767247797;12317.445714942849;8707.869381959275;11629.185956983014;11936.641900742992;11962.880371196263;12225.388730563436;39858;40159.196816063515;40176.79911600453;40182.59817401847;40260.19479610391;3353.0946644406117;3418.504316874064;3570.250247448039;3646.2889736501393;3938.586448422903;28584.28539286514;29779.10662680123;31212.46236937776;31299.687003129904;31776.682233177602;3075.3080556874747;3122.1414111119398;3127.5934128563367;3269.6893795089427;3361.5293858859777;530742;532274;533181;533211;533886;57375.42624573784;57774.133387999216;57798.42201578015;57801;57804.4219557799;60114.797704045675;60264.698676507214;60355.69822150861;60446.697766510886;60472;16437.424690135787;16688.415905443253;16691.24889379981;16691.497765200947;16699.582510437336;11487.310761354178;11774.529018839321;13075.411606477732;13131.737365252642;13162.802557961639;13474.797878031837;14943.626409339637;15300.311485983157;15345.539633811004;15748.370065197492;5429.864253393696;5981.6710080945095;6022.638641681513;6031.155638210654;6047.183630209954;741.9443541734391;878.7934835313696;882.4528792148781;943.9946457023249;1017.2574020964737;24331.572126407995;28819.279518011797;29275.268118297212;29735;29919;1021.7854250607307;1046.7906418716134;1053.1416895230363;1064.2816099133054;1142.657202839145;14761.483348082766;15273.541793745982;15302.311395987208;15336.856867647768;15665.765013524806;696456;703881;704070;704149;704332;47980.760096199294;56064;57000;57142;59889;1143.954241830334;1390.4299237312653;1396.2460271453504;1396.8533304002933;1401.628568429367;29889.93554784333;31010.68989310078;31130.844345778125;31425.528617070304;31938.20154496156;48086.27870582014;48551.271730923356;48597.51402486071;48723.269150962056;48749.02501950012;636297;639356;640048;641356;641927.7903610452;38436.61563384331;38830.805845970586;39222.2155556893;39449.80275098606;39474.40788388234;46249.306260406796;46388;46521.302180467996;46894.53105469038;47180.7640961793;38231.42652860265;38338;38724.03189920162;39884.00289992657;40065.799671001456;32380.190495236864;38415.03962400962;38418;38868.80565597154;39790.403143953445;37376.439353410264;37981.810090949366;38052.61947380491;38140.23719525649;38222.23555528929;32377.514337284487;33633.60961417323;34281.62873485132;34575.481367779;34803;25453.618195726707;25504.362390940376;25537.23388298354;25812.741872581035;26089.478210436064 07:55:28 INFO - PROCESS | 1661 | |2;jquery.html;341.0365716849899;355.4792229383952;371.6970668904844;376.41843352021135;396.9960300396995;14842.925785371071;15258.237088145605;15994.040357578539;20454.977251137458;20809.791902080975;19896.70154947677;19946.70079948802;20546.794532054675;20594.970251487404;20882.269120580782;5308.044551980642;5734.369219385854;5897.941020589804;6022.307434645006;6027.668478233695;5156.53591176794;6614.669266536654;6730.49521285903;6739.764108256212;6740.359665831738;5818.5345172386105;6139.355367686396;6666.0334251533495;6685.632290224035;6689.933100669004;6150.477209437181;6171.969140154315;6176.81469555914;6178.289496707891;6194.008958566653;5769.423057694239;5957.553183511254;6026.849328766816;6030.788922387739;6038.788642397539;10868.836967445495;12753.61739147827;13004.479820807157;21698.674519882214;23981;2169.945751356229;2251.4371407148215;2447.0334217983795;2456.4350199454225;2486.987565062181;8906.73279801607;9194.666773317898;9502.619895204252;9861.260405469548;10207.13239374654;1716.7167417376243;1722.3541172060477;1818.0546116019727;1832.605989712205;1838.2187570282576;116234;118384.40807795992;123624.38187809003;125678.37160814229;127168;10862.619808306672;11236.606718764804;11516.596919107791;11528.942355288169;11685.18203725748;14403.78394324086;14411.279436028366;14421.062630929166;14425.350859211361;14434.783478247835;8313.12712165226;8526.147385261424;8532.402731808714;8619;8674.913250867537;8200;8509.10654381281;8510.872336914952;8676.522791246416;8683.739487815375;4107.486564179478;4374.081442896963;4460.330950357472;4517.525659805673;4539.614132798683;1569.2467615544374;1893.9621207575772;1901.7812951510753;1910.2072639854582;1924.1437560285538;811.8335741173046;860.8837806896114;936.8851067229974;971.4802580619335;984.5963155106372;20193.596128077355;20246.898765506372;20508.79491205069;20516.794832051488;20686.379408617766;895.1406649616441;904.3850181876387;910.544727636182;920.8342498350361;989.2086330935223;10291.331063480999;10868.510917008754;10888.40113793749;10912.563497460013;10922;626490;627790;640990.323683436;644160;650644;116872;120014;120723;122552;125612;905.764501229685;949.1410273702172;962.9807403851884;963.8506031565119;966.3428868369435;14887.627809304853;17395.47813565595;18158;18209.271629135215;18551.35070272534;49944.750276248385;50339;52042;52341;55856.88286234334;75283.49433011419;77273;80081;80971.59514202391;81122;6629.569078009914;7477;7601.581912994839;7891.329237014918;7988.241117093867;6995.265497122728;10643.829178790173;11188.552457901918;11878.809627049079;12247.081468890046;10190.1338386238;10243.795124097625;10278.691639250834;10625.574977000833;10730.83903741429;10177.440240786827;10225.130863876653;10407.167426606005;10489.318194317346;10652.733681658021;6494.642794646151;9855.950720246354;10561.788764224826;10611.363318200933;10705.785884282426;6662.666866656551;6851.246362900177;6946.79159625212;7183.820404489929;7636.08366995964;8339.416240863324;9115.407498512575;9855.802883942424;10586.72385437104;10668 07:55:28 INFO - PROCESS | 1661 | |3;mootools.html;1346.0981142634434;1351.952681656142;1503.3235044230096;1568.5608029751666;1681.8654507639383;7852.293293603581;8394.748157555276;8758.737237882866;8862.645494180226;8873.600687969041;8805.955970220157;8899.91100088999;8913.68802091927;8914.732558023254;8921.33090018248;2377.3224630980176;2404.617345026608;2408.000679717915;2412.2401443545314;2412.7345991940874;2394.162043284845;2415.9637605435933;2441.6093425051995;2442.3405680466262;2442.694663167104;2403.0387844862107;2416.867072311022;2422.6002709552904;2431.890564924574;2432.3311089450453;2365.8817059146972;2396.424858034068;2400.9879950600134;2404.7475015123423;2406.7472915343988;2363.8581685098948;2390.2351247600773;2390.97609023911;2393.126508824284;2395.700537432821;8820.514871682055;8828;8839.911600883974;8902.06528314524;8952.418092823946;5267.183586544092;5453.536449401806;5460.563154947595;5474.151506516497;5477.260569823063;3058.9847050764824;3614.8373323200517;3652;3707.6477734615437;3717.7769333840056;1113.8162203236457;1120.137494129524;1122.3041714137205;1129.4183495499824;1142.4173671427548;11884.049276057895;11906;11963.581274655433;11972.940135299355;11973.221740586834;4447.3773671685985;4523.841665541756;4691.413573303337;4699.0132072265205;4710.105080034851;9290;9298.53507324631;9305.906940930505;9310.9757926628;9311.301652376098;5285.7621407036;5293.0472514946905;5299.655522391032;5301.284326615934;5315.096433606296;4171.791410429466;4449.7997590108525;4559.658025648089;4572.222722137245;4956.653034287638;3415.504751811023;3810.5617853946596;3860.768353898775;3938.606139386096;3947;926.9073092690677;1106.391484683421;1149.3621589235306;1157.739508610556;1164.0745607242263;908.8000639859221;928.8513837785922;935.9953200233955;937.6624415210518;942.7548837302351;5787.131930210502;5843.94156058434;5960.612560183661;6206.286277078194;6221.3778622138325;395.74276720132144;428.1202129623653;428.6356596892616;448.3163176156323;448.9393931819228;3932.5870783567884;4032.717709760347;4079.204555111725;4110.547839737626;4153.68847336451;10506.947465262778;11024;11030.731465881367;11049.834252486218;11078.169137314733;10624.468776561142;10975.28660637056;10994.560217591366;10994.945025274823;11002.449877506093;8188.631511581993;8410.411271211078;8412.411131220755;8416.410851240476;8432.620532075949;5785.016547186904;5839.474447299764;5948.405159484017;6052.515798736179;6076.483498902643;9971.850422243817;9983.650572229937;10072.446015469219;10150.847737284093;10207.948960255448;9393.248540116638;10222;10475.52860121281;10519.053285204369;10529.157667386744;6580.374864388067;6806.6256355900905;6937.9653101736185;6969.651517424007;7114.181869084914;8285.047219569826;8305.335573154012;8310.293625041939;8364.121767214356;8394.496330220207;6374.362563743589;7520.811979700551;7551.773446796605;7563.016807814949;7574.81062973408;7193.5324203926575;7285.62250036117;7320.853582928418;7323.231060738759;7393.482456228013;6888.448924085961;6973.302669732986;7007.789766307019;7012.579245245098;7024.227334993045;4944.3572335596145;4949.158643030765;4979.377577802775;5084.2881996521255;5247.107991641354;5047.949520504748;5092.567131793839;5094.2358646203365;5143.871403214949;5213.374395072616 07:55:28 INFO - PROCESS | 1661 | |4;prototype.html;263.7468030690537;305.45323870272216;306.7362068620986;310.65051816706193;315.6858925369258;4741.3836201293825;5365.382980957191;5408.945910540893;5467.535259502942;5490.313710786152;4616.122936642036;4833.275008748689;5313.546194973269;5317;5373.220882971967;3839.692824574034;3987.421823835542;4029.4157347184787;4036.233115708006;4041.3533834586474;3102.5966624338803;3653.9489526245616;3901.590333015035;3996.161765587833;4186.769727664992;3298.6371499135075;3740.971232910944;4080.8575497863562;4100.487439070116;4110.712250142491;3954.7033972451895;4054.8378064877515;4058.817353219112;4101.794910254475;4108.342665173588;2917.7519910807396;3538.610752817188;3561.2521370512222;3565.7001234204054;3566.892993210208;4961.5286547777905;5179.818706345298;5192.948070519285;5217.330454254602;5236.319278493771;4229.281022226229;4468.173387923244;4700.976495117537;4733.763311834395;4753.714777113384;5391.514763671288;5652.632578882401;5660.5471562274915;5664.291963504562;5668.121441176624;3943.960560394388;3946.644801967837;3953.1815364932168;3954.940675889864;3962.960370396288;5010.498950104997;5445.50990410865;6024.759009639609;6033.185519954794;6035.758569657209;3559.875404360835;3963.920721585552;3968.3253846846105;3970.68234541236;3975.920481590352;3632.5277713897026;3947.743396679207;3976.005998500375;4039;4052.723392131469;4081.795910204478;4500.842470513517;4686.203345431285;4707.31743897133;4730.88172795676;4730.864592497775;5545.306836645419;5642.351129620064;5653.689047102366;5733.910556994158;1200.39980009995;1356.19984209315;1372.6499742565582;1378.2144177818748;1378.7862881253423;818.9590520473953;888.5290795878195;905.4024343932973;935.6584846530967;941.5480569326625;4779.713217206979;4927.162382395001;4987.202047672355;5019.623528235397;5108.335916330853;4965.751712414365;5207.765650545734;5382.973085134549;5858.681796595732;5887.852803679943;4786.401699787527;5213.478652134756;5399.460053994648;5413.512783849394;5416.864578385493;3009.9247518812203;3047.2229581456586;3053.6030316059214;3064.341166649181;3075.876964921378;5100.846974590768;5383.757730902119;6052.909206361908;6063.938810708109;6129.938700612936;4935.950640493549;5807.818370773037;6000.549958753111;6014.729337179838;6037.396260374016;5058.367704036996;5068.847934561969;5078.984203159383;5506.972465137648;6068.939310606926;5392.595555333287;5509.787846673726;5874.265716785402;5877.471027607536;5889;5650.29371328584;5733.913991290217;5768;5770.3364113125845;5822.94177058241;5678.77284908599;5818.44724751148;5996.730147143477;6019.428154325332;6059.848503787264;3810.5998870118237;3927.743122200868;3935.803209839439;3936.2324346752107;3972.483577134954;4390.990072283329;5823.301203855564;5826.514238869061;5834.212381328466;5863.061910094364;5213.765380557808;5645.193538067779;5694.629849059798;5719.885602287848;5721.914171287351;5275.498827611371;5328.387235467971;5616.747246374005;5631.6902570359025;5703.287089113861;5486.451354864482;5523.6685798852195;5561.749721262472;5568.939492387843;5570.69088764132;4810.494898035656;5229.980153870111;5439.600249843847;5531.917021244604;5695.971520142372;4967.0065986802065;5375.3280839895015;5480.890382192413;5514.876772442558;5522.889542209214 07:55:28 INFO - PROCESS | 1661 | |5;yui.html;580.9680467574284;720.5460559847297;744.9776506704801;757.9691619397619;796.4004277695367;14792.926035369821;16122.596935076599;16133.43532976346;16168.434104806349;16313.184340782958;14468.421263149461;14629.122252664847;14658.63353416165;14663.266836658151;14668.26658667065;672.1732269308741;694.035290945586;694.6908625661582;695.544418405945;695.7495301691387;706.7561691216522;832.1137988042746;851.812601227732;858.0218550852034;869.7390782765177;909.8043920557079;910.9524047345573;914.1863741270275;914.401067300919;917.0783362720457;900.7883147460342;902.4900930974012;903.5798353765498;904.9819003619891;907.1971305394708;525.5401523666792;544.1402583917401;651.7881688451225;671.942884854788;673.592476551689;14991;15013.024153429991;15026.549203523911;15028.624284392869;15062.623434414227;13667.453301867914;13941.302934853318;14033.78949315761;14083.577492675236;14308.57074287773;12143.149979501439;12602.684932876751;12677.492900283978;12881.825981125698;12899.742005159938;4477.082198149405;4505.864824055284;4645.86062418128;4710.4347478302825;4780.545848144421;108115;108535;108565.37151942727;112892.22646641228;115572.42213788877;9344.439333640003;10468.979791927562;10685.679429617125;10880.727981800519;10913.618023369145;19871.30450434228;22090.88954555217;22182.55634887293;22222.444438889157;22259.888700556716;8041.798955026171;8092.8381432371025;8172.18278172178;8188.222118898695;8231.259186673109;4249.957500425018;4341.60925516705;4443.533428989909;4570.085982803453;4660.04469083837;3583.5341405617105;3725.646063624006;3731.1791405890663;3731.869384571527;3732.42147467143;638.4860187548975;661.1372159332118;670.1154476091609;676.7326905872153;685.1880521581942;582.5921854701726;656.9146011018632;672.6838385958591;676.6650507998473;677.4580335731396;8051.838963220703;9475.952620236854;9553.522323883779;9673.806523869483;9727.513624318897;659.446065305146;675.93240675933;677.1907570453261;686.8900975843941;698.5948150072945;4174.519930208005;4521.163584736769;4542.909141817145;4552.180607490617;4711.599514041345;142841;146833.53166468412;150669;152559;154620;110771.20899494516;120378.19432708516;124304;127201.36399317945;136273.3186334062;104699;108220;109847.90152098537;111286;111908.44045779719;7487.3261406473675;8671.783205419915;8849.247813935888;8909.064548222343;8980.775480612776;58089.709551451975;59190.37691419308;61024.77950441055;63498.36501635109;64049;87350.1264987342;94648;96934.51532742291;98919.53781617609;100301.49849250707;11492;11900.464479098287;11966.760664786829;12000.879991199976;12433.12968092225;12849.494348601933;13081.411336490071;13123.60629181126;13188.472461101832;13656.453741850215;11603.303801771583;12119.454624542093;12336.444859981142;12364.81452778227;12809.807852882028;12318.753624927273;12330.136890417944;12372.13395062337;12411.875881241072;12826.61520154397;11950.940245298718;12070.215435996632;12114.091443141975;12123.393830308625;12574.30841303737;9815.705528834147;9868.950655246677;10336;10704.464776761286;10832.025117739442;10353.741156470847;10466.68599942003;10723.19576031785;10748.570057197625;10750.51622676997 07:55:28 INFO - PROCESS | 1661 | __end_tp_report 07:55:28 INFO - PROCESS | 1661 | __start_cc_report 07:55:28 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1381 07:55:28 INFO - PROCESS | 1661 | __end_cc_report 07:55:28 INFO - PROCESS | 1661 | __startTimestamp1475247328785__endTimestamp 07:55:28 INFO - PROCESS | 1661 | 07:55:28 INFO - PROCESS | 1661 | ------- Summary: start ------- 07:55:28 INFO - PROCESS | 1661 | Number of tests: 6 07:55:28 INFO - PROCESS | 1661 | 07:55:28 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5781.77 Median:6026.10 stddev:666.86 (11.1%) stddev-sans-first:630.50 07:55:28 INFO - PROCESS | 1661 | Values: 2938.7 3365.7 3366.0 3370.5 3462.9 5764.1 5796.1 5802.9 5810.5 5850.6 5687.5 5728.8 5813.2 5818.6 5825.7 5237.2 5284.0 5302.4 5305.7 5346.9 5248.6 5264.7 5353.8 5358.4 5362.6 5319.5 5348.5 5349.3 5355.8 5364.6 5244.7 5305.5 5307.2 5308.1 5335.7 5206.2 5255.0 5288.6 5305.7 5320.6 5792.9 5825.7 5883.9 5892.7 5901.8 6146.4 6195.1 6195.9 6245.3 6278.1 6266.9 6280.0 6359.2 6369.2 6384.1 5896.5 5900.9 5902.4 5905.3 5956.0 6253.2 6286.7 6331.3 6366.5 6535.1 6231.9 6265.0 6265.8 6282.6 6283.4 6335.7 6338.6 6344.4 6349.7 6372.6 4884.3 6027.4 6105.1 6147.5 6321.5 6168.6 6232.2 6305.7 6306.5 6356.6 4946.1 4957.9 4969.8 4970.8 4978.8 4456.6 4470.5 4490.1 4490.5 4499.0 4471.4 5763.3 5765.0 5786.2 5877.8 6339.5 6350.9 6357.9 6362.2 6385.1 5121.6 5592.7 5809.4 5822.8 5824.9 5377.6 5414.7 5424.5 5426.1 5460.7 6230.7 6297.0 6299.8 6322.2 6406.4 6376.5 6378.3 6384.9 6387.2 6396.5 6228.8 6367.1 6385.9 6394.7 6398.7 5186.7 5718.8 6111.5 6155.1 6179.9 6079.9 6326.6 6349.4 6359.9 6373.4 5078.9 6076.9 6180.7 6189.8 6244.8 6038.0 6090.1 6098.9 6124.9 6202.4 5953.6 6036.2 6064.3 6092.3 6107.2 6192.3 6197.6 6210.5 6212.7 6227.9 5817.7 6000.3 6026.1 6051.7 6058.6 07:55:28 INFO - PROCESS | 1661 | 07:55:28 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:74964.34 Median:38416.52 stddev:168450.76 (438.5%) stddev-sans-first:168830.49 07:55:28 INFO - PROCESS | 1661 | Values: 483.7 516.3 531.0 536.8 551.4 30016.7 38958.2 39995.6 40104.4 40183.6 41758.7 42091.0 42120.8 42185.2 42350.8 8211.5 9859.8 9861.5 9861.9 9885.1 8914.0 9122.6 11956.8 12193.8 12212.9 12187.3 12237.6 12258.2 12276.4 12299.1 8817.1 12208.3 12303.9 12313.3 12317.4 8707.9 11629.2 11936.6 11962.9 12225.4 39858.0 40159.2 40176.8 40182.6 40260.2 3353.1 3418.5 3570.3 3646.3 3938.6 28584.3 29779.1 31212.5 31299.7 31776.7 3075.3 3122.1 3127.6 3269.7 3361.5 530742.0 532274.0 533181.0 533211.0 533886.0 57375.4 57774.1 57798.4 57801.0 57804.4 60114.8 60264.7 60355.7 60446.7 60472.0 16437.4 16688.4 16691.2 16691.5 16699.6 11487.3 11774.5 13075.4 13131.7 13162.8 13474.8 14943.6 15300.3 15345.5 15748.4 5429.9 5981.7 6022.6 6031.2 6047.2 741.9 878.8 882.5 944.0 1017.3 24331.6 28819.3 29275.3 29735.0 29919.0 1021.8 1046.8 1053.1 1064.3 1142.7 14761.5 15273.5 15302.3 15336.9 15665.8 696456.0 703881.0 704070.0 704149.0 704332.0 47980.8 56064.0 57000.0 57142.0 59889.0 1144.0 1390.4 1396.2 1396.9 1401.6 29889.9 31010.7 31130.8 31425.5 31938.2 48086.3 48551.3 48597.5 48723.3 48749.0 636297.0 639356.0 640048.0 641356.0 641927.8 38436.6 38830.8 39222.2 39449.8 39474.4 46249.3 46388.0 46521.3 46894.5 47180.8 38231.4 38338.0 38724.0 39884.0 40065.8 32380.2 38415.0 38418.0 38868.8 39790.4 37376.4 37981.8 38052.6 38140.2 38222.2 32377.5 33633.6 34281.6 34575.5 34803.0 25453.6 25504.4 25537.2 25812.7 26089.5 07:55:28 INFO - PROCESS | 1661 | 07:55:28 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:35482.36 Median:4240.78 stddev:106193.66 (2504.1%) stddev-sans-first:106458.78 07:55:28 INFO - PROCESS | 1661 | Values: 341.0 355.5 371.7 376.4 397.0 14842.9 15258.2 15994.0 20455.0 20809.8 19896.7 19946.7 20546.8 20595.0 20882.3 5308.0 5734.4 5897.9 6022.3 6027.7 5156.5 6614.7 6730.5 6739.8 6740.4 5818.5 6139.4 6666.0 6685.6 6689.9 6150.5 6172.0 6176.8 6178.3 6194.0 5769.4 5957.6 6026.8 6030.8 6038.8 10868.8 12753.6 13004.5 21698.7 23981.0 2169.9 2251.4 2447.0 2456.4 2487.0 8906.7 9194.7 9502.6 9861.3 10207.1 1716.7 1722.4 1818.1 1832.6 1838.2 116234.0 118384.4 123624.4 125678.4 127168.0 10862.6 11236.6 11516.6 11528.9 11685.2 14403.8 14411.3 14421.1 14425.4 14434.8 8313.1 8526.1 8532.4 8619.0 8674.9 8200.0 8509.1 8510.9 8676.5 8683.7 4107.5 4374.1 4460.3 4517.5 4539.6 1569.2 1894.0 1901.8 1910.2 1924.1 811.8 860.9 936.9 971.5 984.6 20193.6 20246.9 20508.8 20516.8 20686.4 895.1 904.4 910.5 920.8 989.2 10291.3 10868.5 10888.4 10912.6 10922.0 626490.0 627790.0 640990.3 644160.0 650644.0 116872.0 120014.0 120723.0 122552.0 125612.0 905.8 949.1 963.0 963.9 966.3 14887.6 17395.5 18158.0 18209.3 18551.4 49944.8 50339.0 52042.0 52341.0 55856.9 75283.5 77273.0 80081.0 80971.6 81122.0 6629.6 7477.0 7601.6 7891.3 7988.2 6995.3 10643.8 11188.6 11878.8 12247.1 10190.1 10243.8 10278.7 10625.6 10730.8 10177.4 10225.1 10407.2 10489.3 10652.7 6494.6 9856.0 10561.8 10611.4 10705.8 6662.7 6851.2 6946.8 7183.8 7636.1 8339.4 9115.4 9855.8 10586.7 10668.0 07:55:28 INFO - PROCESS | 1661 | 07:55:28 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5705.64 Median:4946.76 stddev:3245.13 (65.6%) stddev-sans-first:3237.70 07:55:28 INFO - PROCESS | 1661 | Values: 1346.1 1352.0 1503.3 1568.6 1681.9 7852.3 8394.7 8758.7 8862.6 8873.6 8806.0 8899.9 8913.7 8914.7 8921.3 2377.3 2404.6 2408.0 2412.2 2412.7 2394.2 2416.0 2441.6 2442.3 2442.7 2403.0 2416.9 2422.6 2431.9 2432.3 2365.9 2396.4 2401.0 2404.7 2406.7 2363.9 2390.2 2391.0 2393.1 2395.7 8820.5 8828.0 8839.9 8902.1 8952.4 5267.2 5453.5 5460.6 5474.2 5477.3 3059.0 3614.8 3652.0 3707.6 3717.8 1113.8 1120.1 1122.3 1129.4 1142.4 11884.0 11906.0 11963.6 11972.9 11973.2 4447.4 4523.8 4691.4 4699.0 4710.1 9290.0 9298.5 9305.9 9311.0 9311.3 5285.8 5293.0 5299.7 5301.3 5315.1 4171.8 4449.8 4559.7 4572.2 4956.7 3415.5 3810.6 3860.8 3938.6 3947.0 926.9 1106.4 1149.4 1157.7 1164.1 908.8 928.9 936.0 937.7 942.8 5787.1 5843.9 5960.6 6206.3 6221.4 395.7 428.1 428.6 448.3 448.9 3932.6 4032.7 4079.2 4110.5 4153.7 10506.9 11024.0 11030.7 11049.8 11078.2 10624.5 10975.3 10994.6 10994.9 11002.4 8188.6 8410.4 8412.4 8416.4 8432.6 5785.0 5839.5 5948.4 6052.5 6076.5 9971.9 9983.7 10072.4 10150.8 10207.9 9393.2 10222.0 10475.5 10519.1 10529.2 6580.4 6806.6 6938.0 6969.7 7114.2 8285.0 8305.3 8310.3 8364.1 8394.5 6374.4 7520.8 7551.8 7563.0 7574.8 7193.5 7285.6 7320.9 7323.2 7393.5 6888.4 6973.3 7007.8 7012.6 7024.2 4944.4 4949.2 4979.4 5084.3 5247.1 5047.9 5092.6 5094.2 5143.9 5213.4 07:55:28 INFO - PROCESS | 1661 | 07:55:28 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:4573.29 Median:5144.08 stddev:1400.48 (27.2%) stddev-sans-first:1366.54 07:55:28 INFO - PROCESS | 1661 | Values: 263.7 305.5 306.7 310.7 315.7 4741.4 5365.4 5408.9 5467.5 5490.3 4616.1 4833.3 5313.5 5317.0 5373.2 3839.7 3987.4 4029.4 4036.2 4041.4 3102.6 3653.9 3901.6 3996.2 4186.8 3298.6 3741.0 4080.9 4100.5 4110.7 3954.7 4054.8 4058.8 4101.8 4108.3 2917.8 3538.6 3561.3 3565.7 3566.9 4961.5 5179.8 5192.9 5217.3 5236.3 4229.3 4468.2 4701.0 4733.8 4753.7 5391.5 5652.6 5660.5 5664.3 5668.1 3944.0 3946.6 3953.2 3954.9 3963.0 5010.5 5445.5 6024.8 6033.2 6035.8 3559.9 3963.9 3968.3 3970.7 3975.9 3632.5 3947.7 3976.0 4039.0 4052.7 4081.8 4500.8 4686.2 4707.3 4730.9 4730.9 5545.3 5642.4 5653.7 5733.9 1200.4 1356.2 1372.6 1378.2 1378.8 819.0 888.5 905.4 935.7 941.5 4779.7 4927.2 4987.2 5019.6 5108.3 4965.8 5207.8 5383.0 5858.7 5887.9 4786.4 5213.5 5399.5 5413.5 5416.9 3009.9 3047.2 3053.6 3064.3 3075.9 5100.8 5383.8 6052.9 6063.9 6129.9 4936.0 5807.8 6000.5 6014.7 6037.4 5058.4 5068.8 5079.0 5507.0 6068.9 5392.6 5509.8 5874.3 5877.5 5889.0 5650.3 5733.9 5768.0 5770.3 5822.9 5678.8 5818.4 5996.7 6019.4 6059.8 3810.6 3927.7 3935.8 3936.2 3972.5 4391.0 5823.3 5826.5 5834.2 5863.1 5213.8 5645.2 5694.6 5719.9 5721.9 5275.5 5328.4 5616.7 5631.7 5703.3 5486.5 5523.7 5561.7 5568.9 5570.7 4810.5 5230.0 5439.6 5531.9 5696.0 4967.0 5375.3 5480.9 5514.9 5522.9 07:55:28 INFO - PROCESS | 1661 | 07:55:28 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:24646.87 Median:3731.52 stddev:39527.71 (1059.3%) stddev-sans-first:39597.29 07:55:28 INFO - PROCESS | 1661 | Values: 581.0 720.5 745.0 758.0 796.4 14792.9 16122.6 16133.4 16168.4 16313.2 14468.4 14629.1 14658.6 14663.3 14668.3 672.2 694.0 694.7 695.5 695.7 706.8 832.1 851.8 858.0 869.7 909.8 911.0 914.2 914.4 917.1 900.8 902.5 903.6 905.0 907.2 525.5 544.1 651.8 671.9 673.6 14991.0 15013.0 15026.5 15028.6 15062.6 13667.5 13941.3 14033.8 14083.6 14308.6 12143.1 12602.7 12677.5 12881.8 12899.7 4477.1 4505.9 4645.9 4710.4 4780.5 108115.0 108535.0 108565.4 112892.2 115572.4 9344.4 10469.0 10685.7 10880.7 10913.6 19871.3 22090.9 22182.6 22222.4 22259.9 8041.8 8092.8 8172.2 8188.2 8231.3 4250.0 4341.6 4443.5 4570.1 4660.0 3583.5 3725.6 3731.2 3731.9 3732.4 638.5 661.1 670.1 676.7 685.2 582.6 656.9 672.7 676.7 677.5 8051.8 9476.0 9553.5 9673.8 9727.5 659.4 675.9 677.2 686.9 698.6 4174.5 4521.2 4542.9 4552.2 4711.6 142841.0 146833.5 150669.0 152559.0 154620.0 110771.2 120378.2 124304.0 127201.4 136273.3 104699.0 108220.0 109847.9 111286.0 111908.4 7487.3 8671.8 8849.2 8909.1 8980.8 58089.7 59190.4 61024.8 63498.4 64049.0 87350.1 94648.0 96934.5 98919.5 100301.5 11492.0 11900.5 11966.8 12000.9 12433.1 12849.5 13081.4 13123.6 13188.5 13656.5 11603.3 12119.5 12336.4 12364.8 12809.8 12318.8 12330.1 12372.1 12411.9 12826.6 11950.9 12070.2 12114.1 12123.4 12574.3 9815.7 9869.0 10336.0 10704.5 10832.0 10353.7 10466.7 10723.2 10748.6 10750.5 07:55:28 INFO - PROCESS | 1661 | -------- Summary: end -------- 07:55:28 INFO - PROCESS | 1661 | 07:55:29 INFO - TEST-INFO | 1661: exit 0 07:55:29 INFO - TEST-OK | dromaeo_css | took 1116898ms 07:55:29 INFO - TEST-START | kraken 07:55:29 INFO - operating with platform_type : mac_ 07:55:29 INFO - Initialising browser for kraken test... 07:55:29 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmp8gNPAU/profile http://localhost:49271/getInfo.html) 07:55:31 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 07:55:31 INFO - PROCESS | 1667 | colorDepth:24 07:55:31 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 07:55:31 INFO - PROCESS | 1667 | __metrics 07:55:31 INFO - PROCESS | 1667 | 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" 07:55:31 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:55:32 INFO - TEST-INFO | 1667: exit 0 07:55:32 INFO - Browser initialized. 07:55:32 INFO - Running cycle 1/1 for kraken test... 07:55:32 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmp8gNPAU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:44 INFO - PROCESS | 1668 | RSS: Main: 219516928 07:55:44 INFO - PROCESS | 1668 | 07:55:47 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 07:55:48 INFO - PROCESS | 1668 | RSS: Main: 269123584 07:55:48 INFO - PROCESS | 1668 | 07:55:50 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 07:55:51 INFO - PROCESS | 1668 | RSS: Main: 279232512 07:55:51 INFO - PROCESS | 1668 | 07:55:54 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 07:55:55 INFO - PROCESS | 1668 | RSS: Main: 377315328 07:55:55 INFO - PROCESS | 1668 | 07:55:57 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 07:55:57 INFO - PROCESS | 1668 | RSS: Main: 279797760 07:55:57 INFO - PROCESS | 1668 | 07:55:59 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:56:00 INFO - PROCESS | 1668 | RSS: Main: 281460736 07:56:00 INFO - PROCESS | 1668 | 07:56:02 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 07:56:03 INFO - PROCESS | 1668 | RSS: Main: 318124032 07:56:03 INFO - PROCESS | 1668 | 07:56:06 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:07 INFO - PROCESS | 1668 | RSS: Main: 318414848 07:56:07 INFO - PROCESS | 1668 | 07:56:10 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 07:56:10 INFO - PROCESS | 1668 | RSS: Main: 318230528 07:56:10 INFO - PROCESS | 1668 | 07:56:12 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:12 INFO - PROCESS | 1668 | RSS: Main: 289759232 07:56:12 INFO - PROCESS | 1668 | 07:56:14 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:15 INFO - PROCESS | 1668 | RSS: Main: 295972864 07:56:15 INFO - PROCESS | 1668 | 07:56:17 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:18 INFO - PROCESS | 1668 | RSS: Main: 296976384 07:56:18 INFO - PROCESS | 1668 | 07:56:21 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:21 INFO - PROCESS | 1668 | RSS: Main: 313434112 07:56:21 INFO - PROCESS | 1668 | 07:56:24 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:25 INFO - PROCESS | 1668 | RSS: Main: 309489664 07:56:25 INFO - PROCESS | 1668 | 07:56:27 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 07:56:27 INFO - PROCESS | 1668 | RSS: Main: 353116160 07:56:27 INFO - PROCESS | 1668 | 07:56:27 INFO - PROCESS | 1668 | __start_tp_report 07:56:27 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 07:56:27 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 07:56:27 INFO - PROCESS | 1668 | |i|pagename|runs| 07:56:27 INFO - PROCESS | 1668 | |0;ai-astar;109;112;115;114;114;113;114;111;112;114 07:56:27 INFO - PROCESS | 1668 | |1;audio-beat-detection;144;106;108;141;112;145;130;109;137;109 07:56:27 INFO - PROCESS | 1668 | |2;audio-dft;183;189;221;184;184;183;182;184;184;183 07:56:27 INFO - PROCESS | 1668 | |3;audio-fft;81;59;58;89;64;60;59;57;82;58 07:56:27 INFO - PROCESS | 1668 | |4;audio-oscillator;84;70;95;69;67;70;92;67;68;89 07:56:27 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;87;85;87;85;87;84;88;85;88;84 07:56:27 INFO - PROCESS | 1668 | |6;imaging-darkroom;92;120;150;94;103;97;93;96;93;94 07:56:27 INFO - PROCESS | 1668 | |7;imaging-desaturate;84;84;86;85;90;84;84;101;139;136 07:56:27 INFO - PROCESS | 1668 | |8;json-parse-financial;56;55;53;50;55;55;56;78;88;87 07:56:27 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;69;69;65;75;70;68;68;69;69;70 07:56:27 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;81;85;85;84;87;101;101;85;84;82 07:56:27 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;136;132;136;138;134;139;139;138;203;147 07:56:27 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;163;164;161;162;162;163;163;165;162;159 07:56:27 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;66;68;67;67;67;66;66;67;69;83 07:56:27 INFO - PROCESS | 1668 | __end_tp_report 07:56:27 INFO - PROCESS | 1668 | __start_cc_report 07:56:27 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1988 07:56:27 INFO - PROCESS | 1668 | __end_cc_report 07:56:27 INFO - PROCESS | 1668 | __startTimestamp1475247387358__endTimestamp 07:56:27 INFO - PROCESS | 1668 | 07:56:27 INFO - PROCESS | 1668 | ------- Summary: start ------- 07:56:27 INFO - PROCESS | 1668 | Number of tests: 14 07:56:27 INFO - PROCESS | 1668 | 07:56:27 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:1.81 (1.6%) stddev-sans-first:1.30 07:56:27 INFO - PROCESS | 1668 | Values: 109.0 112.0 115.0 114.0 114.0 113.0 114.0 111.0 112.0 114.0 07:56:27 INFO - PROCESS | 1668 | 07:56:27 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:124.10 Median:133.50 stddev:16.70 (12.5%) stddev-sans-first:16.08 07:56:27 INFO - PROCESS | 1668 | Values: 144.0 106.0 108.0 141.0 112.0 145.0 130.0 109.0 137.0 109.0 07:56:27 INFO - PROCESS | 1668 | 07:56:27 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:187.70 Median:184.00 stddev:11.85 (6.4%) stddev-sans-first:12.45 07:56:27 INFO - PROCESS | 1668 | Values: 183.0 189.0 221.0 184.0 184.0 183.0 182.0 184.0 184.0 183.0 07:56:27 INFO - PROCESS | 1668 | 07:56:27 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:66.70 Median:62.00 stddev:12.26 (19.8%) stddev-sans-first:11.86 07:56:27 INFO - PROCESS | 1668 | Values: 81.0 59.0 58.0 89.0 64.0 60.0 59.0 57.0 82.0 58.0 07:56:27 INFO - PROCESS | 1668 | 07:56:27 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:77.00 stddev:11.47 (14.9%) stddev-sans-first:11.90 07:56:27 INFO - PROCESS | 1668 | Values: 84.0 70.0 95.0 69.0 67.0 70.0 92.0 67.0 68.0 89.0 07:56:27 INFO - PROCESS | 1668 | 07:56:27 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:87.00 stddev:1.56 (1.8%) stddev-sans-first:1.62 07:56:27 INFO - PROCESS | 1668 | Values: 87.0 85.0 87.0 85.0 87.0 84.0 88.0 85.0 88.0 84.0 07:56:27 INFO - PROCESS | 1668 | 07:56:27 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:103.20 Median:93.50 stddev:18.46 (19.7%) stddev-sans-first:19.13 07:56:27 INFO - PROCESS | 1668 | Values: 92.0 120.0 150.0 94.0 103.0 97.0 93.0 96.0 93.0 94.0 07:56:27 INFO - PROCESS | 1668 | 07:56:27 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:84.00 stddev:21.83 (26.0%) stddev-sans-first:22.62 07:56:27 INFO - PROCESS | 1668 | Values: 84.0 84.0 86.0 85.0 90.0 84.0 84.0 101.0 139.0 136.0 07:56:27 INFO - PROCESS | 1668 | 07:56:27 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:56.00 stddev:14.85 (26.5%) stddev-sans-first:15.51 07:56:27 INFO - PROCESS | 1668 | Values: 56.0 55.0 53.0 50.0 55.0 55.0 56.0 78.0 88.0 87.0 07:56:27 INFO - PROCESS | 1668 | 07:56:27 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:2.49 (3.6%) stddev-sans-first:2.64 07:56:27 INFO - PROCESS | 1668 | Values: 69.0 69.0 65.0 75.0 70.0 68.0 68.0 69.0 69.0 70.0 07:56:27 INFO - PROCESS | 1668 | 07:56:27 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:84.50 stddev:7.31 (8.6%) stddev-sans-first:7.36 07:56:27 INFO - PROCESS | 1668 | Values: 81.0 85.0 85.0 84.0 87.0 101.0 101.0 85.0 84.0 82.0 07:56:27 INFO - PROCESS | 1668 | 07:56:27 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:138.50 stddev:21.04 (15.2%) stddev-sans-first:22.10 07:56:27 INFO - PROCESS | 1668 | Values: 136.0 132.0 136.0 138.0 134.0 139.0 139.0 138.0 203.0 147.0 07:56:27 INFO - PROCESS | 1668 | 07:56:27 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:163.00 stddev:1.65 (1.0%) stddev-sans-first:1.73 07:56:27 INFO - PROCESS | 1668 | Values: 163.0 164.0 161.0 162.0 162.0 163.0 163.0 165.0 162.0 159.0 07:56:27 INFO - PROCESS | 1668 | 07:56:27 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:67.00 stddev:5.15 (7.7%) stddev-sans-first:5.37 07:56:27 INFO - PROCESS | 1668 | Values: 66.0 68.0 67.0 67.0 67.0 66.0 66.0 67.0 69.0 83.0 07:56:27 INFO - PROCESS | 1668 | -------- Summary: end -------- 07:56:27 INFO - PROCESS | 1668 | 07:56:28 INFO - TEST-INFO | 1668: exit 0 07:56:28 INFO - TEST-OK | kraken | took 58885ms 07:56:28 INFO - SUITE-END | took 1175s 07:56:28 INFO - Completed test suite (00:19:35) 07:56:28 INFO - javascript benchmark 07:56:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2938.720821521955, 3365.697087262147, 3366.007027926763, 3370.5449764281816, 3462.8961131166056, 5764.077747560391, 5796.07262837946, 5802.941970580293, 5810.535157187425, 5850.561207909408, 5687.516561092312, 5728.79949201778, 5813.2152159458465, 5818.5926985111055, 5825.737841797119, 5237.188235823453, 5284.0, 5302.416734159239, 5305.681659100447, 5346.893062138755, 5248.6063545234065, 5264.736763161845, 5353.812616558421, 5358.437364076774, 5362.624616276843, 5319.547838433718, 5348.545373643245, 5349.251104845324, 5355.812546560871, 5364.5708343332635, 5244.659097158673, 5305.549028332577, 5307.230451584499, 5308.124159513675, 5335.706536140511, 5206.245094461282, 5254.975279820436, 5288.550473209782, 5305.681659100428, 5320.6275560710765, 5792.88414231713, 5825.679587622679, 5883.911741323884, 5892.675902825343, 5901.7934372297195, 6146.416090471398, 6195.132681424604, 6195.938040619581, 6245.313015568284, 6278.058291256302, 6266.937330626681, 6279.968600157015, 6359.236891573041, 6369.235691717024, 6384.106225128486, 5896.498797602209, 5900.924229145164, 5902.380250073724, 5905.261842269716, 5956.047032474783, 6253.249610046732, 6286.717097730613, 6331.303556608769, 6366.522510811707, 6535.052417399451, 6231.875362492725, 6265.0, 6265.8120256392385, 6282.560220784501, 6283.43449089575, 6335.68321583919, 6338.619682819046, 6344.429001389804, 6349.650769207646, 6372.649504277217, 4884.340614017134, 6027.427394397525, 6105.084237364342, 6147.538934579924, 6321.525885558602, 6168.568200225941, 6232.18981532407, 6305.716242769086, 6306.49548036156, 6356.586821856565, 4946.1344264753525, 4957.925631115536, 4969.82605608802, 4970.826021089245, 4978.8257410990445, 4456.64443814555, 4470.530594287618, 4490.079533695584, 4490.483594386622, 4498.955010449919, 4471.35165401015, 5763.279590051244, 5765.019946609086, 5786.1610066540115, 5877.823665290048, 6339.524535659844, 6350.872982540323, 6357.904631430532, 6362.172917520786, 6385.138006369174, 5121.564667003272, 5592.657762137139, 5809.3609702932645, 5822.796202132905, 5824.854378640483, 5377.596680248997, 5414.729263536808, 5424.538914192259, 5426.131818908955, 5460.726963651801, 6230.657313847782, 6296.968515157395, 6299.842503937438, 6322.178116844781, 6406.391392817675, 6376.521760868046, 6378.298387177314, 6384.872302554016, 6387.233531976192, 6396.456301214449, 6228.813135605939, 6367.140436041075, 6385.904211436925, 6394.680265986589, 6398.680065996588, 5186.740662966912, 5718.770464350185, 6111.470193407107, 6155.1075094112, 6179.938200618116, 6079.939200607937, 6326.620402775849, 6349.3650634937985, 6359.872802544016, 6373.3945275198785, 5078.898422031612, 6076.908846367396, 6180.6600636965395, 6189.752409903554, 6244.781432649836, 6038.0, 6090.1169330445955, 6098.878022439438, 6124.930239974474, 6202.379762023762, 5953.58324917269, 6036.215292012186, 6064.272287325549, 6092.294157635869, 6107.226802228232, 6192.318844927145, 6197.566170368031, 6210.503159747119, 6212.720427580679, 6227.906581401192, 5817.650940943557, 6000.309964354155, 6026.096085587022, 6051.667158306159, 6058.606190597597], "value": 5738.95497114822, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.67110364951816, 516.256590509666, 531.0467710459725, 536.8443151486069, 551.3879593651046, 30016.69983300169, 38958.220835583306, 39995.600043999584, 40104.39843402351, 40183.59816401835, 41758.747237582844, 42091.0, 42120.78939605298, 42185.15629687405, 42350.78824605873, 8211.50730956143, 9859.802803943916, 9861.506924653775, 9861.901380986206, 9885.110340069392, 8913.955430222872, 9122.589483473259, 11956.760864782698, 12193.756124877496, 12212.93893530531, 12187.32969686667, 12237.571684991028, 12258.203216790924, 12276.447559859827, 12299.077569182302, 8817.118288171132, 12208.32854193019, 12303.93848030754, 12313.322767247797, 12317.445714942849, 8707.869381959275, 11629.185956983014, 11936.641900742992, 11962.880371196263, 12225.388730563436, 39858.0, 40159.196816063515, 40176.79911600453, 40182.59817401847, 40260.19479610391, 3353.0946644406117, 3418.504316874064, 3570.250247448039, 3646.2889736501393, 3938.586448422903, 28584.28539286514, 29779.10662680123, 31212.46236937776, 31299.687003129904, 31776.682233177602, 3075.3080556874747, 3122.1414111119398, 3127.5934128563367, 3269.6893795089427, 3361.5293858859777, 530742.0, 532274.0, 533181.0, 533211.0, 533886.0, 57375.42624573784, 57774.133387999216, 57798.42201578015, 57801.0, 57804.4219557799, 60114.797704045675, 60264.698676507214, 60355.69822150861, 60446.697766510886, 60472.0, 16437.424690135787, 16688.415905443253, 16691.24889379981, 16691.497765200947, 16699.582510437336, 11487.310761354178, 11774.529018839321, 13075.411606477732, 13131.737365252642, 13162.802557961639, 13474.797878031837, 14943.626409339637, 15300.311485983157, 15345.539633811004, 15748.370065197492, 5429.864253393696, 5981.6710080945095, 6022.638641681513, 6031.155638210654, 6047.183630209954, 741.9443541734391, 878.7934835313696, 882.4528792148781, 943.9946457023249, 1017.2574020964737, 24331.572126407995, 28819.279518011797, 29275.268118297212, 29735.0, 29919.0, 1021.7854250607307, 1046.7906418716134, 1053.1416895230363, 1064.2816099133054, 1142.657202839145, 14761.483348082766, 15273.541793745982, 15302.311395987208, 15336.856867647768, 15665.765013524806, 696456.0, 703881.0, 704070.0, 704149.0, 704332.0, 47980.760096199294, 56064.0, 57000.0, 57142.0, 59889.0, 1143.954241830334, 1390.4299237312653, 1396.2460271453504, 1396.8533304002933, 1401.628568429367, 29889.93554784333, 31010.68989310078, 31130.844345778125, 31425.528617070304, 31938.20154496156, 48086.27870582014, 48551.271730923356, 48597.51402486071, 48723.269150962056, 48749.02501950012, 636297.0, 639356.0, 640048.0, 641356.0, 641927.7903610452, 38436.61563384331, 38830.805845970586, 39222.2155556893, 39449.80275098606, 39474.40788388234, 46249.306260406796, 46388.0, 46521.302180467996, 46894.53105469038, 47180.7640961793, 38231.42652860265, 38338.0, 38724.03189920162, 39884.00289992657, 40065.799671001456, 32380.190495236864, 38415.03962400962, 38418.0, 38868.80565597154, 39790.403143953445, 37376.439353410264, 37981.810090949366, 38052.61947380491, 38140.23719525649, 38222.23555528929, 32377.514337284487, 33633.60961417323, 34281.62873485132, 34575.481367779, 34803.0, 25453.618195726707, 25504.362390940376, 25537.23388298354, 25812.741872581035, 26089.478210436064], "value": 20329.92511817681, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.0365716849899, 355.4792229383952, 371.6970668904844, 376.41843352021135, 396.9960300396995, 14842.925785371071, 15258.237088145605, 15994.040357578539, 20454.977251137458, 20809.791902080975, 19896.70154947677, 19946.70079948802, 20546.794532054675, 20594.970251487404, 20882.269120580782, 5308.044551980642, 5734.369219385854, 5897.941020589804, 6022.307434645006, 6027.668478233695, 5156.53591176794, 6614.669266536654, 6730.49521285903, 6739.764108256212, 6740.359665831738, 5818.5345172386105, 6139.355367686396, 6666.0334251533495, 6685.632290224035, 6689.933100669004, 6150.477209437181, 6171.969140154315, 6176.81469555914, 6178.289496707891, 6194.008958566653, 5769.423057694239, 5957.553183511254, 6026.849328766816, 6030.788922387739, 6038.788642397539, 10868.836967445495, 12753.61739147827, 13004.479820807157, 21698.674519882214, 23981.0, 2169.945751356229, 2251.4371407148215, 2447.0334217983795, 2456.4350199454225, 2486.987565062181, 8906.73279801607, 9194.666773317898, 9502.619895204252, 9861.260405469548, 10207.13239374654, 1716.7167417376243, 1722.3541172060477, 1818.0546116019727, 1832.605989712205, 1838.2187570282576, 116234.0, 118384.40807795992, 123624.38187809003, 125678.37160814229, 127168.0, 10862.619808306672, 11236.606718764804, 11516.596919107791, 11528.942355288169, 11685.18203725748, 14403.78394324086, 14411.279436028366, 14421.062630929166, 14425.350859211361, 14434.783478247835, 8313.12712165226, 8526.147385261424, 8532.402731808714, 8619.0, 8674.913250867537, 8200.0, 8509.10654381281, 8510.872336914952, 8676.522791246416, 8683.739487815375, 4107.486564179478, 4374.081442896963, 4460.330950357472, 4517.525659805673, 4539.614132798683, 1569.2467615544374, 1893.9621207575772, 1901.7812951510753, 1910.2072639854582, 1924.1437560285538, 811.8335741173046, 860.8837806896114, 936.8851067229974, 971.4802580619335, 984.5963155106372, 20193.596128077355, 20246.898765506372, 20508.79491205069, 20516.794832051488, 20686.379408617766, 895.1406649616441, 904.3850181876387, 910.544727636182, 920.8342498350361, 989.2086330935223, 10291.331063480999, 10868.510917008754, 10888.40113793749, 10912.563497460013, 10922.0, 626490.0, 627790.0, 640990.323683436, 644160.0, 650644.0, 116872.0, 120014.0, 120723.0, 122552.0, 125612.0, 905.764501229685, 949.1410273702172, 962.9807403851884, 963.8506031565119, 966.3428868369435, 14887.627809304853, 17395.47813565595, 18158.0, 18209.271629135215, 18551.35070272534, 49944.750276248385, 50339.0, 52042.0, 52341.0, 55856.88286234334, 75283.49433011419, 77273.0, 80081.0, 80971.59514202391, 81122.0, 6629.569078009914, 7477.0, 7601.581912994839, 7891.329237014918, 7988.241117093867, 6995.265497122728, 10643.829178790173, 11188.552457901918, 11878.809627049079, 12247.081468890046, 10190.1338386238, 10243.795124097625, 10278.691639250834, 10625.574977000833, 10730.83903741429, 10177.440240786827, 10225.130863876653, 10407.167426606005, 10489.318194317346, 10652.733681658021, 6494.642794646151, 9855.950720246354, 10561.788764224826, 10611.363318200933, 10705.785884282426, 6662.666866656551, 6851.246362900177, 6946.79159625212, 7183.820404489929, 7636.08366995964, 8339.416240863324, 9115.407498512575, 9855.802883942424, 10586.72385437104, 10668.0], "value": 9202.163966841987, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.0981142634434, 1351.952681656142, 1503.3235044230096, 1568.5608029751666, 1681.8654507639383, 7852.293293603581, 8394.748157555276, 8758.737237882866, 8862.645494180226, 8873.600687969041, 8805.955970220157, 8899.91100088999, 8913.68802091927, 8914.732558023254, 8921.33090018248, 2377.3224630980176, 2404.617345026608, 2408.000679717915, 2412.2401443545314, 2412.7345991940874, 2394.162043284845, 2415.9637605435933, 2441.6093425051995, 2442.3405680466262, 2442.694663167104, 2403.0387844862107, 2416.867072311022, 2422.6002709552904, 2431.890564924574, 2432.3311089450453, 2365.8817059146972, 2396.424858034068, 2400.9879950600134, 2404.7475015123423, 2406.7472915343988, 2363.8581685098948, 2390.2351247600773, 2390.97609023911, 2393.126508824284, 2395.700537432821, 8820.514871682055, 8828.0, 8839.911600883974, 8902.06528314524, 8952.418092823946, 5267.183586544092, 5453.536449401806, 5460.563154947595, 5474.151506516497, 5477.260569823063, 3058.9847050764824, 3614.8373323200517, 3652.0, 3707.6477734615437, 3717.7769333840056, 1113.8162203236457, 1120.137494129524, 1122.3041714137205, 1129.4183495499824, 1142.4173671427548, 11884.049276057895, 11906.0, 11963.581274655433, 11972.940135299355, 11973.221740586834, 4447.3773671685985, 4523.841665541756, 4691.413573303337, 4699.0132072265205, 4710.105080034851, 9290.0, 9298.53507324631, 9305.906940930505, 9310.9757926628, 9311.301652376098, 5285.7621407036, 5293.0472514946905, 5299.655522391032, 5301.284326615934, 5315.096433606296, 4171.791410429466, 4449.7997590108525, 4559.658025648089, 4572.222722137245, 4956.653034287638, 3415.504751811023, 3810.5617853946596, 3860.768353898775, 3938.606139386096, 3947.0, 926.9073092690677, 1106.391484683421, 1149.3621589235306, 1157.739508610556, 1164.0745607242263, 908.8000639859221, 928.8513837785922, 935.9953200233955, 937.6624415210518, 942.7548837302351, 5787.131930210502, 5843.94156058434, 5960.612560183661, 6206.286277078194, 6221.3778622138325, 395.74276720132144, 428.1202129623653, 428.6356596892616, 448.3163176156323, 448.9393931819228, 3932.5870783567884, 4032.717709760347, 4079.204555111725, 4110.547839737626, 4153.68847336451, 10506.947465262778, 11024.0, 11030.731465881367, 11049.834252486218, 11078.169137314733, 10624.468776561142, 10975.28660637056, 10994.560217591366, 10994.945025274823, 11002.449877506093, 8188.631511581993, 8410.411271211078, 8412.411131220755, 8416.410851240476, 8432.620532075949, 5785.016547186904, 5839.474447299764, 5948.405159484017, 6052.515798736179, 6076.483498902643, 9971.850422243817, 9983.650572229937, 10072.446015469219, 10150.847737284093, 10207.948960255448, 9393.248540116638, 10222.0, 10475.52860121281, 10519.053285204369, 10529.157667386744, 6580.374864388067, 6806.6256355900905, 6937.9653101736185, 6969.651517424007, 7114.181869084914, 8285.047219569826, 8305.335573154012, 8310.293625041939, 8364.121767214356, 8394.496330220207, 6374.362563743589, 7520.811979700551, 7551.773446796605, 7563.016807814949, 7574.81062973408, 7193.5324203926575, 7285.62250036117, 7320.853582928418, 7323.231060738759, 7393.482456228013, 6888.448924085961, 6973.302669732986, 7007.789766307019, 7012.579245245098, 7024.227334993045, 4944.3572335596145, 4949.158643030765, 4979.377577802775, 5084.2881996521255, 5247.107991641354, 5047.949520504748, 5092.567131793839, 5094.2358646203365, 5143.871403214949, 5213.374395072616], "value": 4488.943003956586, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [263.7468030690537, 305.45323870272216, 306.7362068620986, 310.65051816706193, 315.6858925369258, 4741.3836201293825, 5365.382980957191, 5408.945910540893, 5467.535259502942, 5490.313710786152, 4616.122936642036, 4833.275008748689, 5313.546194973269, 5317.0, 5373.220882971967, 3839.692824574034, 3987.421823835542, 4029.4157347184787, 4036.233115708006, 4041.3533834586474, 3102.5966624338803, 3653.9489526245616, 3901.590333015035, 3996.161765587833, 4186.769727664992, 3298.6371499135075, 3740.971232910944, 4080.8575497863562, 4100.487439070116, 4110.712250142491, 3954.7033972451895, 4054.8378064877515, 4058.817353219112, 4101.794910254475, 4108.342665173588, 2917.7519910807396, 3538.610752817188, 3561.2521370512222, 3565.7001234204054, 3566.892993210208, 4961.5286547777905, 5179.818706345298, 5192.948070519285, 5217.330454254602, 5236.319278493771, 4229.281022226229, 4468.173387923244, 4700.976495117537, 4733.763311834395, 4753.714777113384, 5391.514763671288, 5652.632578882401, 5660.5471562274915, 5664.291963504562, 5668.121441176624, 3943.960560394388, 3946.644801967837, 3953.1815364932168, 3954.940675889864, 3962.960370396288, 5010.498950104997, 5445.50990410865, 6024.759009639609, 6033.185519954794, 6035.758569657209, 3559.875404360835, 3963.920721585552, 3968.3253846846105, 3970.68234541236, 3975.920481590352, 3632.5277713897026, 3947.743396679207, 3976.005998500375, 4039.0, 4052.723392131469, 4081.795910204478, 4500.842470513517, 4686.203345431285, 4707.31743897133, 4730.88172795676, 4730.864592497775, 5545.306836645419, 5642.351129620064, 5653.689047102366, 5733.910556994158, 1200.39980009995, 1356.19984209315, 1372.6499742565582, 1378.2144177818748, 1378.7862881253423, 818.9590520473953, 888.5290795878195, 905.4024343932973, 935.6584846530967, 941.5480569326625, 4779.713217206979, 4927.162382395001, 4987.202047672355, 5019.623528235397, 5108.335916330853, 4965.751712414365, 5207.765650545734, 5382.973085134549, 5858.681796595732, 5887.852803679943, 4786.401699787527, 5213.478652134756, 5399.460053994648, 5413.512783849394, 5416.864578385493, 3009.9247518812203, 3047.2229581456586, 3053.6030316059214, 3064.341166649181, 3075.876964921378, 5100.846974590768, 5383.757730902119, 6052.909206361908, 6063.938810708109, 6129.938700612936, 4935.950640493549, 5807.818370773037, 6000.549958753111, 6014.729337179838, 6037.396260374016, 5058.367704036996, 5068.847934561969, 5078.984203159383, 5506.972465137648, 6068.939310606926, 5392.595555333287, 5509.787846673726, 5874.265716785402, 5877.471027607536, 5889.0, 5650.29371328584, 5733.913991290217, 5768.0, 5770.3364113125845, 5822.94177058241, 5678.77284908599, 5818.44724751148, 5996.730147143477, 6019.428154325332, 6059.848503787264, 3810.5998870118237, 3927.743122200868, 3935.803209839439, 3936.2324346752107, 3972.483577134954, 4390.990072283329, 5823.301203855564, 5826.514238869061, 5834.212381328466, 5863.061910094364, 5213.765380557808, 5645.193538067779, 5694.629849059798, 5719.885602287848, 5721.914171287351, 5275.498827611371, 5328.387235467971, 5616.747246374005, 5631.6902570359025, 5703.287089113861, 5486.451354864482, 5523.6685798852195, 5561.749721262472, 5568.939492387843, 5570.69088764132, 4810.494898035656, 5229.980153870111, 5439.600249843847, 5531.917021244604, 5695.971520142372, 4967.0065986802065, 5375.3280839895015, 5480.890382192413, 5514.876772442558, 5522.889542209214], "value": 4124.256232664403, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.9680467574284, 720.5460559847297, 744.9776506704801, 757.9691619397619, 796.4004277695367, 14792.926035369821, 16122.596935076599, 16133.43532976346, 16168.434104806349, 16313.184340782958, 14468.421263149461, 14629.122252664847, 14658.63353416165, 14663.266836658151, 14668.26658667065, 672.1732269308741, 694.035290945586, 694.6908625661582, 695.544418405945, 695.7495301691387, 706.7561691216522, 832.1137988042746, 851.812601227732, 858.0218550852034, 869.7390782765177, 909.8043920557079, 910.9524047345573, 914.1863741270275, 914.401067300919, 917.0783362720457, 900.7883147460342, 902.4900930974012, 903.5798353765498, 904.9819003619891, 907.1971305394708, 525.5401523666792, 544.1402583917401, 651.7881688451225, 671.942884854788, 673.592476551689, 14991.0, 15013.024153429991, 15026.549203523911, 15028.624284392869, 15062.623434414227, 13667.453301867914, 13941.302934853318, 14033.78949315761, 14083.577492675236, 14308.57074287773, 12143.149979501439, 12602.684932876751, 12677.492900283978, 12881.825981125698, 12899.742005159938, 4477.082198149405, 4505.864824055284, 4645.86062418128, 4710.4347478302825, 4780.545848144421, 108115.0, 108535.0, 108565.37151942727, 112892.22646641228, 115572.42213788877, 9344.439333640003, 10468.979791927562, 10685.679429617125, 10880.727981800519, 10913.618023369145, 19871.30450434228, 22090.88954555217, 22182.55634887293, 22222.444438889157, 22259.888700556716, 8041.798955026171, 8092.8381432371025, 8172.18278172178, 8188.222118898695, 8231.259186673109, 4249.957500425018, 4341.60925516705, 4443.533428989909, 4570.085982803453, 4660.04469083837, 3583.5341405617105, 3725.646063624006, 3731.1791405890663, 3731.869384571527, 3732.42147467143, 638.4860187548975, 661.1372159332118, 670.1154476091609, 676.7326905872153, 685.1880521581942, 582.5921854701726, 656.9146011018632, 672.6838385958591, 676.6650507998473, 677.4580335731396, 8051.838963220703, 9475.952620236854, 9553.522323883779, 9673.806523869483, 9727.513624318897, 659.446065305146, 675.93240675933, 677.1907570453261, 686.8900975843941, 698.5948150072945, 4174.519930208005, 4521.163584736769, 4542.909141817145, 4552.180607490617, 4711.599514041345, 142841.0, 146833.53166468412, 150669.0, 152559.0, 154620.0, 110771.20899494516, 120378.19432708516, 124304.0, 127201.36399317945, 136273.3186334062, 104699.0, 108220.0, 109847.90152098537, 111286.0, 111908.44045779719, 7487.3261406473675, 8671.783205419915, 8849.247813935888, 8909.064548222343, 8980.775480612776, 58089.709551451975, 59190.37691419308, 61024.77950441055, 63498.36501635109, 64049.0, 87350.1264987342, 94648.0, 96934.51532742291, 98919.53781617609, 100301.49849250707, 11492.0, 11900.464479098287, 11966.760664786829, 12000.879991199976, 12433.12968092225, 12849.494348601933, 13081.411336490071, 13123.60629181126, 13188.472461101832, 13656.453741850215, 11603.303801771583, 12119.454624542093, 12336.444859981142, 12364.81452778227, 12809.807852882028, 12318.753624927273, 12330.136890417944, 12372.13395062337, 12411.875881241072, 12826.61520154397, 11950.940245298718, 12070.215435996632, 12114.091443141975, 12123.393830308625, 12574.30841303737, 9815.705528834147, 9868.950655246677, 10336.0, 10704.464776761286, 10832.025117739442, 10353.741156470847, 10466.68599942003, 10723.19576031785, 10748.570057197625, 10750.51622676997], "value": 7698.127995944869, "unit": "score"}], "name": "dromaeo_css", "value": 7313.579207563513, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 115.0, 114.0, 114.0, 113.0, 114.0, 111.0, 112.0, 114.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 106.0, 108.0, 141.0, 112.0, 145.0, 130.0, 109.0, 137.0, 109.0], "value": 124.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 189.0, 221.0, 184.0, 184.0, 183.0, 182.0, 184.0, 184.0, 183.0], "value": 187.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 89.0, 64.0, 60.0, 59.0, 57.0, 82.0, 58.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 95.0, 69.0, 67.0, 70.0, 92.0, 67.0, 68.0, 89.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 85.0, 87.0, 84.0, 88.0, 85.0, 88.0, 84.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 120.0, 150.0, 94.0, 103.0, 97.0, 93.0, 96.0, 93.0, 94.0], "value": 103.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 85.0, 90.0, 84.0, 84.0, 101.0, 139.0, 136.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 53.0, 50.0, 55.0, 55.0, 56.0, 78.0, 88.0, 87.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 65.0, 75.0, 70.0, 68.0, 68.0, 69.0, 69.0, 70.0], "value": 69.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 85.0, 84.0, 87.0, 101.0, 101.0, 85.0, 84.0, 82.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 136.0, 138.0, 134.0, 139.0, 139.0, 138.0, 203.0, 147.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 161.0, 162.0, 162.0, 163.0, 163.0, 165.0, 162.0, 159.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0, 69.0, 83.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1450.1000000000001, "alertThreshold": 2.0}]} 07:56:28 INFO - Return code: 0 07:56:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:56:28 INFO - # TBPL SUCCESS # 07:56:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:56:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:56:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:56:28 INFO - 2016-09-30 07:56:28.648 screenresolution[1672:10341] starting screenresolution argv=screenresolution get 07:56:28 INFO - 2016-09-30 07:56:28.651 screenresolution[1672:10341] Display 0: 1600x1200x32@60 07:56:28 INFO - 2016-09-30 07:56:28.658 screenresolution[1673:10344] starting screenresolution argv=screenresolution list 07:56:28 INFO - Available Modes on Display 0 07:56:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:56:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:56:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:56:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:56:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:56:28 INFO - Intel Iris: 07:56:28 INFO - Chipset Model: Intel Iris 07:56:28 INFO - Type: GPU 07:56:28 INFO - Bus: Built-In 07:56:28 INFO - VRAM (Dynamic, Max): 1536 MB 07:56:28 INFO - Vendor: Intel (0x8086) 07:56:28 INFO - Device ID: 0x0a2e 07:56:28 INFO - Revision ID: 0x0009 07:56:28 INFO - Displays: 07:56:28 INFO - Display: 07:56:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:56:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:56:28 INFO - Display Serial Number: 1600x1200 60 07:56:28 INFO - Main Display: Yes 07:56:28 INFO - Mirror: Off 07:56:28 INFO - Online: Yes 07:56:28 INFO - Rotation: Supported 07:56:28 INFO - Return code: 0 07:56:28 INFO - Running post-action listener: _resource_record_post_action 07:56:28 INFO - [mozharness: 2016-09-30 14:56:28.895331Z] Finished run-tests step (success) 07:56:28 INFO - Running post-run listener: _resource_record_post_run 07:56:28 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 33065984; Write bytes: 663723008; Read time: 315; Write time: 1836 07:56:28 INFO - TinderboxPrint: CPU usage
53.4% 07:56:28 INFO - TinderboxPrint: I/O read bytes / time
33,065,984 / 315 07:56:28 INFO - TinderboxPrint: I/O write bytes / time
663,723,008 / 1,836 07:56:28 INFO - TinderboxPrint: CPU idle
2,256.5 (46.6%) 07:56:28 INFO - TinderboxPrint: CPU system
966.1 (20.0%) 07:56:28 INFO - TinderboxPrint: CPU user
1,615.0 (33.4%) 07:56:28 INFO - TinderboxPrint: Swap in / out
392,413,184 / 0 07:56:28 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 358167040; Write bytes: 356825088; Read time: 27698; Write time: 704 07:56:28 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 31091712; Write bytes: 295773184; Read time: 293; Write time: 1094 07:56:29 INFO - Running post-run listener: _upload_blobber_files 07:56:29 INFO - Blob upload gear active. 07:56:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:56:29 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 07:56:29 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'] 07:56:29 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 07:56:29 INFO - (blobuploader) - INFO - Open directory for files ... 07:56:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:56:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:56:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:30 INFO - (blobuploader) - INFO - Done attempting. 07:56:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:56:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:56:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:31 INFO - (blobuploader) - INFO - Done attempting. 07:56:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:56:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:56:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:39 INFO - (blobuploader) - INFO - Done attempting. 07:56:39 INFO - (blobuploader) - INFO - Iteration through files over. 07:56:39 INFO - Return code: 0 07:56:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:56:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:56:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/afb9d0e7de1fb68d13fb77bb155eafece83f4aa87f132edcabb0837d7c977997d69107fe6e2259e9031ab8505fe041bb8faf8cb4433cc729b440f393fa58c504", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c73c45aa5d29c5b23d1d286dba2497fcc072015c8f1f56414ca74956b22a33d83fbbbfef08dffd2127d7ad538d58774d409e173f3d0764b938760fa94976ba3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46f370805e481e16d60a6770ca39cfe374dc1db33f43ea20db4351f9a900c41b58dfe94518e5e6b3ab6c365a85a4fc9369dad7fd28ab0a12681b45659489c1b5"} 07:56:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:56:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:56:39 INFO - Contents: 07:56:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/afb9d0e7de1fb68d13fb77bb155eafece83f4aa87f132edcabb0837d7c977997d69107fe6e2259e9031ab8505fe041bb8faf8cb4433cc729b440f393fa58c504", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c73c45aa5d29c5b23d1d286dba2497fcc072015c8f1f56414ca74956b22a33d83fbbbfef08dffd2127d7ad538d58774d409e173f3d0764b938760fa94976ba3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46f370805e481e16d60a6770ca39cfe374dc1db33f43ea20db4351f9a900c41b58dfe94518e5e6b3ab6c365a85a4fc9369dad7fd28ab0a12681b45659489c1b5"} 07:56:39 INFO - Running post-run listener: copy_logs_to_upload_dir 07:56:39 INFO - Copying logs to upload dir... 07:56:39 INFO - mkdir: /builds/slave/test/build/upload/logs 07:56:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.748761 ========= master_lag: 0.68 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-09-30 07:56:39.772925) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 17 secs) (at 2016-09-30 07:56:39.778703) ========= 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.NOctr2xlSG/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.Zp8E3jjDo0/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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/afb9d0e7de1fb68d13fb77bb155eafece83f4aa87f132edcabb0837d7c977997d69107fe6e2259e9031ab8505fe041bb8faf8cb4433cc729b440f393fa58c504", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c73c45aa5d29c5b23d1d286dba2497fcc072015c8f1f56414ca74956b22a33d83fbbbfef08dffd2127d7ad538d58774d409e173f3d0764b938760fa94976ba3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46f370805e481e16d60a6770ca39cfe374dc1db33f43ea20db4351f9a900c41b58dfe94518e5e6b3ab6c365a85a4fc9369dad7fd28ab0a12681b45659489c1b5"} build_url:https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009816 build_url: 'https://queue.taskcluster.net/v1/task/Gamubk4LT-iG8N5pkdse6g/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/afb9d0e7de1fb68d13fb77bb155eafece83f4aa87f132edcabb0837d7c977997d69107fe6e2259e9031ab8505fe041bb8faf8cb4433cc729b440f393fa58c504", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c73c45aa5d29c5b23d1d286dba2497fcc072015c8f1f56414ca74956b22a33d83fbbbfef08dffd2127d7ad538d58774d409e173f3d0764b938760fa94976ba3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/46f370805e481e16d60a6770ca39cfe374dc1db33f43ea20db4351f9a900c41b58dfe94518e5e6b3ab6c365a85a4fc9369dad7fd28ab0a12681b45659489c1b5"}' ========= master_lag: 17.54 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 17 secs) (at 2016-09-30 07:56:57.332868) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-09-30 07:56:57.333439) ========= 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.NOctr2xlSG/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.Zp8E3jjDo0/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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.005249 ========= master_lag: 5.00 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-09-30 07:57:02.338729) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 07:57:02.339050) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 07:57:02.340936) ========= ========= Total master_lag: 23.31 =========