builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0123 starttime: 1482164386.91 results: success (0) buildid: 20161219070438 builduid: 0f955e9ab14746ee9cbcc4218ead8e09 revision: d4b3146a5567a7ddbcdfa5244945db55616cb8d1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 08:19:46.906623) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 08:19:46.907064) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 08:19:46.907433) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 08:19:46.934468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 08:19:46.934877) ========= 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.LTN5OYCo12/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.6ycGZV5GUC/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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-12-19 08:19:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.0M=0.001s 2016-12-19 08:19:47 (13.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.194322 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 08:19:47.155016) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 08:19:47.155325) ========= 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.LTN5OYCo12/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.6ycGZV5GUC/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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.027129 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 08:19:47.208416) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-19 08:19:47.208882) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d4b3146a5567a7ddbcdfa5244945db55616cb8d1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d4b3146a5567a7ddbcdfa5244945db55616cb8d1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LTN5OYCo12/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.6ycGZV5GUC/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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-12-19 08:19:47,303 truncating revision to first 12 chars 2016-12-19 08:19:47,303 Setting DEBUG logging. 2016-12-19 08:19:47,303 attempt 1/10 2016-12-19 08:19:47,303 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d4b3146a5567?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-19 08:19:48,433 unpacking tar archive at: mozilla-central-d4b3146a5567/testing/mozharness/ program finished with exit code 0 elapsedTime=1.992756 ========= master_lag: 0.77 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-19 08:19:49.974449) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 08:19:49.974848) ========= script_repo_revision: d4b3146a5567a7ddbcdfa5244945db55616cb8d1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 08:19:49.975268) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 08:19:49.975535) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 08:19:50.147816) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-12-19 08:19:50.148175) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LTN5OYCo12/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.6ycGZV5GUC/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:19:50 INFO - MultiFileLogger online at 20161219 08:19:50 in /builds/slave/test 08:19:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:19:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:19:50 INFO - {'append_to_log': False, 08:19:50 INFO - 'base_work_dir': '/builds/slave/test', 08:19:50 INFO - 'blob_upload_branch': 'Firefox', 08:19:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:19:50 INFO - 'branch': 'Firefox', 08:19:50 INFO - 'buildbot_json_path': 'buildprops.json', 08:19:50 INFO - 'config_files': ('talos/mac_config.py',), 08:19:50 INFO - 'default_actions': ('clobber', 08:19:50 INFO - 'read-buildbot-config', 08:19:50 INFO - 'download-and-extract', 08:19:50 INFO - 'populate-webroot', 08:19:50 INFO - 'create-virtualenv', 08:19:50 INFO - 'install', 08:19:50 INFO - 'run-tests'), 08:19:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:19:50 INFO - 'download_minidump_stackwalk': True, 08:19:50 INFO - 'download_symbols': 'ondemand', 08:19:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:19:50 INFO - 'tooltool.py': '/tools/tooltool.py', 08:19:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:19:50 INFO - '/tools/misc-python/virtualenv.py')}, 08:19:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:19:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:19:50 INFO - 'installer_path': 'installer.exe', 08:19:50 INFO - 'log_level': 'info', 08:19:50 INFO - 'log_name': 'talos', 08:19:50 INFO - 'log_to_console': True, 08:19:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:19:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:19:50 INFO - 'opt_config_files': (), 08:19:50 INFO - 'pip_index': False, 08:19:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:19:50 INFO - 'cmd': ('bash', 08:19:50 INFO - '-c', 08:19:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:19:50 INFO - 'enabled': True, 08:19:50 INFO - 'halt_on_failure': False, 08:19:50 INFO - 'name': 'check_screen_resolution'},), 08:19:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:19:50 INFO - 'cmd': ('bash', 08:19:50 INFO - '-c', 08:19:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:19:50 INFO - 'enabled': True, 08:19:50 INFO - 'halt_on_failure': False, 08:19:50 INFO - 'name': 'check_screen_resolution'},), 08:19:50 INFO - 'run_cmd_checks_enabled': True, 08:19:50 INFO - 'sps_profile': False, 08:19:50 INFO - 'sps_profile_interval': 0, 08:19:50 INFO - 'suite': 'dromaeojs', 08:19:50 INFO - 'system_bits': '32', 08:19:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:19:50 INFO - 'title': 't-yosemite-r7-0123', 08:19:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:19:50 INFO - 'use_talos_json': True, 08:19:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:19:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:19:50 INFO - 'work_dir': 'build'} 08:19:50 INFO - [mozharness: 2016-12-19 16:19:50.358901Z] Running clobber step. 08:19:50 INFO - Running pre-action listener: _resource_record_pre_action 08:19:50 INFO - Running main action method: clobber 08:19:50 INFO - rmtree: /builds/slave/test/build 08:19:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:19:52 INFO - Running post-action listener: _resource_record_post_action 08:19:52 INFO - [mozharness: 2016-12-19 16:19:52.853908Z] Finished clobber step (success) 08:19:52 INFO - [mozharness: 2016-12-19 16:19:52.854040Z] Running read-buildbot-config step. 08:19:52 INFO - Running pre-action listener: _resource_record_pre_action 08:19:52 INFO - Running main action method: read_buildbot_config 08:19:52 INFO - Using buildbot properties: 08:19:52 INFO - { 08:19:52 INFO - "project": "", 08:19:52 INFO - "product": "firefox", 08:19:52 INFO - "script_repo_revision": "production", 08:19:52 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:19:52 INFO - "repository": "", 08:19:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:19:52 INFO - "buildid": "20161219070438", 08:19:52 INFO - "pgo_build": "False", 08:19:52 INFO - "basedir": "/builds/slave/test", 08:19:52 INFO - "buildnumber": 13, 08:19:52 INFO - "slavename": "t-yosemite-r7-0123", 08:19:52 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:19:52 INFO - "platform": "yosemite_r7", 08:19:52 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:19:52 INFO - "branch": "mozilla-central", 08:19:52 INFO - "repo_path": "mozilla-central", 08:19:52 INFO - "revision": "d4b3146a5567a7ddbcdfa5244945db55616cb8d1", 08:19:52 INFO - "stage_platform": "macosx64", 08:19:52 INFO - "builduid": "0f955e9ab14746ee9cbcc4218ead8e09", 08:19:52 INFO - "slavebuilddir": "test" 08:19:52 INFO - } 08:19:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 08:19:52 INFO - Running post-action listener: _resource_record_post_action 08:19:52 INFO - [mozharness: 2016-12-19 16:19:52.857387Z] Finished read-buildbot-config step (success) 08:19:52 INFO - [mozharness: 2016-12-19 16:19:52.857516Z] Running download-and-extract step. 08:19:52 INFO - Running pre-action listener: _resource_record_pre_action 08:19:52 INFO - Running main action method: download_and_extract 08:19:52 INFO - mkdir: /builds/slave/test/build/tests 08:19: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')]} 08:19:52 INFO - trying https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 08:19:52 INFO - Downloading https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:19:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 08:19:54 INFO - Downloaded 1199 bytes. 08:19:54 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:19:54 INFO - Using the following test package requirements: 08:19:54 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:19:54 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:19:54 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 08:19:54 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:19:54 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 08:19:54 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:19:54 INFO - u'jsshell-mac.zip'], 08:19:54 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:19:54 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 08:19:54 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:19:54 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:19:54 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 08:19:54 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:19:54 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 08:19:54 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:19:54 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 08:19:54 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:19:54 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 08:19:54 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:19:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:19:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:19:54 INFO - Fetch https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:19:55 INFO - Expected file size: 16276089 08:19:55 INFO - Obtained file size: 16276089 08:20:01 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:20:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:20:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:20:01 INFO - Fetch https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:20:02 INFO - Expected file size: 16276089 08:20:02 INFO - Obtained file size: 16276089 08:20:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 08:20:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:20:09 INFO - Fetch https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 08:20:10 INFO - Expected file size: 14409734 08:20:10 INFO - Obtained file size: 14409734 08:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:11 INFO - trying https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:20:11 INFO - Downloading https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 08:20:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 08:20:13 INFO - Downloaded 69556187 bytes. 08:20:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:20:13 INFO - mkdir: /builds/slave/test/properties 08:20:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:20:13 INFO - Writing to file /builds/slave/test/properties/build_url 08:20:13 INFO - Contents: 08:20:13 INFO - build_url:https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:20:13 INFO - Running post-action listener: _resource_record_post_action 08:20:13 INFO - Running post-action listener: set_extra_try_arguments 08:20:13 INFO - [mozharness: 2016-12-19 16:20:13.985131Z] Finished download-and-extract step (success) 08:20:13 INFO - [mozharness: 2016-12-19 16:20:13.985285Z] Running populate-webroot step. 08:20:13 INFO - Running pre-action listener: _resource_record_pre_action 08:20:13 INFO - Running main action method: populate_webroot 08:20:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:20:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:20:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:20:13 INFO - '--tppagecycles', 08:20:13 INFO - '7'], 08:20:13 INFO - 'tests': ['tsvgm']}}, 08:20:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:20:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:20:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:20:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:20:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:20:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:20:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:20:13 INFO - 'talos_options': ['--disable-e10s'], 08:20:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:20:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:20:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:20:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:20:13 INFO - 'talos_options': ['--disable-e10s'], 08:20:13 INFO - 'tests': ['damp', 'tps']}, 08:20:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:20:13 INFO - 'tests': ['damp', 'tps']}, 08:20:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:20:13 INFO - 'tests': ['dromaeo_dom']}, 08:20:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:20:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:20:13 INFO - 'tests': ['basic_compositor_video']}, 08:20:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:20:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:20:13 INFO - 'tests': ['a11yr', 08:20:13 INFO - 'ts_paint', 08:20:13 INFO - 'tpaint', 08:20:13 INFO - 'sessionrestore', 08:20:13 INFO - 'sessionrestore_no_auto_restore', 08:20:13 INFO - 'tabpaint']}, 08:20:13 INFO - 'other-e10s': {'tests': ['a11yr', 08:20:13 INFO - 'ts_paint', 08:20:13 INFO - 'tpaint', 08:20:13 INFO - 'sessionrestore', 08:20:13 INFO - 'sessionrestore_no_auto_restore', 08:20:13 INFO - 'tabpaint']}, 08:20:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:20:13 INFO - 'ts_paint', 08:20:13 INFO - 'tpaint', 08:20:13 INFO - 'sessionrestore', 08:20:13 INFO - 'sessionrestore_no_auto_restore', 08:20:13 INFO - 'tabpaint']}, 08:20:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:20:13 INFO - 'ts_paint', 08:20:13 INFO - 'tpaint', 08:20:13 INFO - 'sessionrestore', 08:20:13 INFO - 'sessionrestore_no_auto_restore', 08:20:13 INFO - 'tabpaint']}, 08:20:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:20:13 INFO - 'tests': ['a11yr', 08:20:13 INFO - 'ts_paint', 08:20:13 INFO - 'tpaint', 08:20:13 INFO - 'sessionrestore', 08:20:13 INFO - 'sessionrestore_no_auto_restore', 08:20:13 INFO - 'tabpaint']}, 08:20:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:20:14 INFO - 'tests': ['a11yr', 08:20:14 INFO - 'ts_paint', 08:20:14 INFO - 'tpaint', 08:20:14 INFO - 'sessionrestore', 08:20:14 INFO - 'sessionrestore_no_auto_restore', 08:20:14 INFO - 'tabpaint']}, 08:20:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:20:14 INFO - 'tests': ['tsvgx', 08:20:14 INFO - 'tsvgr_opacity', 08:20:14 INFO - 'tart', 08:20:14 INFO - 'tscrollx', 08:20:14 INFO - 'cart', 08:20:14 INFO - 'tsvg_static']}, 08:20:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:20:14 INFO - 'tsvgr_opacity', 08:20:14 INFO - 'tart', 08:20:14 INFO - 'tscrollx', 08:20:14 INFO - 'cart', 08:20:14 INFO - 'tsvg_static']}, 08:20:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:20:14 INFO - 'talos_options': ['--disable-e10s'], 08:20:14 INFO - 'tests': ['tp5o']}, 08:20:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:20:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:20:14 INFO - 'talos_options': ['--disable-e10s', 08:20:14 INFO - '--xperf_path', 08:20:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:20:14 INFO - 'tests': ['tp5n']}, 08:20:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:20:14 INFO - 'talos_options': ['--xperf_path', 08:20:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:20:14 INFO - 'tests': ['tp5n']}}, 08:20:14 INFO - 'talos.zip': {'path': '', 08:20:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:20:14 INFO - Running post-action listener: _resource_record_post_action 08:20:14 INFO - [mozharness: 2016-12-19 16:20:14.003873Z] Finished populate-webroot step (success) 08:20:14 INFO - [mozharness: 2016-12-19 16:20:14.004009Z] Running create-virtualenv step. 08:20:14 INFO - Running pre-action listener: _resource_record_pre_action 08:20:14 INFO - Running main action method: create_virtualenv 08:20:14 INFO - Creating virtualenv /builds/slave/test/build/venv 08:20:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:20:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:20:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:20:14 INFO - Using real prefix '/tools/python27' 08:20:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:20:14 INFO - Installing distribute.............................................................................................................................................................................................done. 08:20:17 INFO - Installing pip.................done. 08:20:17 INFO - Return code: 0 08:20:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:20:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:20:17 INFO - Reading from file tmpfile_stdout 08:20:17 INFO - Output received: 08:20:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:20:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105359b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10535c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c8d92170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105137d30>, '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 0x10505edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10512cbe8>, '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.LTN5OYCo12/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.6ycGZV5GUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:20:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:20:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LTN5OYCo12/Render', 08:20:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:17 INFO - 'HOME': '/Users/cltbld', 08:20:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:17 INFO - 'LOGNAME': 'cltbld', 08:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:17 INFO - 'MOZ_NO_REMOTE': '1', 08:20:17 INFO - 'NO_EM_RESTART': '1', 08:20:17 INFO - 'PAGER': '/bin/cat', 08:20:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:17 INFO - 'PWD': '/builds/slave/test', 08:20:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:17 INFO - 'SHELL': '/bin/bash', 08:20:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ycGZV5GUC/Listeners', 08:20:17 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 08:20:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:17 INFO - 'USER': 'cltbld', 08:20:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:17 INFO - 'XPC_FLAGS': '0x0', 08:20:17 INFO - 'XPC_SERVICE_NAME': '0', 08:20:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:20:18 INFO - Cleaning up... 08:20:18 INFO - Return code: 0 08:20:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:20: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')]} 08:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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')]} 08:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:18 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 0x105359b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10535c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c8d92170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105137d30>, '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 0x10505edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10512cbe8>, '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.LTN5OYCo12/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.6ycGZV5GUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:20:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:20:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LTN5OYCo12/Render', 08:20:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:18 INFO - 'HOME': '/Users/cltbld', 08:20:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:18 INFO - 'LOGNAME': 'cltbld', 08:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:18 INFO - 'MOZ_NO_REMOTE': '1', 08:20:18 INFO - 'NO_EM_RESTART': '1', 08:20:18 INFO - 'PAGER': '/bin/cat', 08:20:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:18 INFO - 'PWD': '/builds/slave/test', 08:20:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:18 INFO - 'SHELL': '/bin/bash', 08:20:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ycGZV5GUC/Listeners', 08:20:18 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 08:20:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:18 INFO - 'USER': 'cltbld', 08:20:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:18 INFO - 'XPC_FLAGS': '0x0', 08:20:18 INFO - 'XPC_SERVICE_NAME': '0', 08:20:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:18 INFO - Downloading/unpacking psutil>=3.1.1 08:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:20:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:20:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:20:21 INFO - Installing collected packages: psutil 08:20:21 INFO - Running setup.py install for psutil 08:20:22 INFO - building 'psutil._psutil_osx' extension 08:20:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:20:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:20:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:20:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:20:22 INFO - building 'psutil._psutil_posix' extension 08:20:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:20:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:20:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:20:22 INFO - ^ 08:20:22 INFO - 1 warning generated. 08:20:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:20:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:20:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:20:23 INFO - Successfully installed psutil 08:20:23 INFO - Cleaning up... 08:20:23 INFO - Return code: 0 08:20:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105359b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10535c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c8d92170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105137d30>, '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 0x10505edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10512cbe8>, '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.LTN5OYCo12/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.6ycGZV5GUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:20:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LTN5OYCo12/Render', 08:20:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:23 INFO - 'HOME': '/Users/cltbld', 08:20:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:23 INFO - 'LOGNAME': 'cltbld', 08:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:23 INFO - 'MOZ_NO_REMOTE': '1', 08:20:23 INFO - 'NO_EM_RESTART': '1', 08:20:23 INFO - 'PAGER': '/bin/cat', 08:20:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:23 INFO - 'PWD': '/builds/slave/test', 08:20:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:23 INFO - 'SHELL': '/bin/bash', 08:20:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ycGZV5GUC/Listeners', 08:20:23 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 08:20:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:23 INFO - 'USER': 'cltbld', 08:20:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:23 INFO - 'XPC_FLAGS': '0x0', 08:20:23 INFO - 'XPC_SERVICE_NAME': '0', 08:20:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:20:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:20:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:20:26 INFO - Installing collected packages: mozsystemmonitor 08:20:26 INFO - Running setup.py install for mozsystemmonitor 08:20:26 INFO - Successfully installed mozsystemmonitor 08:20:26 INFO - Cleaning up... 08:20:26 INFO - Return code: 0 08:20:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:27 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 0x105359b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10535c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c8d92170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105137d30>, '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 0x10505edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10512cbe8>, '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.LTN5OYCo12/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.6ycGZV5GUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:20:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:20:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LTN5OYCo12/Render', 08:20:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:27 INFO - 'HOME': '/Users/cltbld', 08:20:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:27 INFO - 'LOGNAME': 'cltbld', 08:20:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:27 INFO - 'MOZ_NO_REMOTE': '1', 08:20:27 INFO - 'NO_EM_RESTART': '1', 08:20:27 INFO - 'PAGER': '/bin/cat', 08:20:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:27 INFO - 'PWD': '/builds/slave/test', 08:20:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:27 INFO - 'SHELL': '/bin/bash', 08:20:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ycGZV5GUC/Listeners', 08:20:27 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 08:20:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:27 INFO - 'USER': 'cltbld', 08:20:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:27 INFO - 'XPC_FLAGS': '0x0', 08:20:27 INFO - 'XPC_SERVICE_NAME': '0', 08:20:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:27 INFO - Downloading/unpacking jsonschema==2.5.1 08:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:20:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:30 INFO - Downloading functools32-3.2.3-2.tar.gz 08:20:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:20:30 INFO - warning: no files found matching '*.txt' 08:20:30 INFO - no previously-included directories found matching 'build' 08:20:30 INFO - no previously-included directories found matching 'dist' 08:20:30 INFO - no previously-included directories found matching '.git*' 08:20:30 INFO - Installing collected packages: jsonschema, functools32 08:20:30 INFO - Running setup.py install for functools32 08:20:30 INFO - warning: no files found matching '*.txt' 08:20:30 INFO - no previously-included directories found matching 'build' 08:20:30 INFO - no previously-included directories found matching 'dist' 08:20:30 INFO - no previously-included directories found matching '.git*' 08:20:30 INFO - Successfully installed jsonschema functools32 08:20:30 INFO - Cleaning up... 08:20:31 INFO - Return code: 0 08:20:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:31 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 0x105359b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10535c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c8d92170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105137d30>, '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 0x10505edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10512cbe8>, '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.LTN5OYCo12/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.6ycGZV5GUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:20:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LTN5OYCo12/Render', 08:20:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:31 INFO - 'HOME': '/Users/cltbld', 08:20:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:31 INFO - 'LOGNAME': 'cltbld', 08:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:31 INFO - 'MOZ_NO_REMOTE': '1', 08:20:31 INFO - 'NO_EM_RESTART': '1', 08:20:31 INFO - 'PAGER': '/bin/cat', 08:20:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:31 INFO - 'PWD': '/builds/slave/test', 08:20:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:31 INFO - 'SHELL': '/bin/bash', 08:20:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ycGZV5GUC/Listeners', 08:20:31 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 08:20:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:31 INFO - 'USER': 'cltbld', 08:20:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:31 INFO - 'XPC_FLAGS': '0x0', 08:20:31 INFO - 'XPC_SERVICE_NAME': '0', 08:20:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:20:31 INFO - Cleaning up... 08:20:31 INFO - Return code: 0 08:20:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:31 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 0x105359b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10535c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c8d92170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105137d30>, '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 0x10505edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10512cbe8>, '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.LTN5OYCo12/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.6ycGZV5GUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:20:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LTN5OYCo12/Render', 08:20:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:31 INFO - 'HOME': '/Users/cltbld', 08:20:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:31 INFO - 'LOGNAME': 'cltbld', 08:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:31 INFO - 'MOZ_NO_REMOTE': '1', 08:20:31 INFO - 'NO_EM_RESTART': '1', 08:20:31 INFO - 'PAGER': '/bin/cat', 08:20:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:31 INFO - 'PWD': '/builds/slave/test', 08:20:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:31 INFO - 'SHELL': '/bin/bash', 08:20:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ycGZV5GUC/Listeners', 08:20:31 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 08:20:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:31 INFO - 'USER': 'cltbld', 08:20:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:31 INFO - 'XPC_FLAGS': '0x0', 08:20:31 INFO - 'XPC_SERVICE_NAME': '0', 08:20:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:31 INFO - Downloading/unpacking blobuploader==1.2.4 08:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:34 INFO - Downloading blobuploader-1.2.4.tar.gz 08:20:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:20:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:20:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:35 INFO - Downloading docopt-0.6.1.tar.gz 08:20:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:20:35 INFO - Installing collected packages: blobuploader, requests, docopt 08:20:35 INFO - Running setup.py install for blobuploader 08:20:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:20:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:20:35 INFO - Running setup.py install for requests 08:20:36 INFO - Running setup.py install for docopt 08:20:36 INFO - Successfully installed blobuploader requests docopt 08:20:36 INFO - Cleaning up... 08:20:36 INFO - Return code: 0 08:20:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:36 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 0x105359b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10535c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c8d92170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105137d30>, '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 0x10505edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10512cbe8>, '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.LTN5OYCo12/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.6ycGZV5GUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:20:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:20:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LTN5OYCo12/Render', 08:20:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:36 INFO - 'HOME': '/Users/cltbld', 08:20:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:36 INFO - 'LOGNAME': 'cltbld', 08:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:36 INFO - 'MOZ_NO_REMOTE': '1', 08:20:36 INFO - 'NO_EM_RESTART': '1', 08:20:36 INFO - 'PAGER': '/bin/cat', 08:20:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:36 INFO - 'PWD': '/builds/slave/test', 08:20:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:36 INFO - 'SHELL': '/bin/bash', 08:20:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ycGZV5GUC/Listeners', 08:20:36 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 08:20:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:36 INFO - 'USER': 'cltbld', 08:20:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:36 INFO - 'XPC_FLAGS': '0x0', 08:20:36 INFO - 'XPC_SERVICE_NAME': '0', 08:20:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:20:36 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-8YZmw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:20:36 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-54Eb3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:20:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:20:36 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-bFbuGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:20:37 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-S2yml2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:20:37 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-0zzmvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:20:37 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-Wfb_uG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:20:37 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-3DqL1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:20:37 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-jyIXWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:20:37 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-SpU5RJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:20:37 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-GSKBxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:20:37 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-Ba0z8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:20:37 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-8wuoBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:20:37 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-WfE5Nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:20:38 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-IXLZHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:38 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-YOQmpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:20:38 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-4eHt9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:20:38 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-iyQGzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:20:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:20:38 INFO - Running setup.py install for manifestparser 08:20:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:20:38 INFO - Running setup.py install for mozcrash 08:20:38 INFO - Running setup.py install for mozdebug 08:20:38 INFO - Running setup.py install for mozdevice 08:20:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:20:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:20:39 INFO - Running setup.py install for mozfile 08:20:39 INFO - Running setup.py install for mozhttpd 08:20:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:20:39 INFO - Running setup.py install for mozinfo 08:20:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:20:39 INFO - Running setup.py install for mozInstall 08:20:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:20:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:20:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:20:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:20:39 INFO - Running setup.py install for mozleak 08:20:39 INFO - Running setup.py install for mozlog 08:20:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:20:39 INFO - Running setup.py install for moznetwork 08:20:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:20:40 INFO - Running setup.py install for mozprocess 08:20:40 INFO - Running setup.py install for mozprofile 08:20:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:20:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:20:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:20:40 INFO - Running setup.py install for mozrunner 08:20:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:20:40 INFO - Running setup.py install for mozscreenshot 08:20:40 INFO - Running setup.py install for moztest 08:20:40 INFO - Running setup.py install for mozversion 08:20:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:20:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:20:41 INFO - Cleaning up... 08:20:41 INFO - Return code: 0 08:20:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:41 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 0x105359b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10535c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c8d92170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105137d30>, '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 0x10505edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10512cbe8>, '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.LTN5OYCo12/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.6ycGZV5GUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:20:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LTN5OYCo12/Render', 08:20:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:41 INFO - 'HOME': '/Users/cltbld', 08:20:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:41 INFO - 'LOGNAME': 'cltbld', 08:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:41 INFO - 'MOZ_NO_REMOTE': '1', 08:20:41 INFO - 'NO_EM_RESTART': '1', 08:20:41 INFO - 'PAGER': '/bin/cat', 08:20:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:41 INFO - 'PWD': '/builds/slave/test', 08:20:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:41 INFO - 'SHELL': '/bin/bash', 08:20:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ycGZV5GUC/Listeners', 08:20:41 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 08:20:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:41 INFO - 'USER': 'cltbld', 08:20:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:41 INFO - 'XPC_FLAGS': '0x0', 08:20:41 INFO - 'XPC_SERVICE_NAME': '0', 08:20:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:20:41 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-aQxYvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:20:41 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-ErLmHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:20:41 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-jMA9jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:20:41 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-E4mdko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:20:41 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-Xbu670-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:20:41 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-dOYA6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:20:41 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-BZqm3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:20:42 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-xcKDws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:20:42 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-B4K9R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:20:42 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-sHTB92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:20:42 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-XFjJdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:20:42 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-jQmeeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:20:42 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-iHFrQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:20:42 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-hPePnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:42 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-Zj1C0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:20:42 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-ZnXHHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:20:42 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-iCtaQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:20:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:45 INFO - Downloading blessings-1.6.tar.gz 08:20:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:20:45 INFO - Installing collected packages: blessings 08:20:45 INFO - Running setup.py install for blessings 08:20:45 INFO - Successfully installed blessings 08:20:45 INFO - Cleaning up... 08:20:46 INFO - Return code: 0 08:20:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:20:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:20:46 INFO - Reading from file tmpfile_stdout 08:20:46 INFO - Current package versions: 08:20:46 INFO - blessings == 1.6 08:20:46 INFO - blobuploader == 1.2.4 08:20:46 INFO - docopt == 0.6.1 08:20:46 INFO - functools32 == 3.2.3-2 08:20:46 INFO - jsonschema == 2.5.1 08:20:46 INFO - manifestparser == 1.1 08:20:46 INFO - mozInstall == 1.12 08:20:46 INFO - mozcrash == 1.0 08:20:46 INFO - mozdebug == 0.1 08:20:46 INFO - mozdevice == 0.49 08:20:46 INFO - mozfile == 1.2 08:20:46 INFO - mozhttpd == 0.7 08:20:46 INFO - mozinfo == 0.9 08:20:46 INFO - mozleak == 0.1 08:20:46 INFO - mozlog == 3.4 08:20:46 INFO - moznetwork == 0.27 08:20:46 INFO - mozprocess == 0.23 08:20:46 INFO - mozprofile == 0.28 08:20:46 INFO - mozrunner == 6.13 08:20:46 INFO - mozscreenshot == 0.1 08:20:46 INFO - mozsystemmonitor == 0.3 08:20:46 INFO - moztest == 0.7 08:20:46 INFO - mozversion == 1.4 08:20:46 INFO - psutil == 3.1.1 08:20:46 INFO - requests == 1.2.3 08:20:46 INFO - wsgiref == 0.1.2 08:20:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:46 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 0x105359b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10535c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c8d92170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105137d30>, '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 0x10505edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10512cbe8>, '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.LTN5OYCo12/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.6ycGZV5GUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:20:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LTN5OYCo12/Render', 08:20:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:46 INFO - 'HOME': '/Users/cltbld', 08:20:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:46 INFO - 'LOGNAME': 'cltbld', 08:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:46 INFO - 'MOZ_NO_REMOTE': '1', 08:20:46 INFO - 'NO_EM_RESTART': '1', 08:20:46 INFO - 'PAGER': '/bin/cat', 08:20:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:46 INFO - 'PWD': '/builds/slave/test', 08:20:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:46 INFO - 'SHELL': '/bin/bash', 08:20:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ycGZV5GUC/Listeners', 08:20:46 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 08:20:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:46 INFO - 'USER': 'cltbld', 08:20:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:46 INFO - 'XPC_FLAGS': '0x0', 08:20:46 INFO - 'XPC_SERVICE_NAME': '0', 08:20:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:20:46 INFO - Cleaning up... 08:20:46 INFO - Return code: 0 08:20:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105359b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10535c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c8d92170>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105137d30>, '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 0x10505edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10512cbe8>, '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.LTN5OYCo12/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.6ycGZV5GUC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:20:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LTN5OYCo12/Render', 08:20:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:46 INFO - 'HOME': '/Users/cltbld', 08:20:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:46 INFO - 'LOGNAME': 'cltbld', 08:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:46 INFO - 'MOZ_NO_REMOTE': '1', 08:20:46 INFO - 'NO_EM_RESTART': '1', 08:20:46 INFO - 'PAGER': '/bin/cat', 08:20:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:46 INFO - 'PWD': '/builds/slave/test', 08:20:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:46 INFO - 'SHELL': '/bin/bash', 08:20:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ycGZV5GUC/Listeners', 08:20:46 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 08:20:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:46 INFO - 'USER': 'cltbld', 08:20:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:46 INFO - 'XPC_FLAGS': '0x0', 08:20:46 INFO - 'XPC_SERVICE_NAME': '0', 08:20:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:20:46 INFO - Cleaning up... 08:20:46 INFO - Return code: 0 08:20:46 INFO - Running post-action listener: _resource_record_post_action 08:20:46 INFO - Running post-action listener: _start_resource_monitoring 08:20:46 INFO - Starting resource monitoring. 08:20:46 INFO - [mozharness: 2016-12-19 16:20:46.885889Z] Finished create-virtualenv step (success) 08:20:46 INFO - [mozharness: 2016-12-19 16:20:46.886879Z] Running install step. 08:20:46 INFO - Running pre-action listener: _resource_record_pre_action 08:20:46 INFO - Running main action method: install 08:20:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:20:47 INFO - Reading from file tmpfile_stdout 08:20:47 INFO - Detecting whether we're running mozinstall >=1.0... 08:20:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:20:47 INFO - Reading from file tmpfile_stdout 08:20:47 INFO - Output received: 08:20:47 INFO - Usage: mozinstall [options] installer 08:20:47 INFO - Options: 08:20:47 INFO - -h, --help show this help message and exit 08:20:47 INFO - -d DEST, --destination=DEST 08:20:47 INFO - Directory to install application into. [default: 08:20:47 INFO - "/builds/slave/test"] 08:20:47 INFO - --app=APP Application being installed. [default: firefox] 08:20:47 INFO - mkdir: /builds/slave/test/build/application 08:20:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:21:09 INFO - Reading from file tmpfile_stdout 08:21:09 INFO - Output received: 08:21:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:21:09 INFO - Running post-action listener: _resource_record_post_action 08:21:09 INFO - [mozharness: 2016-12-19 16:21:09.247970Z] Finished install step (success) 08:21:09 INFO - [mozharness: 2016-12-19 16:21:09.248127Z] Running run-tests step. 08:21:09 INFO - Running pre-action listener: _resource_record_pre_action 08:21:09 INFO - Running main action method: run_tests 08:21:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:21:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:21:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:21:09 INFO - 2016-12-19 08:21:09.260 screenresolution[1623:7469] starting screenresolution argv=screenresolution get 08:21:09 INFO - 2016-12-19 08:21:09.263 screenresolution[1623:7469] Display 0: 1600x1200x32@60 08:21:09 INFO - 2016-12-19 08:21:09.268 screenresolution[1624:7471] starting screenresolution argv=screenresolution list 08:21:09 INFO - Available Modes on Display 0 08:21:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:21:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:21:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:21:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:21:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:21:09 INFO - Intel Iris: 08:21:09 INFO - Chipset Model: Intel Iris 08:21:09 INFO - Type: GPU 08:21:09 INFO - Bus: Built-In 08:21:09 INFO - VRAM (Dynamic, Max): 1536 MB 08:21:09 INFO - Vendor: Intel (0x8086) 08:21:09 INFO - Device ID: 0x0a2e 08:21:09 INFO - Revision ID: 0x0009 08:21:09 INFO - Displays: 08:21:09 INFO - Display: 08:21:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:21:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:21:09 INFO - Display Serial Number: 1600x1200 60 08:21:09 INFO - Main Display: Yes 08:21:09 INFO - Mirror: Off 08:21:09 INFO - Online: Yes 08:21:09 INFO - Rotation: Supported 08:21:09 INFO - Return code: 0 08:21:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:21:09 INFO - Python 2.7.3 08:21:09 INFO - Return code: 0 08:21:09 INFO - grabbing minidump binary from tooltool 08:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:09 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 0x105137d30>, '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 0x10505edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10512cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:21:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:21:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:21:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:21:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:21:09 INFO - Return code: 0 08:21:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:21:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:21:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:21:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:21:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:21:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0123', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0123 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:21:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LTN5OYCo12/Render', 08:21:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:21:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:21:09 INFO - 'HOME': '/Users/cltbld', 08:21:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:21:09 INFO - 'LOGNAME': 'cltbld', 08:21:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:21:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:09 INFO - 'MOZ_NO_REMOTE': '1', 08:21:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:21:09 INFO - 'NO_EM_RESTART': '1', 08:21:09 INFO - 'PAGER': '/bin/cat', 08:21:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:09 INFO - 'PWD': '/builds/slave/test', 08:21:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:21:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:21:09 INFO - 'SHELL': '/bin/bash', 08:21:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ycGZV5GUC/Listeners', 08:21:09 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 08:21:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:21:09 INFO - 'USER': 'cltbld', 08:21:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:21:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:09 INFO - 'XPC_FLAGS': '0x0', 08:21:09 INFO - 'XPC_SERVICE_NAME': '0', 08:21:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:21:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0123', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:21:09 INFO - mozversion application_buildid: 20161219070438 08:21:09 INFO - mozversion application_changeset: d4b3146a5567a7ddbcdfa5244945db55616cb8d1 08:21:09 INFO - mozversion application_display_name: Nightly 08:21:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:21:09 INFO - mozversion application_name: Firefox 08:21:09 INFO - mozversion application_remotingname: firefox 08:21:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:21:09 INFO - mozversion application_vendor: Mozilla 08:21:09 INFO - mozversion application_version: 53.0a1 08:21:09 INFO - mozversion platform_buildid: 20161219070438 08:21:09 INFO - mozversion platform_changeset: d4b3146a5567a7ddbcdfa5244945db55616cb8d1 08:21:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:21:09 INFO - mozversion platform_version: 53.0a1 08:21:09 INFO - using testdate: 1482164469 08:21:09 INFO - actual date: 1482164469 08:21:09 INFO - starting webserver on 'localhost:49240' 08:21:09 INFO - SUITE-START | Running 2 tests 08:21:09 INFO - TEST-START | dromaeo_css 08:21:09 INFO - operating with platform_type : mac_ 08:21:09 INFO - Initialising browser for dromaeo_css test... 08:21:09 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpSxuXjg/profile http://localhost:49240/getInfo.html) 08:21:12 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 08:21:12 INFO - PROCESS | 1634 | colorDepth:24 08:21:12 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 08:21:12 INFO - PROCESS | 1634 | __metrics 08:21:12 INFO - PROCESS | 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:21:12 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:21:12 INFO - TEST-INFO | 1634: exit 0 08:21:12 INFO - Browser initialized. 08:21:12 INFO - Running cycle 1/1 for dromaeo_css test... 08:21:12 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpSxuXjg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:21:24 INFO - PROCESS | 1636 | RSS: Main: 237051904 08:21:24 INFO - PROCESS | 1636 | 08:22:15 INFO - PROCESS | 1636 | 1482164535650 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] 08:24:29 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 08:24:30 INFO - PROCESS | 1636 | RSS: Main: 389115904 08:24:30 INFO - PROCESS | 1636 | 08:27:33 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 08:27:34 INFO - PROCESS | 1636 | RSS: Main: 371019776 08:27:34 INFO - PROCESS | 1636 | 08:30:37 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 08:30:37 INFO - PROCESS | 1636 | RSS: Main: 344944640 08:30:37 INFO - PROCESS | 1636 | 08:33:40 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 08:33:40 INFO - PROCESS | 1636 | RSS: Main: 354508800 08:33:40 INFO - PROCESS | 1636 | 08:36:44 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 08:36:45 INFO - PROCESS | 1636 | RSS: Main: 335577088 08:36:45 INFO - PROCESS | 1636 | 08:39:48 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 08:39:48 INFO - PROCESS | 1636 | RSS: Main: 461877248 08:39:48 INFO - PROCESS | 1636 | 08:39:48 INFO - PROCESS | 1636 | __start_tp_report 08:39:48 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 08:39:48 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 08:39:48 INFO - PROCESS | 1636 | |i|pagename|runs| 08:39:48 INFO - PROCESS | 1636 | |0;dojo.html;3266.9346613067746;3271.280318329967;3305.0910999475127;3330.500424936258;3344.6153692325374;5504.091824848895;5552.6390784599025;5593.244911936892;5593.356763972144;5634.746436410361;5515.310586176728;5588.385277619469;5592.273004509419;5594.748236329365;5608.859778505529;5082.390113186423;5088.618353623475;5094;5094.898102037957;5101.872453188663;5139.0749665060275;5187.6628019178825;5212.609054320922;5230.529252367286;5261.921071183935;5166.844994650167;5172.456892026321;5182.689038657692;5210.583153347742;5261.8947621047555;5003.199488081889;5052.292679024939;5099.980003999215;5110.156824124052;5118.513741194581;4178.519470260898;5057.190849464068;5086.643934924557;5110.310108135392;5113.667611605271;5515.145152501329;5549.056660367747;5559.388467268597;5570.832875013756;5575.553955683536;5901.7934372297195;5951.761929522814;5959.761609535613;6026.186464827236;6033.6983150842725;6049.667268300242;6093.11649810775;6107.977837958716;6152.753889844401;6158.938410615881;5598.3282006159525;5653.265075540154;5656.745446454961;5667.461591148916;5699.088145896637;6146.78486252979;6296.937030629727;6318.052292156121;6323.051542268605;6324.71538780756;5848.5321174305955;5853.004989151855;5939.07944268639;5941.821745347646;5969;6178;6179.16581261524;6188.535859810532;6190.783322583688;6195.690215489208;6056.515478761688;6074;6086.509319499273;6101.542384321105;6141.662208578482;5936.732847021808;5938.198343223609;6013.278406591237;6054.636721796618;6075.635461872302;4845.9757701211265;4851.248056551241;4851.878703032452;4861.270809378621;4873.80504779812;4277.8288868444915;4358.782060896942;4380.452443444569;4390.7585082820115;4397.2304846651705;5680.943190568124;5682.289713785777;5683.346415162309;5694.97152514243;5702.116171993348;6033.939660603338;6226.128342032119;6235.657038862906;6236.407541283571;6244.313125556185;5604.719764011865;5648.096304591246;5650.63270887391;5650.943490565124;5657.264555607745;5333.893322133536;5387.353517577916;5395.81114660985;5398.352197736218;5401.378841433286;6313.558050936482;6324.146240257691;6355.14205582259;6365.522585806083;6376.1392212051705;6218.253809542703;6221.657808820377;6237.002079667232;6237.4698150657705;6244.906326405198;5244.632875698664;6135.04893764628;6173.506119510518;6175.166352542529;6283.654399007915;6077.544184186116;6080.209572755513;6094.055421409688;6097.390260974044;6134.9079763804475;6014.428629280386;6116.480099191618;6151.108089326933;6182.474489668429;6183.938160618336;5822.970885145547;5875.030619947661;5878.735456904364;5955.553333499918;5961.821145365646;5918.17145599625;5928.140419639214;5953.553483488669;5955.791547295824;6012.278526576839;4813.3983252093485;5825.650460972355;5829.358770535323;5832.445917637818;5833.095870140135;5541.722913854372;5757.0788673811985;5973.1338955852025;5997.370276120944;6015.939840601538;5726.169705392778;5726.79956201531;5755.223044888887;5804.361520232686;5808.912866307093 08:39:48 INFO - PROCESS | 1636 | |1;ext.html;421.8544602112271;423.6166269526078;483.3957553058677;484.2276568872647;509.1649694501018;29692.851535742317;37207.62792372076;39154.60845391549;39274.8036259819;41048;39955.800220998855;40448;40482.7975860121;40529;40529.59470405302;8284.088750237499;8510.617022234015;9235.307351948613;9430.905690943071;9452.291078169164;8492.74521764348;8580.313574914024;8603.268722158624;11007.724806879853;11339.489722962486;11199.27204731694;11279.026170420144;11298;11298.717532061683;11320;11199.328040317567;11275;11281.548738050467;11286.322820630789;11312.981831635152;11100;11173;11186.776264474665;11191.657001159832;11204.439778011067;37665.24669506622;37970.24059518822;38009;38090.61909380926;38101;3398.5921689397433;3481.408160612702;3788.8673896413493;4013.097053163044;4143.08852052548;28998.27504312388;29325.413491730258;30107.096787096423;30135.849320753474;30311.545326820116;2722.4555088982283;3105.2547388626795;3239.8542065607103;3283.5238890360765;3289.473684210539;463107;471270.3784989017;472583;475137;475270;53425.1986220207;53839;53868.73065634725;53898.92202155935;54003.999999999214;58205;58393.4160658388;58501.952431664686;58533.122003169985;58567.70716146392;15304.846951530564;15784;15791.921040394724;15816.209189540477;15826.525204243891;12348.876511234772;12396.504139834486;12398.876011239952;12407.193532420364;12414.317212553397;12420.378981051092;13208.735825283633;13483.303339332173;13521.797173042412;14512.1292722437;5260.263563101169;6126.23422072241;6185.876282474415;6232.345603711636;6249.468795152372;855.3969451536652;866.423828154283;935.4247138010211;975.9707208783748;1057.962971296001;27589.58615620767;28814.84740610352;29374.55938160929;29469.852650736608;29491;1020.8417695257247;1070.8714954205545;1110.7001109700336;1123.662901129658;1239.4794186441536;11810.704732381759;12885;13429.127106738031;14996.625084372978;15326.693466130615;488116;494208;496555;499140;503672;48563.75718121387;49526.50473495291;49620;55056;56398;1352.6077437543001;1380.9930950345386;1399.3493025743078;1400.4048279480976;1404.1996062244627;24407.23228921202;29617.5557366644;30018.69981300159;30414.93547725819;30465.54301685521;47211.52788472209;47759.28361074656;47801.28298075462;47837.28244076272;47870;534834.3258283839;535050;536523;536689;537407;24655.260342189762;24780;24880;25063.248102556954;25074.498510030062;44516.55483445254;44875.32687009632;45639;45879.54120458753;46132.846678833295;37235;37274.627253727114;37760.433593496666;38205.80897095608;38767.418488723255;36547;36760.08099797527;37795.81102094582;37796.05509862275;38099.42850857184;33916.64333426734;34630.653693462744;37119.814400927826;37455.06362340854;37613.81193094017;29194.416111677223;29508.721235421173;30922.072337829002;31175.688243117278;31191.220219493785;23152.4211894704;23184.768152318262;23349.41626459352;23646.763532364457;23672.28983130509 08:39:48 INFO - PROCESS | 1636 | |2;jquery.html;355.83809366738103;372.30007585738826;376.71934408865394;384.33701864284114;406.56091421265035;14500.927495362535;14855.777163342545;16236.75644865328;19355.709664355047;20120.698189527167;20379.796202037975;20452.38642840717;20776.376708698725;21257.149714011422;21264.36206913795;4656.045510670321;5591.7483713232905;5832.2418085649015;5837.036888913324;5842.970785146068;4081.8367265309503;4289.914201715964;4292.806823692941;5653.773849046033;5714.25714657094;6044.667543285118;6339.461145802612;6353.110564520947;6393.232812062536;6403.583767055126;5320.893582128375;5456.826782241817;6108.786192483264;6310;6323.588966717149;4692.36653051837;5514.3658479275;5515.531179849718;5523.917141242844;5530.778768849241;24439.389015274584;25395.365115872068;25400.618990715153;25575.84908679114;25785.74214257852;2116.322776711453;2302.6661134135625;2398.364433425144;2552.6171074338813;2898.825975479934;14824.925875370662;14993;15298.923505382512;15507.379704811794;15874.761878571831;1779.590694140342;1803.4319189455412;1805.5395874052033;1849.8427633651156;1868.719692046204;107724;111508.4424577872;111791;111839.88160118376;112675.87388895477;10787.946060269649;10858;10975.451227438596;11065.446727663584;11165.330080195214;13775.966802489853;13785.931070344785;13795.448182072805;13807.9978403133;13810.37853296604;6841.555298905555;8489.745307640656;8522.403431759718;8551.444156129955;8728.78178045554;8573.149775820168;8591.957040214758;8596.699115530926;8751.56242187888;8805.471671699719;5750.396208398058;6023.969880150659;6432.970724684122;6652.201735791736;6674.599524028574;1647.9423220187236;1762.1805860274778;1780.5192597998728;1840.5030641726926;1853.6014756827346;722.9783106506814;880.7489865388334;901.4366021236727;914.4056363363867;1023.5240613114937;18028.819711802975;22405.21581744631;22530.54938901213;22543.0982760691;22550.436239094153;812.6668066092992;945.3382632157517;999.9500024998721;1000.2648053680539;1014.2798612984716;11162.330260184415;11414.657560273205;11557.190996630155;11586.594469193538;11632.476538555786;498670.5066474644;506978;510829.02538770944;516188;520608;92795;93973;101379.94480220856;106280.87438251192;106841;976.6484065736329;982.9557669904872;991.8660980767793;998.9950050249702;1001.639409812467;18975;19307.227710891406;19437;19524.316648917218;19532.31636892702;50241.99516009732;50620.49379506158;50721;50903.23645145252;51680.191193308056;70056.6497167511;70773.58452831018;71254.86235412947;71290.64354678194;72752;7136.678849451683;7186.46101542376;7291.708331666674;7865.606719664108;8060.476069055492;11901.880981190423;12444.128910976146;12733.108682392143;12800.74398512043;12886.677833053873;7297.927020729725;8048.718294859652;10765.461726913467;10825.891741082803;11005.504752286006;10745.892541074489;10780.407077610807;10832.458377081271;11098.2786118902;11126.721831954266;8840.469571825712;9656.420614763138;11061.170412219277;11270.380129092979;11418.771624567296;7703.691852326068;7870.645820937957;7935.6032198391;8021.5187088774865;8289.917100828914;3912.3349030665427;4684.1334353144775;7740.883886741591;10839;11021.724456888642 08:39:48 INFO - PROCESS | 1636 | |3;mootools.html;1350.6623344163957;1489.456348432822;1649.480413669694;1872.3633964452083;1907.9427617171482;7956.323712484438;8414.410991230616;8423.831523369528;8441.53571553565;8446.873296900536;7452.850942981151;7739.57432341221;7739.922600773991;7978.9601051994805;8181.100078991321;2282.6804247405375;2318.8492747971327;2319.512902290521;2326.499802542453;2327.197116994634;2317.8493397929165;2343.625019996801;2347.558539119322;2357.222116701493;2361.315218586608;2295.5523672883796;2296.0700916128994;2319.4317392238927;2321.918732844351;2331.6619090231907;2282.760310167425;2287.5196208796174;2318.2929206591984;2318.710161229846;2319.4781174235745;2157.417497275727;2180.269609680759;2197.9780202197935;2227.5433536125056;2252.8085112765434;8250.628721707537;8326.833463330699;8339.041010283774;8341.95829020851;8364.623591938378;5056.140456122431;5227.163653815372;5243.79024839006;5255.106631872591;5259.342582177228;3109.67348428414;3218.5333126696496;3388.15296175956;3393.100828280508;3395.9830200848837;1030.5156576409152;1039.6309310194922;1054.140875186728;1066.4454483668526;1068.4283908109123;10819.67540973772;10828.296160749525;10981.286216395909;10993.175511836644;10995.945020274847;3861.864834730771;4466.642668586505;4579.610733087658;4669.252919532859;4691.202495575692;9001.864972025425;9203.677871274473;9260.166585007382;9273.907260927304;9277.680579855036;5191.922121168185;5198.142306519458;5201.427842937273;5201.479852014844;5213.895722085537;3996.600339966038;4288.056627541936;4413.691041627056;4638.1883170445035;4683.461401938753;3612.169201083713;3682.668559829628;3715.851365945386;3778.9244215115546;3798.753081049723;1151.642990672894;1273.6688461000022;1274.8597654258024;1278.5972418688084;1288.574770325809;756.8297133144998;783.8197214640551;885.7387070814125;902.9864552031725;922.7139586728135;5437.646552974044;5597.178933908771;5832.708364581754;5931.139984702194;6069.870735156456;760.4980712729682;771.502380964275;949.4018768176143;968.2302569457157;969.1374676537887;3640.308341415123;3755.7746535207975;3780.4707340972286;3842.9231415372096;3965.940510892339;8585.65657373698;9939.950300248453;10049.497525123714;10119.9494002531;10161.849826553793;9780.462074585967;9855.014498550088;9855.950720246496;10104.74738131538;10115.140213081824;7891.881621775678;7968.203179682101;8054.476459030145;8066.919330806617;8068.0721717002125;5505.752241149238;5546.889062218814;5649.745761440663;5674.773009079756;5678.858028549319;9323.766905827408;9422.434653920787;9582.329236953346;9597.856032159383;9609.039096090615;9114.31642626819;9578.664746733832;9617.134457898823;9653.227741780782;9654.469004204555;6601.966990165019;6815;6863.245043045361;7081.4334853210585;7273.3817625500305;7606.239376062349;7732.226777322223;7866.7639970800965;7976.32201262876;8016.118226995142;7024.419505611197;7138.785836424916;7191.712331506681;7246.855062898818;7286;6999.825004374931;7007.404370628554;7009.9649501752165;7156.463265255231;7211.783646490614;6596.373344532261;6729.158855143107;6757.189137303555;6757.256701762703;6772.762953296611;4844.660873738804;4896.804127834846;4913.28757330178;4953.430355509018;5020.3724534433195;4809.893278634995;4838.943449034076;4905.583025442735;5007.3240112584335;5084.7966081356335 08:39:48 INFO - PROCESS | 1636 | |4;prototype.html;337.3354491651449;346.1778276593091;349.2334326154092;349.34497816593904;360.4989065199372;4726.818295426144;4853.131544355427;5131.692098474095;5173.844784656457;5232.476752324776;4796.280557916314;4847.830325938593;4965.230389289666;5108.565771909382;5113.386393632769;3758.285925674113;4039.9394009089815;4042;4049.7165198436123;4076.2485322407406;3570.982145089271;3738.2336620992633;3770.09517715749;3932.705047121463;4004.099077707507;3175.300994154973;3983.1635356575152;4000.3199456092534;4002.7198096133284;4018.4976877890263;3997.4603428537066;4008.498937632796;4037;4040.171764788226;4040.636342729139;2751.8899244030213;3327.73378129749;3533.0460775590705;3537.9386184144655;3564.518789963348;4051.3463681288804;4458.487273963503;4850.830220942285;4927.457979622274;4971.204607262856;4536.8865778355475;4547.977260113711;4576.702514336557;4577.679562430631;4581.3128030795315;4872.926906096376;5036.489053284036;5158.74206289684;5320.973395133038;5362.570994320445;3599.3161299353037;3896.8636097736726;3901.4886602058373;3917.2557214129224;3920.6863450923856;4894.657373983822;5315.760790764386;5487.256371814133;5494.752736126884;5593.636413633141;3372.3592517422103;3924.529056513237;3999.460072890123;4029.4560234367987;4038.809340620877;3773.8111295955423;4107;4108.157827645326;4122.6083522065355;4127.4634297541725;3511.3504001759757;4091.345384738487;4183.3515805050265;4581.541845815458;4598.724076555417;5389.27244821944;5442.319710036246;5449.863753406196;5474.671519708831;5476.616636835383;1050.891309668292;1147.1912301827192;1237.560665963588;1242.589945318043;1249.5564074753331;683.5795985468901;795.2246559604339;835.8579041562949;851.2253848997383;855.39267120344;4202.2646036943415;4301.741895486281;4445.866624001285;4830.855074347775;4835.782389792468;4329.484680361848;4968.509447165836;5251.4485978972425;5295;5300.628955973122;4141.668666506672;4481.507034226298;4691.366665500182;4754.524547545287;4828.444728856156;2571.2616063891896;2606.83632584954;2790.5116604594114;2805.3968396794785;2826.5194916864184;4746.677325871903;5088.491150884956;5305.455798690377;5471.671699698031;5576.553875689935;4704.411948506437;4748.6438517111355;4776.785044672998;5075.8984820303385;5169.741512924414;5095;5728.627639203439;5788.421157884178;5800.274965629296;5822.214001109796;5512.586556008235;5588.960029589252;5608.635438696635;5609.512390087995;5613.214150018919;4634.606058484932;4653.302004699322;5442.755076021509;5530.281063461724;5531.976584331912;4598.793054312631;4779.928301075417;5672.922144792641;5703.372629010722;5863.237779088691;3741.4948981887096;3767.3783825668456;3776.4712940187846;3777.1491968935575;3777.1501412182038;4661.417322834645;5566.916496252478;5615.410381909841;5627.296587926509;5639.661620302795;4125.64931980785;4832.275158726219;5004.873903371712;5086.033653605803;5389.676619402849;4549.044700612908;4991.3511243538105;5088.542031217208;5427.457254274541;5440.646357986719;4678.461976872567;4717.348927875353;5056.696598203972;5339.3058902344;5362.946370536245;4596.448426188745;4700.670953033255;4918.163912135017;5133.435322114489;5264;4498.460184777848;5338.224123455703;5342.706151161723;5354.303940487712;5469.7027248554905 08:39:48 INFO - PROCESS | 1636 | |5;yui.html;592.2951935642556;721.6319676964753;741.6217728958229;761.8095476130964;785.7721260834359;10630.627928022512;12660.303683297416;12662.81005784914;12693.682657933556;12712.872871271296;14017.088889222194;14037.859621403783;14061.437542498314;14155.929220353884;14192.006559540836;854.4061876995476;885.7874110213535;888.5157589113949;895.9875340864846;896.7399454158286;869.7521206456162;873.68547322964;878.8549889268263;880.3177537408495;881.8633111867639;919.5218486387075;924.0113079005467;924.1036194890945;925.1442415765424;926.5922993882704;916.6058594804232;917.2249449215402;918.7014220378337;919.8574220995756;921.2906062331967;660.0693022837776;679.7960611816435;680.9761658341935;683.9521233513656;684.6268783512998;15016.24918754058;15291.694166116728;15337.46318878845;15342.539723808191;15392.076475411512;11135.944320278346;13652.24912629805;13908.280904098221;14558.9080818939;14611.707765844623;10216.182705383551;11046.21079445949;11136.220464567483;11314.830277545843;11437;3256.8208748518823;3763.73653844231;3793.5637401698605;3855.7108216883566;3931.3120203964477;102809.48595256975;103830;104360;104423;105885.99999999923;10923.00162806258;11024.614138505114;11177.776444471065;11252.26860254081;11487.13846461502;23546.175883843982;23553.528929421314;23647.172348967702;23660.408489787893;23667.171648992204;7837.412194085352;7860.371170306362;7889;8011.519308841488;8072.959635201786;4220.177065472203;4265.296226122717;4298.9570104298555;4300.440942677432;4321.65426765858;3286.5398844161837;3442.1566716154703;3447.413939630269;3570.535830342091;3773.1699026214187;683.5864302097259;689.217737867514;691.629977961788;693.1197379328225;696.0186137546036;625.2840497630187;637.8341631175834;638.543441439373;641.6214433484266;645.3707635055783;8810.47137171759;9087.591058402388;9284.72145835626;9416.90583094174;9559.904400955902;503.76326119377575;588.349873389898;607.4775692904099;628.6793735194992;645.8998855177455;4565.474970378449;4575.588197062214;4576.084783043405;4604.769761511978;4615.9076818463445;103173.48413257886;104219.47890260651;106621;106687;107914.46042769736;69299;84718;85479.86300342542;86783;88550;53120.93758124816;64079.679601601696;81563;82055.17944820595;82593.58703206565;8786.912130878865;8905.910940890508;8958.28255646805;9012.729618111467;9076.912310168565;43082.138357232056;43571.128577428906;43911.92616516813;52167.2174917369;53445.19832202442;39524.2095158101;54580.90838183294;63891;65535.34464655483;66155;12660.556880509139;12682.239065656091;12745.55390561363;12843;12918.870811291767;14174.858251417354;14267.143971361751;14477.855221447651;14481.338584251362;14973.700525989638;13383.74178420112;13534.796978045533;13535.729285414434;13636.386362613905;13780.65548361299;13467.528636498067;13511.354331023518;13589.932050339685;13654;13667.043306968417;13058.477660893457;13266;13300.600981970556;13342.466301347837;13365.39855706515;10392.324498907547;10592.682219533426;10976.615818446317;11418.942905285421;11446.141539384413;10355.171586272929;10764.623238186627;10988.058839347108;11447;11514.251573647685 08:39:48 INFO - PROCESS | 1636 | __end_tp_report 08:39:48 INFO - PROCESS | 1636 | __start_cc_report 08:39:48 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,1677 08:39:48 INFO - PROCESS | 1636 | __end_cc_report 08:39:48 INFO - PROCESS | 1636 | __startTimestamp1482165588449__endTimestamp 08:39:48 INFO - PROCESS | 1636 | 08:39:48 INFO - PROCESS | 1636 | ------- Summary: start ------- 08:39:48 INFO - PROCESS | 1636 | Number of tests: 6 08:39:48 INFO - PROCESS | 1636 | 08:39:48 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5628.76 Median:5804.36 stddev:635.99 (11.0%) stddev-sans-first:610.35 08:39:48 INFO - PROCESS | 1636 | Values: 3266.9 3271.3 3305.1 3330.5 3344.6 5504.1 5552.6 5593.2 5593.4 5634.7 5515.3 5588.4 5592.3 5594.7 5608.9 5082.4 5088.6 5094.0 5094.9 5101.9 5139.1 5187.7 5212.6 5230.5 5261.9 5166.8 5172.5 5182.7 5210.6 5261.9 5003.2 5052.3 5100.0 5110.2 5118.5 4178.5 5057.2 5086.6 5110.3 5113.7 5515.1 5549.1 5559.4 5570.8 5575.6 5901.8 5951.8 5959.8 6026.2 6033.7 6049.7 6093.1 6108.0 6152.8 6158.9 5598.3 5653.3 5656.7 5667.5 5699.1 6146.8 6296.9 6318.1 6323.1 6324.7 5848.5 5853.0 5939.1 5941.8 5969.0 6178.0 6179.2 6188.5 6190.8 6195.7 6056.5 6074.0 6086.5 6101.5 6141.7 5936.7 5938.2 6013.3 6054.6 6075.6 4846.0 4851.2 4851.9 4861.3 4873.8 4277.8 4358.8 4380.5 4390.8 4397.2 5680.9 5682.3 5683.3 5695.0 5702.1 6033.9 6226.1 6235.7 6236.4 6244.3 5604.7 5648.1 5650.6 5650.9 5657.3 5333.9 5387.4 5395.8 5398.4 5401.4 6313.6 6324.1 6355.1 6365.5 6376.1 6218.3 6221.7 6237.0 6237.5 6244.9 5244.6 6135.0 6173.5 6175.2 6283.7 6077.5 6080.2 6094.1 6097.4 6134.9 6014.4 6116.5 6151.1 6182.5 6183.9 5823.0 5875.0 5878.7 5955.6 5961.8 5918.2 5928.1 5953.6 5955.8 6012.3 4813.4 5825.7 5829.4 5832.4 5833.1 5541.7 5757.1 5973.1 5997.4 6015.9 5726.2 5726.8 5755.2 5804.4 5808.9 08:39:48 INFO - PROCESS | 1636 | 08:39:48 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:63301.55 Median:37163.72 stddev:133689.68 (359.7%) stddev-sans-first:133981.35 08:39:48 INFO - PROCESS | 1636 | Values: 421.9 423.6 483.4 484.2 509.2 29692.9 37207.6 39154.6 39274.8 41048.0 39955.8 40448.0 40482.8 40529.0 40529.6 8284.1 8510.6 9235.3 9430.9 9452.3 8492.7 8580.3 8603.3 11007.7 11339.5 11199.3 11279.0 11298.0 11298.7 11320.0 11199.3 11275.0 11281.5 11286.3 11313.0 11100.0 11173.0 11186.8 11191.7 11204.4 37665.2 37970.2 38009.0 38090.6 38101.0 3398.6 3481.4 3788.9 4013.1 4143.1 28998.3 29325.4 30107.1 30135.8 30311.5 2722.5 3105.3 3239.9 3283.5 3289.5 463107.0 471270.4 472583.0 475137.0 475270.0 53425.2 53839.0 53868.7 53898.9 54004.0 58205.0 58393.4 58502.0 58533.1 58567.7 15304.8 15784.0 15791.9 15816.2 15826.5 12348.9 12396.5 12398.9 12407.2 12414.3 12420.4 13208.7 13483.3 13521.8 14512.1 5260.3 6126.2 6185.9 6232.3 6249.5 855.4 866.4 935.4 976.0 1058.0 27589.6 28814.8 29374.6 29469.9 29491.0 1020.8 1070.9 1110.7 1123.7 1239.5 11810.7 12885.0 13429.1 14996.6 15326.7 488116.0 494208.0 496555.0 499140.0 503672.0 48563.8 49526.5 49620.0 55056.0 56398.0 1352.6 1381.0 1399.3 1400.4 1404.2 24407.2 29617.6 30018.7 30414.9 30465.5 47211.5 47759.3 47801.3 47837.3 47870.0 534834.3 535050.0 536523.0 536689.0 537407.0 24655.3 24780.0 24880.0 25063.2 25074.5 44516.6 44875.3 45639.0 45879.5 46132.8 37235.0 37274.6 37760.4 38205.8 38767.4 36547.0 36760.1 37795.8 37796.1 38099.4 33916.6 34630.7 37119.8 37455.1 37613.8 29194.4 29508.7 30922.1 31175.7 31191.2 23152.4 23184.8 23349.4 23646.8 23672.3 08:39:48 INFO - PROCESS | 1636 | 08:39:48 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:31298.47 Median:364.07 stddev:85150.12 (23388.5%) stddev-sans-first:85357.29 08:39:48 INFO - PROCESS | 1636 | Values: 355.8 372.3 376.7 384.3 406.6 14500.9 14855.8 16236.8 19355.7 20120.7 20379.8 20452.4 20776.4 21257.1 21264.4 4656.0 5591.7 5832.2 5837.0 5843.0 4081.8 4289.9 4292.8 5653.8 5714.3 6044.7 6339.5 6353.1 6393.2 6403.6 5320.9 5456.8 6108.8 6310.0 6323.6 4692.4 5514.4 5515.5 5523.9 5530.8 24439.4 25395.4 25400.6 25575.8 25785.7 2116.3 2302.7 2398.4 2552.6 2898.8 14824.9 14993.0 15298.9 15507.4 15874.8 1779.6 1803.4 1805.5 1849.8 1868.7 107724.0 111508.4 111791.0 111839.9 112675.9 10787.9 10858.0 10975.5 11065.4 11165.3 13776.0 13785.9 13795.4 13808.0 13810.4 6841.6 8489.7 8522.4 8551.4 8728.8 8573.1 8592.0 8596.7 8751.6 8805.5 5750.4 6024.0 6433.0 6652.2 6674.6 1647.9 1762.2 1780.5 1840.5 1853.6 723.0 880.7 901.4 914.4 1023.5 18028.8 22405.2 22530.5 22543.1 22550.4 812.7 945.3 1000.0 1000.3 1014.3 11162.3 11414.7 11557.2 11586.6 11632.5 498670.5 506978.0 510829.0 516188.0 520608.0 92795.0 93973.0 101379.9 106280.9 106841.0 976.6 983.0 991.9 999.0 1001.6 18975.0 19307.2 19437.0 19524.3 19532.3 50242.0 50620.5 50721.0 50903.2 51680.2 70056.6 70773.6 71254.9 71290.6 72752.0 7136.7 7186.5 7291.7 7865.6 8060.5 11901.9 12444.1 12733.1 12800.7 12886.7 7297.9 8048.7 10765.5 10825.9 11005.5 10745.9 10780.4 10832.5 11098.3 11126.7 8840.5 9656.4 11061.2 11270.4 11418.8 7703.7 7870.6 7935.6 8021.5 8289.9 3912.3 4684.1 7740.9 10839.0 11021.7 08:39:48 INFO - PROCESS | 1636 | 08:39:48 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5433.43 Median:5220.53 stddev:2976.50 (57.0%) stddev-sans-first:2969.03 08:39:48 INFO - PROCESS | 1636 | Values: 1350.7 1489.5 1649.5 1872.4 1907.9 7956.3 8414.4 8423.8 8441.5 8446.9 7452.9 7739.6 7739.9 7979.0 8181.1 2282.7 2318.8 2319.5 2326.5 2327.2 2317.8 2343.6 2347.6 2357.2 2361.3 2295.6 2296.1 2319.4 2321.9 2331.7 2282.8 2287.5 2318.3 2318.7 2319.5 2157.4 2180.3 2198.0 2227.5 2252.8 8250.6 8326.8 8339.0 8342.0 8364.6 5056.1 5227.2 5243.8 5255.1 5259.3 3109.7 3218.5 3388.2 3393.1 3396.0 1030.5 1039.6 1054.1 1066.4 1068.4 10819.7 10828.3 10981.3 10993.2 10995.9 3861.9 4466.6 4579.6 4669.3 4691.2 9001.9 9203.7 9260.2 9273.9 9277.7 5191.9 5198.1 5201.4 5201.5 5213.9 3996.6 4288.1 4413.7 4638.2 4683.5 3612.2 3682.7 3715.9 3778.9 3798.8 1151.6 1273.7 1274.9 1278.6 1288.6 756.8 783.8 885.7 903.0 922.7 5437.6 5597.2 5832.7 5931.1 6069.9 760.5 771.5 949.4 968.2 969.1 3640.3 3755.8 3780.5 3842.9 3965.9 8585.7 9940.0 10049.5 10119.9 10161.8 9780.5 9855.0 9856.0 10104.7 10115.1 7891.9 7968.2 8054.5 8066.9 8068.1 5505.8 5546.9 5649.7 5674.8 5678.9 9323.8 9422.4 9582.3 9597.9 9609.0 9114.3 9578.7 9617.1 9653.2 9654.5 6602.0 6815.0 6863.2 7081.4 7273.4 7606.2 7732.2 7866.8 7976.3 8016.1 7024.4 7138.8 7191.7 7246.9 7286.0 6999.8 7007.4 7010.0 7156.5 7211.8 6596.4 6729.2 6757.2 6757.3 6772.8 4844.7 4896.8 4913.3 4953.4 5020.4 4809.9 4838.9 4905.6 5007.3 5084.8 08:39:48 INFO - PROCESS | 1636 | 08:39:48 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4319.21 Median:4722.08 stddev:1296.48 (27.5%) stddev-sans-first:1265.20 08:39:48 INFO - PROCESS | 1636 | Values: 337.3 346.2 349.2 349.3 360.5 4726.8 4853.1 5131.7 5173.8 5232.5 4796.3 4847.8 4965.2 5108.6 5113.4 3758.3 4039.9 4042.0 4049.7 4076.2 3571.0 3738.2 3770.1 3932.7 4004.1 3175.3 3983.2 4000.3 4002.7 4018.5 3997.5 4008.5 4037.0 4040.2 4040.6 2751.9 3327.7 3533.0 3537.9 3564.5 4051.3 4458.5 4850.8 4927.5 4971.2 4536.9 4548.0 4576.7 4577.7 4581.3 4872.9 5036.5 5158.7 5321.0 5362.6 3599.3 3896.9 3901.5 3917.3 3920.7 4894.7 5315.8 5487.3 5494.8 5593.6 3372.4 3924.5 3999.5 4029.5 4038.8 3773.8 4107.0 4108.2 4122.6 4127.5 3511.4 4091.3 4183.4 4581.5 4598.7 5389.3 5442.3 5449.9 5474.7 5476.6 1050.9 1147.2 1237.6 1242.6 1249.6 683.6 795.2 835.9 851.2 855.4 4202.3 4301.7 4445.9 4830.9 4835.8 4329.5 4968.5 5251.4 5295.0 5300.6 4141.7 4481.5 4691.4 4754.5 4828.4 2571.3 2606.8 2790.5 2805.4 2826.5 4746.7 5088.5 5305.5 5471.7 5576.6 4704.4 4748.6 4776.8 5075.9 5169.7 5095.0 5728.6 5788.4 5800.3 5822.2 5512.6 5589.0 5608.6 5609.5 5613.2 4634.6 4653.3 5442.8 5530.3 5532.0 4598.8 4779.9 5672.9 5703.4 5863.2 3741.5 3767.4 3776.5 3777.1 3777.2 4661.4 5566.9 5615.4 5627.3 5639.7 4125.6 4832.3 5004.9 5086.0 5389.7 4549.0 4991.4 5088.5 5427.5 5440.6 4678.5 4717.3 5056.7 5339.3 5362.9 4596.4 4700.7 4918.2 5133.4 5264.0 4498.5 5338.2 5342.7 5354.3 5469.7 08:39:48 INFO - PROCESS | 1636 | 08:39:48 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:19739.29 Median:21872.19 stddev:28523.69 (130.4%) stddev-sans-first:28567.47 08:39:48 INFO - PROCESS | 1636 | Values: 592.3 721.6 741.6 761.8 785.8 10630.6 12660.3 12662.8 12693.7 12712.9 14017.1 14037.9 14061.4 14155.9 14192.0 854.4 885.8 888.5 896.0 896.7 869.8 873.7 878.9 880.3 881.9 919.5 924.0 924.1 925.1 926.6 916.6 917.2 918.7 919.9 921.3 660.1 679.8 681.0 684.0 684.6 15016.2 15291.7 15337.5 15342.5 15392.1 11135.9 13652.2 13908.3 14558.9 14611.7 10216.2 11046.2 11136.2 11314.8 11437.0 3256.8 3763.7 3793.6 3855.7 3931.3 102809.5 103830.0 104360.0 104423.0 105886.0 10923.0 11024.6 11177.8 11252.3 11487.1 23546.2 23553.5 23647.2 23660.4 23667.2 7837.4 7860.4 7889.0 8011.5 8073.0 4220.2 4265.3 4299.0 4300.4 4321.7 3286.5 3442.2 3447.4 3570.5 3773.2 683.6 689.2 691.6 693.1 696.0 625.3 637.8 638.5 641.6 645.4 8810.5 9087.6 9284.7 9416.9 9559.9 503.8 588.3 607.5 628.7 645.9 4565.5 4575.6 4576.1 4604.8 4615.9 103173.5 104219.5 106621.0 106687.0 107914.5 69299.0 84718.0 85479.9 86783.0 88550.0 53120.9 64079.7 81563.0 82055.2 82593.6 8786.9 8905.9 8958.3 9012.7 9076.9 43082.1 43571.1 43911.9 52167.2 53445.2 39524.2 54580.9 63891.0 65535.3 66155.0 12660.6 12682.2 12745.6 12843.0 12918.9 14174.9 14267.1 14477.9 14481.3 14973.7 13383.7 13534.8 13535.7 13636.4 13780.7 13467.5 13511.4 13589.9 13654.0 13667.0 13058.5 13266.0 13300.6 13342.5 13365.4 10392.3 10592.7 10976.6 11418.9 11446.1 10355.2 10764.6 10988.1 11447.0 11514.3 08:39:48 INFO - PROCESS | 1636 | -------- Summary: end -------- 08:39:48 INFO - PROCESS | 1636 | 08:39:49 INFO - TEST-INFO | 1636: exit 0 08:39:49 INFO - TEST-OK | dromaeo_css | took 1119278ms 08:39:49 INFO - TEST-START | kraken 08:39:49 INFO - operating with platform_type : mac_ 08:39:49 INFO - Initialising browser for kraken test... 08:39:49 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpAPHD5F/profile http://localhost:49240/getInfo.html) 08:39:51 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 08:39:51 INFO - PROCESS | 1646 | colorDepth:24 08:39:51 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 08:39:51 INFO - PROCESS | 1646 | __metrics 08:39:51 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:39:51 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:39:52 INFO - TEST-INFO | 1646: exit 0 08:39:52 INFO - Browser initialized. 08:39:52 INFO - Running cycle 1/1 for kraken test... 08:39:52 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpAPHD5F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:40:04 INFO - PROCESS | 1647 | RSS: Main: 237121536 08:40:04 INFO - PROCESS | 1647 | 08:40:06 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 08:40:07 INFO - PROCESS | 1647 | RSS: Main: 290402304 08:40:07 INFO - PROCESS | 1647 | 08:40:10 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 08:40:10 INFO - PROCESS | 1647 | RSS: Main: 293662720 08:40:10 INFO - PROCESS | 1647 | 08:40:14 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 08:40:15 INFO - PROCESS | 1647 | RSS: Main: 383508480 08:40:15 INFO - PROCESS | 1647 | 08:40:16 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 08:40:17 INFO - PROCESS | 1647 | RSS: Main: 287895552 08:40:17 INFO - PROCESS | 1647 | 08:40:19 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:40:20 INFO - PROCESS | 1647 | RSS: Main: 290779136 08:40:20 INFO - PROCESS | 1647 | 08:40:23 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 08:40:23 INFO - PROCESS | 1647 | RSS: Main: 333881344 08:40:23 INFO - PROCESS | 1647 | 08:40:26 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 08:40:27 INFO - PROCESS | 1647 | RSS: Main: 334868480 08:40:27 INFO - PROCESS | 1647 | 08:40:30 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 08:40:30 INFO - PROCESS | 1647 | RSS: Main: 330592256 08:40:30 INFO - PROCESS | 1647 | 08:40:32 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:40:33 INFO - PROCESS | 1647 | RSS: Main: 305795072 08:40:33 INFO - PROCESS | 1647 | 08:40:34 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:40:35 INFO - PROCESS | 1647 | RSS: Main: 310657024 08:40:35 INFO - PROCESS | 1647 | 08:40:37 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:40:38 INFO - PROCESS | 1647 | RSS: Main: 312365056 08:40:38 INFO - PROCESS | 1647 | 08:40:41 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:40:42 INFO - PROCESS | 1647 | RSS: Main: 328957952 08:40:42 INFO - PROCESS | 1647 | 08:40:45 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:40:45 INFO - PROCESS | 1647 | RSS: Main: 323239936 08:40:45 INFO - PROCESS | 1647 | 08:40:47 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 08:40:47 INFO - PROCESS | 1647 | RSS: Main: 367140864 08:40:47 INFO - PROCESS | 1647 | 08:40:47 INFO - PROCESS | 1647 | __start_tp_report 08:40:47 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 08:40:47 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 08:40:47 INFO - PROCESS | 1647 | |i|pagename|runs| 08:40:47 INFO - PROCESS | 1647 | |0;ai-astar;113;112;114;115;113;112;113;114;113;113 08:40:47 INFO - PROCESS | 1647 | |1;audio-beat-detection;136;109;111;144;110;122;142;141;149;110 08:40:47 INFO - PROCESS | 1647 | |2;audio-dft;181;184;215;261;185;185;180;182;183;184 08:40:47 INFO - PROCESS | 1647 | |3;audio-fft;80;58;59;87;61;59;63;58;74;58 08:40:47 INFO - PROCESS | 1647 | |4;audio-oscillator;90;71;86;68;68;69;85;69;68;82 08:40:47 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;112;113;111;114;111;113;111;115;111;112 08:40:47 INFO - PROCESS | 1647 | |6;imaging-darkroom;95;94;97;95;94;96;94;96;96;96 08:40:47 INFO - PROCESS | 1647 | |7;imaging-desaturate;87;86;87;88;87;84;86;85;86;85 08:40:47 INFO - PROCESS | 1647 | |8;json-parse-financial;57;55;53;53;53;55;59;77;85;78 08:40:47 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;64;72;81;78;73;69;70;71;71;71 08:40:47 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;90;86;87;90;84;79;90;95;108;83 08:40:47 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;162;150;139;139;142;141;140;140;218;158 08:40:47 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;174;172;176;233;228;173;172;171;173;174 08:40:47 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;66;66;68;67;67;66;66;67;67;66 08:40:47 INFO - PROCESS | 1647 | __end_tp_report 08:40:47 INFO - PROCESS | 1647 | __start_cc_report 08:40:47 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,2114 08:40:47 INFO - PROCESS | 1647 | __end_cc_report 08:40:47 INFO - PROCESS | 1647 | __startTimestamp1482165647919__endTimestamp 08:40:47 INFO - PROCESS | 1647 | 08:40:47 INFO - PROCESS | 1647 | ------- Summary: start ------- 08:40:47 INFO - PROCESS | 1647 | Number of tests: 14 08:40:47 INFO - PROCESS | 1647 | 08:40:47 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 08:40:47 INFO - PROCESS | 1647 | Values: 113.0 112.0 114.0 115.0 113.0 112.0 113.0 114.0 113.0 113.0 08:40:47 INFO - PROCESS | 1647 | 08:40:47 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:127.40 Median:138.50 stddev:16.52 (11.9%) stddev-sans-first:17.23 08:40:47 INFO - PROCESS | 1647 | Values: 136.0 109.0 111.0 144.0 110.0 122.0 142.0 141.0 149.0 110.0 08:40:47 INFO - PROCESS | 1647 | 08:40:47 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:194.00 Median:184.50 stddev:25.65 (13.9%) stddev-sans-first:26.77 08:40:47 INFO - PROCESS | 1647 | Values: 181.0 184.0 215.0 261.0 185.0 185.0 180.0 182.0 183.0 184.0 08:40:47 INFO - PROCESS | 1647 | 08:40:47 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:65.70 Median:62.00 stddev:10.67 (17.2%) stddev-sans-first:9.98 08:40:47 INFO - PROCESS | 1647 | Values: 80.0 58.0 59.0 87.0 61.0 59.0 63.0 58.0 74.0 58.0 08:40:47 INFO - PROCESS | 1647 | 08:40:47 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:75.60 Median:76.50 stddev:8.98 (11.7%) stddev-sans-first:7.87 08:40:47 INFO - PROCESS | 1647 | Values: 90.0 71.0 86.0 68.0 68.0 69.0 85.0 69.0 68.0 82.0 08:40:47 INFO - PROCESS | 1647 | 08:40:47 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:112.30 Median:112.50 stddev:1.42 (1.3%) stddev-sans-first:1.50 08:40:47 INFO - PROCESS | 1647 | Values: 112.0 113.0 111.0 114.0 111.0 113.0 111.0 115.0 111.0 112.0 08:40:47 INFO - PROCESS | 1647 | 08:40:47 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:96.00 stddev:1.06 (1.1%) stddev-sans-first:1.12 08:40:47 INFO - PROCESS | 1647 | Values: 95.0 94.0 97.0 95.0 94.0 96.0 94.0 96.0 96.0 96.0 08:40:47 INFO - PROCESS | 1647 | 08:40:47 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:86.10 Median:86.50 stddev:1.20 (1.4%) stddev-sans-first:1.22 08:40:47 INFO - PROCESS | 1647 | Values: 87.0 86.0 87.0 88.0 87.0 84.0 86.0 85.0 86.0 85.0 08:40:47 INFO - PROCESS | 1647 | 08:40:47 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:58.00 stddev:12.39 (21.4%) stddev-sans-first:12.99 08:40:47 INFO - PROCESS | 1647 | Values: 57.0 55.0 53.0 53.0 53.0 55.0 59.0 77.0 85.0 78.0 08:40:47 INFO - PROCESS | 1647 | 08:40:47 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:71.50 stddev:4.69 (6.6%) stddev-sans-first:3.98 08:40:47 INFO - PROCESS | 1647 | Values: 64.0 72.0 81.0 78.0 73.0 69.0 70.0 71.0 71.0 71.0 08:40:47 INFO - PROCESS | 1647 | 08:40:47 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:88.50 stddev:7.98 (9.0%) stddev-sans-first:8.46 08:40:47 INFO - PROCESS | 1647 | Values: 90.0 86.0 87.0 90.0 84.0 79.0 90.0 95.0 108.0 83.0 08:40:47 INFO - PROCESS | 1647 | 08:40:47 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:152.90 Median:146.00 stddev:24.35 (16.7%) stddev-sans-first:25.60 08:40:47 INFO - PROCESS | 1647 | Values: 162.0 150.0 139.0 139.0 142.0 141.0 140.0 140.0 218.0 158.0 08:40:47 INFO - PROCESS | 1647 | 08:40:47 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.60 Median:174.00 stddev:24.26 (13.9%) stddev-sans-first:25.43 08:40:47 INFO - PROCESS | 1647 | Values: 174.0 172.0 176.0 233.0 228.0 173.0 172.0 171.0 173.0 174.0 08:40:47 INFO - PROCESS | 1647 | 08:40:47 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 08:40:47 INFO - PROCESS | 1647 | Values: 66.0 66.0 68.0 67.0 67.0 66.0 66.0 67.0 67.0 66.0 08:40:47 INFO - PROCESS | 1647 | -------- Summary: end -------- 08:40:47 INFO - PROCESS | 1647 | 08:40:48 INFO - TEST-INFO | 1647: exit 0 08:40:48 INFO - TEST-OK | kraken | took 59730ms 08:40:48 INFO - SUITE-END | took 1179s 08:40:49 INFO - Completed test suite (00:19:39) 08:40:49 INFO - javascript benchmark 08:40:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3266.9346613067746, 3271.280318329967, 3305.0910999475127, 3330.500424936258, 3344.6153692325374, 5504.091824848895, 5552.6390784599025, 5593.244911936892, 5593.356763972144, 5634.746436410361, 5515.310586176728, 5588.385277619469, 5592.273004509419, 5594.748236329365, 5608.859778505529, 5082.390113186423, 5088.618353623475, 5094.0, 5094.898102037957, 5101.872453188663, 5139.0749665060275, 5187.6628019178825, 5212.609054320922, 5230.529252367286, 5261.921071183935, 5166.844994650167, 5172.456892026321, 5182.689038657692, 5210.583153347742, 5261.8947621047555, 5003.199488081889, 5052.292679024939, 5099.980003999215, 5110.156824124052, 5118.513741194581, 4178.519470260898, 5057.190849464068, 5086.643934924557, 5110.310108135392, 5113.667611605271, 5515.145152501329, 5549.056660367747, 5559.388467268597, 5570.832875013756, 5575.553955683536, 5901.7934372297195, 5951.761929522814, 5959.761609535613, 6026.186464827236, 6033.6983150842725, 6049.667268300242, 6093.11649810775, 6107.977837958716, 6152.753889844401, 6158.938410615881, 5598.3282006159525, 5653.265075540154, 5656.745446454961, 5667.461591148916, 5699.088145896637, 6146.78486252979, 6296.937030629727, 6318.052292156121, 6323.051542268605, 6324.71538780756, 5848.5321174305955, 5853.004989151855, 5939.07944268639, 5941.821745347646, 5969.0, 6178.0, 6179.16581261524, 6188.535859810532, 6190.783322583688, 6195.690215489208, 6056.515478761688, 6074.0, 6086.509319499273, 6101.542384321105, 6141.662208578482, 5936.732847021808, 5938.198343223609, 6013.278406591237, 6054.636721796618, 6075.635461872302, 4845.9757701211265, 4851.248056551241, 4851.878703032452, 4861.270809378621, 4873.80504779812, 4277.8288868444915, 4358.782060896942, 4380.452443444569, 4390.7585082820115, 4397.2304846651705, 5680.943190568124, 5682.289713785777, 5683.346415162309, 5694.97152514243, 5702.116171993348, 6033.939660603338, 6226.128342032119, 6235.657038862906, 6236.407541283571, 6244.313125556185, 5604.719764011865, 5648.096304591246, 5650.63270887391, 5650.943490565124, 5657.264555607745, 5333.893322133536, 5387.353517577916, 5395.81114660985, 5398.352197736218, 5401.378841433286, 6313.558050936482, 6324.146240257691, 6355.14205582259, 6365.522585806083, 6376.1392212051705, 6218.253809542703, 6221.657808820377, 6237.002079667232, 6237.4698150657705, 6244.906326405198, 5244.632875698664, 6135.04893764628, 6173.506119510518, 6175.166352542529, 6283.654399007915, 6077.544184186116, 6080.209572755513, 6094.055421409688, 6097.390260974044, 6134.9079763804475, 6014.428629280386, 6116.480099191618, 6151.108089326933, 6182.474489668429, 6183.938160618336, 5822.970885145547, 5875.030619947661, 5878.735456904364, 5955.553333499918, 5961.821145365646, 5918.17145599625, 5928.140419639214, 5953.553483488669, 5955.791547295824, 6012.278526576839, 4813.3983252093485, 5825.650460972355, 5829.358770535323, 5832.445917637818, 5833.095870140135, 5541.722913854372, 5757.0788673811985, 5973.1338955852025, 5997.370276120944, 6015.939840601538, 5726.169705392778, 5726.79956201531, 5755.223044888887, 5804.361520232686, 5808.912866307093], "value": 5588.057631892777, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.8544602112271, 423.6166269526078, 483.3957553058677, 484.2276568872647, 509.1649694501018, 29692.851535742317, 37207.62792372076, 39154.60845391549, 39274.8036259819, 41048.0, 39955.800220998855, 40448.0, 40482.7975860121, 40529.0, 40529.59470405302, 8284.088750237499, 8510.617022234015, 9235.307351948613, 9430.905690943071, 9452.291078169164, 8492.74521764348, 8580.313574914024, 8603.268722158624, 11007.724806879853, 11339.489722962486, 11199.27204731694, 11279.026170420144, 11298.0, 11298.717532061683, 11320.0, 11199.328040317567, 11275.0, 11281.548738050467, 11286.322820630789, 11312.981831635152, 11100.0, 11173.0, 11186.776264474665, 11191.657001159832, 11204.439778011067, 37665.24669506622, 37970.24059518822, 38009.0, 38090.61909380926, 38101.0, 3398.5921689397433, 3481.408160612702, 3788.8673896413493, 4013.097053163044, 4143.08852052548, 28998.27504312388, 29325.413491730258, 30107.096787096423, 30135.849320753474, 30311.545326820116, 2722.4555088982283, 3105.2547388626795, 3239.8542065607103, 3283.5238890360765, 3289.473684210539, 463107.0, 471270.3784989017, 472583.0, 475137.0, 475270.0, 53425.1986220207, 53839.0, 53868.73065634725, 53898.92202155935, 54003.999999999214, 58205.0, 58393.4160658388, 58501.952431664686, 58533.122003169985, 58567.70716146392, 15304.846951530564, 15784.0, 15791.921040394724, 15816.209189540477, 15826.525204243891, 12348.876511234772, 12396.504139834486, 12398.876011239952, 12407.193532420364, 12414.317212553397, 12420.378981051092, 13208.735825283633, 13483.303339332173, 13521.797173042412, 14512.1292722437, 5260.263563101169, 6126.23422072241, 6185.876282474415, 6232.345603711636, 6249.468795152372, 855.3969451536652, 866.423828154283, 935.4247138010211, 975.9707208783748, 1057.962971296001, 27589.58615620767, 28814.84740610352, 29374.55938160929, 29469.852650736608, 29491.0, 1020.8417695257247, 1070.8714954205545, 1110.7001109700336, 1123.662901129658, 1239.4794186441536, 11810.704732381759, 12885.0, 13429.127106738031, 14996.625084372978, 15326.693466130615, 488116.0, 494208.0, 496555.0, 499140.0, 503672.0, 48563.75718121387, 49526.50473495291, 49620.0, 55056.0, 56398.0, 1352.6077437543001, 1380.9930950345386, 1399.3493025743078, 1400.4048279480976, 1404.1996062244627, 24407.23228921202, 29617.5557366644, 30018.69981300159, 30414.93547725819, 30465.54301685521, 47211.52788472209, 47759.28361074656, 47801.28298075462, 47837.28244076272, 47870.0, 534834.3258283839, 535050.0, 536523.0, 536689.0, 537407.0, 24655.260342189762, 24780.0, 24880.0, 25063.248102556954, 25074.498510030062, 44516.55483445254, 44875.32687009632, 45639.0, 45879.54120458753, 46132.846678833295, 37235.0, 37274.627253727114, 37760.433593496666, 38205.80897095608, 38767.418488723255, 36547.0, 36760.08099797527, 37795.81102094582, 37796.05509862275, 38099.42850857184, 33916.64333426734, 34630.653693462744, 37119.814400927826, 37455.06362340854, 37613.81193094017, 29194.416111677223, 29508.721235421173, 30922.072337829002, 31175.688243117278, 31191.220219493785, 23152.4211894704, 23184.768152318262, 23349.41626459352, 23646.763532364457, 23672.28983130509], "value": 19054.801596951103, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.83809366738103, 372.30007585738826, 376.71934408865394, 384.33701864284114, 406.56091421265035, 14500.927495362535, 14855.777163342545, 16236.75644865328, 19355.709664355047, 20120.698189527167, 20379.796202037975, 20452.38642840717, 20776.376708698725, 21257.149714011422, 21264.36206913795, 4656.045510670321, 5591.7483713232905, 5832.2418085649015, 5837.036888913324, 5842.970785146068, 4081.8367265309503, 4289.914201715964, 4292.806823692941, 5653.773849046033, 5714.25714657094, 6044.667543285118, 6339.461145802612, 6353.110564520947, 6393.232812062536, 6403.583767055126, 5320.893582128375, 5456.826782241817, 6108.786192483264, 6310.0, 6323.588966717149, 4692.36653051837, 5514.3658479275, 5515.531179849718, 5523.917141242844, 5530.778768849241, 24439.389015274584, 25395.365115872068, 25400.618990715153, 25575.84908679114, 25785.74214257852, 2116.322776711453, 2302.6661134135625, 2398.364433425144, 2552.6171074338813, 2898.825975479934, 14824.925875370662, 14993.0, 15298.923505382512, 15507.379704811794, 15874.761878571831, 1779.590694140342, 1803.4319189455412, 1805.5395874052033, 1849.8427633651156, 1868.719692046204, 107724.0, 111508.4424577872, 111791.0, 111839.88160118376, 112675.87388895477, 10787.946060269649, 10858.0, 10975.451227438596, 11065.446727663584, 11165.330080195214, 13775.966802489853, 13785.931070344785, 13795.448182072805, 13807.9978403133, 13810.37853296604, 6841.555298905555, 8489.745307640656, 8522.403431759718, 8551.444156129955, 8728.78178045554, 8573.149775820168, 8591.957040214758, 8596.699115530926, 8751.56242187888, 8805.471671699719, 5750.396208398058, 6023.969880150659, 6432.970724684122, 6652.201735791736, 6674.599524028574, 1647.9423220187236, 1762.1805860274778, 1780.5192597998728, 1840.5030641726926, 1853.6014756827346, 722.9783106506814, 880.7489865388334, 901.4366021236727, 914.4056363363867, 1023.5240613114937, 18028.819711802975, 22405.21581744631, 22530.54938901213, 22543.0982760691, 22550.436239094153, 812.6668066092992, 945.3382632157517, 999.9500024998721, 1000.2648053680539, 1014.2798612984716, 11162.330260184415, 11414.657560273205, 11557.190996630155, 11586.594469193538, 11632.476538555786, 498670.5066474644, 506978.0, 510829.02538770944, 516188.0, 520608.0, 92795.0, 93973.0, 101379.94480220856, 106280.87438251192, 106841.0, 976.6484065736329, 982.9557669904872, 991.8660980767793, 998.9950050249702, 1001.639409812467, 18975.0, 19307.227710891406, 19437.0, 19524.316648917218, 19532.31636892702, 50241.99516009732, 50620.49379506158, 50721.0, 50903.23645145252, 51680.191193308056, 70056.6497167511, 70773.58452831018, 71254.86235412947, 71290.64354678194, 72752.0, 7136.678849451683, 7186.46101542376, 7291.708331666674, 7865.606719664108, 8060.476069055492, 11901.880981190423, 12444.128910976146, 12733.108682392143, 12800.74398512043, 12886.677833053873, 7297.927020729725, 8048.718294859652, 10765.461726913467, 10825.891741082803, 11005.504752286006, 10745.892541074489, 10780.407077610807, 10832.458377081271, 11098.2786118902, 11126.721831954266, 8840.469571825712, 9656.420614763138, 11061.170412219277, 11270.380129092979, 11418.771624567296, 7703.691852326068, 7870.645820937957, 7935.6032198391, 8021.5187088774865, 8289.917100828914, 3912.3349030665427, 4684.1334353144775, 7740.883886741591, 10839.0, 11021.724456888642], "value": 9317.20112846358, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.6623344163957, 1489.456348432822, 1649.480413669694, 1872.3633964452083, 1907.9427617171482, 7956.323712484438, 8414.410991230616, 8423.831523369528, 8441.53571553565, 8446.873296900536, 7452.850942981151, 7739.57432341221, 7739.922600773991, 7978.9601051994805, 8181.100078991321, 2282.6804247405375, 2318.8492747971327, 2319.512902290521, 2326.499802542453, 2327.197116994634, 2317.8493397929165, 2343.625019996801, 2347.558539119322, 2357.222116701493, 2361.315218586608, 2295.5523672883796, 2296.0700916128994, 2319.4317392238927, 2321.918732844351, 2331.6619090231907, 2282.760310167425, 2287.5196208796174, 2318.2929206591984, 2318.710161229846, 2319.4781174235745, 2157.417497275727, 2180.269609680759, 2197.9780202197935, 2227.5433536125056, 2252.8085112765434, 8250.628721707537, 8326.833463330699, 8339.041010283774, 8341.95829020851, 8364.623591938378, 5056.140456122431, 5227.163653815372, 5243.79024839006, 5255.106631872591, 5259.342582177228, 3109.67348428414, 3218.5333126696496, 3388.15296175956, 3393.100828280508, 3395.9830200848837, 1030.5156576409152, 1039.6309310194922, 1054.140875186728, 1066.4454483668526, 1068.4283908109123, 10819.67540973772, 10828.296160749525, 10981.286216395909, 10993.175511836644, 10995.945020274847, 3861.864834730771, 4466.642668586505, 4579.610733087658, 4669.252919532859, 4691.202495575692, 9001.864972025425, 9203.677871274473, 9260.166585007382, 9273.907260927304, 9277.680579855036, 5191.922121168185, 5198.142306519458, 5201.427842937273, 5201.479852014844, 5213.895722085537, 3996.600339966038, 4288.056627541936, 4413.691041627056, 4638.1883170445035, 4683.461401938753, 3612.169201083713, 3682.668559829628, 3715.851365945386, 3778.9244215115546, 3798.753081049723, 1151.642990672894, 1273.6688461000022, 1274.8597654258024, 1278.5972418688084, 1288.574770325809, 756.8297133144998, 783.8197214640551, 885.7387070814125, 902.9864552031725, 922.7139586728135, 5437.646552974044, 5597.178933908771, 5832.708364581754, 5931.139984702194, 6069.870735156456, 760.4980712729682, 771.502380964275, 949.4018768176143, 968.2302569457157, 969.1374676537887, 3640.308341415123, 3755.7746535207975, 3780.4707340972286, 3842.9231415372096, 3965.940510892339, 8585.65657373698, 9939.950300248453, 10049.497525123714, 10119.9494002531, 10161.849826553793, 9780.462074585967, 9855.014498550088, 9855.950720246496, 10104.74738131538, 10115.140213081824, 7891.881621775678, 7968.203179682101, 8054.476459030145, 8066.919330806617, 8068.0721717002125, 5505.752241149238, 5546.889062218814, 5649.745761440663, 5674.773009079756, 5678.858028549319, 9323.766905827408, 9422.434653920787, 9582.329236953346, 9597.856032159383, 9609.039096090615, 9114.31642626819, 9578.664746733832, 9617.134457898823, 9653.227741780782, 9654.469004204555, 6601.966990165019, 6815.0, 6863.245043045361, 7081.4334853210585, 7273.3817625500305, 7606.239376062349, 7732.226777322223, 7866.7639970800965, 7976.32201262876, 8016.118226995142, 7024.419505611197, 7138.785836424916, 7191.712331506681, 7246.855062898818, 7286.0, 6999.825004374931, 7007.404370628554, 7009.9649501752165, 7156.463265255231, 7211.783646490614, 6596.373344532261, 6729.158855143107, 6757.189137303555, 6757.256701762703, 6772.762953296611, 4844.660873738804, 4896.804127834846, 4913.28757330178, 4953.430355509018, 5020.3724534433195, 4809.893278634995, 4838.943449034076, 4905.583025442735, 5007.3240112584335, 5084.7966081356335], "value": 4399.630393503237, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.3354491651449, 346.1778276593091, 349.2334326154092, 349.34497816593904, 360.4989065199372, 4726.818295426144, 4853.131544355427, 5131.692098474095, 5173.844784656457, 5232.476752324776, 4796.280557916314, 4847.830325938593, 4965.230389289666, 5108.565771909382, 5113.386393632769, 3758.285925674113, 4039.9394009089815, 4042.0, 4049.7165198436123, 4076.2485322407406, 3570.982145089271, 3738.2336620992633, 3770.09517715749, 3932.705047121463, 4004.099077707507, 3175.300994154973, 3983.1635356575152, 4000.3199456092534, 4002.7198096133284, 4018.4976877890263, 3997.4603428537066, 4008.498937632796, 4037.0, 4040.171764788226, 4040.636342729139, 2751.8899244030213, 3327.73378129749, 3533.0460775590705, 3537.9386184144655, 3564.518789963348, 4051.3463681288804, 4458.487273963503, 4850.830220942285, 4927.457979622274, 4971.204607262856, 4536.8865778355475, 4547.977260113711, 4576.702514336557, 4577.679562430631, 4581.3128030795315, 4872.926906096376, 5036.489053284036, 5158.74206289684, 5320.973395133038, 5362.570994320445, 3599.3161299353037, 3896.8636097736726, 3901.4886602058373, 3917.2557214129224, 3920.6863450923856, 4894.657373983822, 5315.760790764386, 5487.256371814133, 5494.752736126884, 5593.636413633141, 3372.3592517422103, 3924.529056513237, 3999.460072890123, 4029.4560234367987, 4038.809340620877, 3773.8111295955423, 4107.0, 4108.157827645326, 4122.6083522065355, 4127.4634297541725, 3511.3504001759757, 4091.345384738487, 4183.3515805050265, 4581.541845815458, 4598.724076555417, 5389.27244821944, 5442.319710036246, 5449.863753406196, 5474.671519708831, 5476.616636835383, 1050.891309668292, 1147.1912301827192, 1237.560665963588, 1242.589945318043, 1249.5564074753331, 683.5795985468901, 795.2246559604339, 835.8579041562949, 851.2253848997383, 855.39267120344, 4202.2646036943415, 4301.741895486281, 4445.866624001285, 4830.855074347775, 4835.782389792468, 4329.484680361848, 4968.509447165836, 5251.4485978972425, 5295.0, 5300.628955973122, 4141.668666506672, 4481.507034226298, 4691.366665500182, 4754.524547545287, 4828.444728856156, 2571.2616063891896, 2606.83632584954, 2790.5116604594114, 2805.3968396794785, 2826.5194916864184, 4746.677325871903, 5088.491150884956, 5305.455798690377, 5471.671699698031, 5576.553875689935, 4704.411948506437, 4748.6438517111355, 4776.785044672998, 5075.8984820303385, 5169.741512924414, 5095.0, 5728.627639203439, 5788.421157884178, 5800.274965629296, 5822.214001109796, 5512.586556008235, 5588.960029589252, 5608.635438696635, 5609.512390087995, 5613.214150018919, 4634.606058484932, 4653.302004699322, 5442.755076021509, 5530.281063461724, 5531.976584331912, 4598.793054312631, 4779.928301075417, 5672.922144792641, 5703.372629010722, 5863.237779088691, 3741.4948981887096, 3767.3783825668456, 3776.4712940187846, 3777.1491968935575, 3777.1501412182038, 4661.417322834645, 5566.916496252478, 5615.410381909841, 5627.296587926509, 5639.661620302795, 4125.64931980785, 4832.275158726219, 5004.873903371712, 5086.033653605803, 5389.676619402849, 4549.044700612908, 4991.3511243538105, 5088.542031217208, 5427.457254274541, 5440.646357986719, 4678.461976872567, 4717.348927875353, 5056.696598203972, 5339.3058902344, 5362.946370536245, 4596.448426188745, 4700.670953033255, 4918.163912135017, 5133.435322114489, 5264.0, 4498.460184777848, 5338.224123455703, 5342.706151161723, 5354.303940487712, 5469.7027248554905], "value": 3914.59400863554, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.2951935642556, 721.6319676964753, 741.6217728958229, 761.8095476130964, 785.7721260834359, 10630.627928022512, 12660.303683297416, 12662.81005784914, 12693.682657933556, 12712.872871271296, 14017.088889222194, 14037.859621403783, 14061.437542498314, 14155.929220353884, 14192.006559540836, 854.4061876995476, 885.7874110213535, 888.5157589113949, 895.9875340864846, 896.7399454158286, 869.7521206456162, 873.68547322964, 878.8549889268263, 880.3177537408495, 881.8633111867639, 919.5218486387075, 924.0113079005467, 924.1036194890945, 925.1442415765424, 926.5922993882704, 916.6058594804232, 917.2249449215402, 918.7014220378337, 919.8574220995756, 921.2906062331967, 660.0693022837776, 679.7960611816435, 680.9761658341935, 683.9521233513656, 684.6268783512998, 15016.24918754058, 15291.694166116728, 15337.46318878845, 15342.539723808191, 15392.076475411512, 11135.944320278346, 13652.24912629805, 13908.280904098221, 14558.9080818939, 14611.707765844623, 10216.182705383551, 11046.21079445949, 11136.220464567483, 11314.830277545843, 11437.0, 3256.8208748518823, 3763.73653844231, 3793.5637401698605, 3855.7108216883566, 3931.3120203964477, 102809.48595256975, 103830.0, 104360.0, 104423.0, 105885.99999999923, 10923.00162806258, 11024.614138505114, 11177.776444471065, 11252.26860254081, 11487.13846461502, 23546.175883843982, 23553.528929421314, 23647.172348967702, 23660.408489787893, 23667.171648992204, 7837.412194085352, 7860.371170306362, 7889.0, 8011.519308841488, 8072.959635201786, 4220.177065472203, 4265.296226122717, 4298.9570104298555, 4300.440942677432, 4321.65426765858, 3286.5398844161837, 3442.1566716154703, 3447.413939630269, 3570.535830342091, 3773.1699026214187, 683.5864302097259, 689.217737867514, 691.629977961788, 693.1197379328225, 696.0186137546036, 625.2840497630187, 637.8341631175834, 638.543441439373, 641.6214433484266, 645.3707635055783, 8810.47137171759, 9087.591058402388, 9284.72145835626, 9416.90583094174, 9559.904400955902, 503.76326119377575, 588.349873389898, 607.4775692904099, 628.6793735194992, 645.8998855177455, 4565.474970378449, 4575.588197062214, 4576.084783043405, 4604.769761511978, 4615.9076818463445, 103173.48413257886, 104219.47890260651, 106621.0, 106687.0, 107914.46042769736, 69299.0, 84718.0, 85479.86300342542, 86783.0, 88550.0, 53120.93758124816, 64079.679601601696, 81563.0, 82055.17944820595, 82593.58703206565, 8786.912130878865, 8905.910940890508, 8958.28255646805, 9012.729618111467, 9076.912310168565, 43082.138357232056, 43571.128577428906, 43911.92616516813, 52167.2174917369, 53445.19832202442, 39524.2095158101, 54580.90838183294, 63891.0, 65535.34464655483, 66155.0, 12660.556880509139, 12682.239065656091, 12745.55390561363, 12843.0, 12918.870811291767, 14174.858251417354, 14267.143971361751, 14477.855221447651, 14481.338584251362, 14973.700525989638, 13383.74178420112, 13534.796978045533, 13535.729285414434, 13636.386362613905, 13780.65548361299, 13467.528636498067, 13511.354331023518, 13589.932050339685, 13654.0, 13667.043306968417, 13058.477660893457, 13266.0, 13300.600981970556, 13342.466301347837, 13365.39855706515, 10392.324498907547, 10592.682219533426, 10976.615818446317, 11418.942905285421, 11446.141539384413, 10355.171586272929, 10764.623238186627, 10988.058839347108, 11447.0, 11514.251573647685], "value": 7342.3239924942445, "unit": "score"}], "name": "dromaeo_css", "value": 7075.4784475470615, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 114.0, 115.0, 113.0, 112.0, 113.0, 114.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 109.0, 111.0, 144.0, 110.0, 122.0, 142.0, 141.0, 149.0, 110.0], "value": 127.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 184.0, 215.0, 261.0, 185.0, 185.0, 180.0, 182.0, 183.0, 184.0], "value": 194.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 59.0, 87.0, 61.0, 59.0, 63.0, 58.0, 74.0, 58.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 86.0, 68.0, 68.0, 69.0, 85.0, 69.0, 68.0, 82.0], "value": 75.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 111.0, 114.0, 111.0, 113.0, 111.0, 115.0, 111.0, 112.0], "value": 112.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 97.0, 95.0, 94.0, 96.0, 94.0, 96.0, 96.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 88.0, 87.0, 84.0, 86.0, 85.0, 86.0, 85.0], "value": 86.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 53.0, 53.0, 53.0, 55.0, 59.0, 77.0, 85.0, 78.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 81.0, 78.0, 73.0, 69.0, 70.0, 71.0, 71.0, 71.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 87.0, 90.0, 84.0, 79.0, 90.0, 95.0, 108.0, 83.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 150.0, 139.0, 139.0, 142.0, 141.0, 140.0, 140.0, 218.0, 158.0], "value": 152.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 176.0, 233.0, 228.0, 173.0, 172.0, 171.0, 173.0, 174.0], "value": 184.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 67.0, 67.0, 66.0, 66.0, 67.0, 67.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1497.3999999999999, "alertThreshold": 2.0}]} 08:40:49 INFO - Return code: 0 08:40:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:40:49 INFO - # TBPL SUCCESS # 08:40:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:40:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:40:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:40:49 INFO - 2016-12-19 08:40:49.269 screenresolution[1651:9796] starting screenresolution argv=screenresolution get 08:40:49 INFO - 2016-12-19 08:40:49.272 screenresolution[1651:9796] Display 0: 1600x1200x32@60 08:40:49 INFO - 2016-12-19 08:40:49.278 screenresolution[1652:9800] starting screenresolution argv=screenresolution list 08:40:49 INFO - Available Modes on Display 0 08:40:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:40:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:40:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:40:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:40:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:40:49 INFO - Intel Iris: 08:40:49 INFO - Chipset Model: Intel Iris 08:40:49 INFO - Type: GPU 08:40:49 INFO - Bus: Built-In 08:40:49 INFO - VRAM (Dynamic, Max): 1536 MB 08:40:49 INFO - Vendor: Intel (0x8086) 08:40:49 INFO - Device ID: 0x0a2e 08:40:49 INFO - Revision ID: 0x0009 08:40:49 INFO - Displays: 08:40:49 INFO - Display: 08:40:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:40:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:40:49 INFO - Display Serial Number: 1600x1200 60 08:40:49 INFO - Main Display: Yes 08:40:49 INFO - Mirror: Off 08:40:49 INFO - Online: Yes 08:40:49 INFO - Rotation: Supported 08:40:49 INFO - Return code: 0 08:40:49 INFO - Running post-action listener: _resource_record_post_action 08:40:49 INFO - [mozharness: 2016-12-19 16:40:49.512423Z] Finished run-tests step (success) 08:40:49 INFO - Running post-run listener: _resource_record_post_run 08:40:49 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 38712320; Write bytes: 549899776; Read time: 375; Write time: 1773 08:40:49 INFO - TinderboxPrint: CPU usage
53.6% 08:40:49 INFO - TinderboxPrint: I/O read bytes / time
38,712,320 / 375 08:40:49 INFO - TinderboxPrint: I/O write bytes / time
549,899,776 / 1,773 08:40:49 INFO - TinderboxPrint: CPU idle
2,231.4 (46.4%) 08:40:49 INFO - TinderboxPrint: CPU system
961.7 (20.0%) 08:40:49 INFO - TinderboxPrint: CPU user
1,616.5 (33.6%) 08:40:49 INFO - TinderboxPrint: Swap in / out
288,006,144 / 0 08:40:49 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 243495424; Write bytes: 236901888; Read time: 17675; Write time: 447 08:40:49 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 36615168; Write bytes: 297330688; Read time: 351; Write time: 1286 08:40:50 INFO - Running post-run listener: _upload_blobber_files 08:40:50 INFO - Blob upload gear active. 08:40:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:40:50 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 08:40:50 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:40:50 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:40:50 INFO - (blobuploader) - INFO - Open directory for files ... 08:40:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:40:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:40:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:51 INFO - (blobuploader) - INFO - Done attempting. 08:40:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:40:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:40:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:52 INFO - (blobuploader) - INFO - Done attempting. 08:40:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:40:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:40:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:53 INFO - (blobuploader) - INFO - Done attempting. 08:40:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:40:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:40:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:56 INFO - (blobuploader) - INFO - Done attempting. 08:40:56 INFO - (blobuploader) - INFO - Iteration through files over. 08:40:56 INFO - Return code: 0 08:40:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:40:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:40:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/447b3eec62f36e653b7247d8788797a5a0634d79bda29dc33b153e65adf8f8b76d6e4e33686bf2265d864536af0274c592eaebd8a93e2a2b758ac1082de519bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea4a6c1d92ddad2451eb4ecd46ef05441050659cc2ab70ccf869d17e8ec1c373b241a5905835d8b9851f8ff6f1695faf3c6a5c5eaf03ed98cc8b9fc2ebb3a1ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e45b0962311aee36df8cc39b6e7bb6007e1dabbe197884b7c0dc39ec747a77790f3116e612c679a1b84807997ab59ac223adf0e968c32c38385416d449b76eac", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f164e0c8f7cebe343bc4719e9fc8344b372ec4fcf36ec804c5fb99986e08a358217d36343cc08cc15886aa12490c0705a57b584cbbcbb03923e69a743dbbdafe"} 08:40:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:40:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:40:56 INFO - Contents: 08:40:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/447b3eec62f36e653b7247d8788797a5a0634d79bda29dc33b153e65adf8f8b76d6e4e33686bf2265d864536af0274c592eaebd8a93e2a2b758ac1082de519bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea4a6c1d92ddad2451eb4ecd46ef05441050659cc2ab70ccf869d17e8ec1c373b241a5905835d8b9851f8ff6f1695faf3c6a5c5eaf03ed98cc8b9fc2ebb3a1ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e45b0962311aee36df8cc39b6e7bb6007e1dabbe197884b7c0dc39ec747a77790f3116e612c679a1b84807997ab59ac223adf0e968c32c38385416d449b76eac", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f164e0c8f7cebe343bc4719e9fc8344b372ec4fcf36ec804c5fb99986e08a358217d36343cc08cc15886aa12490c0705a57b584cbbcbb03923e69a743dbbdafe"} 08:40:56 INFO - Running post-run listener: copy_logs_to_upload_dir 08:40:56 INFO - Copying logs to upload dir... 08:40:56 INFO - mkdir: /builds/slave/test/build/upload/logs 08:40:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.986426 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-12-19 08:40:56.175828) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 08:40:56.179306) ========= 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.LTN5OYCo12/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.6ycGZV5GUC/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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/Firefox/sha512/447b3eec62f36e653b7247d8788797a5a0634d79bda29dc33b153e65adf8f8b76d6e4e33686bf2265d864536af0274c592eaebd8a93e2a2b758ac1082de519bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea4a6c1d92ddad2451eb4ecd46ef05441050659cc2ab70ccf869d17e8ec1c373b241a5905835d8b9851f8ff6f1695faf3c6a5c5eaf03ed98cc8b9fc2ebb3a1ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e45b0962311aee36df8cc39b6e7bb6007e1dabbe197884b7c0dc39ec747a77790f3116e612c679a1b84807997ab59ac223adf0e968c32c38385416d449b76eac", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f164e0c8f7cebe343bc4719e9fc8344b372ec4fcf36ec804c5fb99986e08a358217d36343cc08cc15886aa12490c0705a57b584cbbcbb03923e69a743dbbdafe"} build_url:https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010849 build_url: 'https://queue.taskcluster.net/v1/task/YU_5Wz-ZRxqhJfdP-IwjMg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/447b3eec62f36e653b7247d8788797a5a0634d79bda29dc33b153e65adf8f8b76d6e4e33686bf2265d864536af0274c592eaebd8a93e2a2b758ac1082de519bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea4a6c1d92ddad2451eb4ecd46ef05441050659cc2ab70ccf869d17e8ec1c373b241a5905835d8b9851f8ff6f1695faf3c6a5c5eaf03ed98cc8b9fc2ebb3a1ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e45b0962311aee36df8cc39b6e7bb6007e1dabbe197884b7c0dc39ec747a77790f3116e612c679a1b84807997ab59ac223adf0e968c32c38385416d449b76eac", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f164e0c8f7cebe343bc4719e9fc8344b372ec4fcf36ec804c5fb99986e08a358217d36343cc08cc15886aa12490c0705a57b584cbbcbb03923e69a743dbbdafe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 08:40:56.215097) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 08:40:56.215462) ========= 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.LTN5OYCo12/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.6ycGZV5GUC/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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.005224 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 08:40:56.265006) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 08:40:56.265370) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 08:40:56.265739) ========= ========= Total master_lag: 0.94 =========