builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0297 starttime: 1484355412.8 results: success (0) buildid: 20170113152824 builduid: 3a13c0d5d6c24f1c9da91e7d55f2bbd1 revision: 671a2f8542cadcf9aad318ab76250a730a03b240 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 16:56:52.800678) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 16:56:52.801180) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 16:56:52.801466) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 16:56:52.828426) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 16:56:52.828880) ========= 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.cUtvhf90KY/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.u6q4Bv852e/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-13 16:56:52-- 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% 19.4M=0.001s 2017-01-13 16:56:52 (19.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134542 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 16:56:52.987847) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 16:56:52.988197) ========= 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.cUtvhf90KY/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.u6q4Bv852e/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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.024841 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 16:56:53.036906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-13 16:56:53.037264) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 671a2f8542cadcf9aad318ab76250a730a03b240 --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 671a2f8542cadcf9aad318ab76250a730a03b240 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cUtvhf90KY/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.u6q4Bv852e/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-13 16:56:53,139 truncating revision to first 12 chars 2017-01-13 16:56:53,139 Setting DEBUG logging. 2017-01-13 16:56:53,139 attempt 1/10 2017-01-13 16:56:53,139 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/671a2f8542ca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-13 16:56:54,925 unpacking tar archive at: mozilla-central-671a2f8542ca/testing/mozharness/ program finished with exit code 0 elapsedTime=2.055525 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-13 16:56:55.113418) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 16:56:55.113773) ========= script_repo_revision: 671a2f8542cadcf9aad318ab76250a730a03b240 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 16:56:55.114273) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 16:56:55.114595) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 16:56:55.133272) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-13 16:56:55.133730) ========= /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.cUtvhf90KY/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.u6q4Bv852e/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 16:56:55 INFO - MultiFileLogger online at 20170113 16:56:55 in /builds/slave/test 16:56:55 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 16:56:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:56:55 INFO - {'append_to_log': False, 16:56:55 INFO - 'base_work_dir': '/builds/slave/test', 16:56:55 INFO - 'blob_upload_branch': 'Firefox', 16:56:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:56:55 INFO - 'branch': 'Firefox', 16:56:55 INFO - 'buildbot_json_path': 'buildprops.json', 16:56:55 INFO - 'config_files': ('talos/mac_config.py',), 16:56:55 INFO - 'default_actions': ('clobber', 16:56:55 INFO - 'read-buildbot-config', 16:56:55 INFO - 'download-and-extract', 16:56:55 INFO - 'populate-webroot', 16:56:55 INFO - 'create-virtualenv', 16:56:55 INFO - 'install', 16:56:55 INFO - 'run-tests'), 16:56:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:56:55 INFO - 'download_minidump_stackwalk': True, 16:56:55 INFO - 'download_symbols': 'ondemand', 16:56:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:56:55 INFO - 'tooltool.py': '/tools/tooltool.py', 16:56:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:56:55 INFO - '/tools/misc-python/virtualenv.py')}, 16:56:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:56:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:56:55 INFO - 'installer_path': 'installer.exe', 16:56:55 INFO - 'log_level': 'info', 16:56:55 INFO - 'log_name': 'talos', 16:56:55 INFO - 'log_to_console': True, 16:56:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:56:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:56:55 INFO - 'opt_config_files': (), 16:56:55 INFO - 'pip_index': False, 16:56:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:56:55 INFO - 'cmd': ('bash', 16:56:55 INFO - '-c', 16:56:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:56:55 INFO - 'enabled': True, 16:56:55 INFO - 'halt_on_failure': False, 16:56:55 INFO - 'name': 'check_screen_resolution'},), 16:56:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:56:55 INFO - 'cmd': ('bash', 16:56:55 INFO - '-c', 16:56:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:56:55 INFO - 'enabled': True, 16:56:55 INFO - 'halt_on_failure': False, 16:56:55 INFO - 'name': 'check_screen_resolution'},), 16:56:55 INFO - 'run_cmd_checks_enabled': True, 16:56:55 INFO - 'sps_profile': False, 16:56:55 INFO - 'sps_profile_interval': 0, 16:56:55 INFO - 'suite': 'dromaeojs', 16:56:55 INFO - 'system_bits': '32', 16:56:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:56:55 INFO - 'title': 't-yosemite-r7-0297', 16:56:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:56:55 INFO - 'use_talos_json': True, 16:56:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:56:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:56:55 INFO - 'work_dir': 'build'} 16:56:55 INFO - [mozharness: 2017-01-14 00:56:55.333739Z] Running clobber step. 16:56:55 INFO - Running pre-action listener: _resource_record_pre_action 16:56:55 INFO - Running main action method: clobber 16:56:55 INFO - rmtree: /builds/slave/test/build 16:56:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:56:57 INFO - Running post-action listener: _resource_record_post_action 16:56:57 INFO - [mozharness: 2017-01-14 00:56:57.728323Z] Finished clobber step (success) 16:56:57 INFO - [mozharness: 2017-01-14 00:56:57.728576Z] Running read-buildbot-config step. 16:56:57 INFO - Running pre-action listener: _resource_record_pre_action 16:56:57 INFO - Running main action method: read_buildbot_config 16:56:57 INFO - Using buildbot properties: 16:56:57 INFO - { 16:56:57 INFO - "project": "", 16:56:57 INFO - "product": "firefox", 16:56:57 INFO - "script_repo_revision": "production", 16:56:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 16:56:57 INFO - "repository": "", 16:56:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 16:56:57 INFO - "buildid": "20170113152824", 16:56:57 INFO - "pgo_build": "False", 16:56:57 INFO - "basedir": "/builds/slave/test", 16:56:57 INFO - "buildnumber": 13, 16:56:57 INFO - "slavename": "t-yosemite-r7-0297", 16:56:57 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 16:56:57 INFO - "platform": "yosemite_r7", 16:56:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:56:57 INFO - "branch": "mozilla-central", 16:56:57 INFO - "repo_path": "mozilla-central", 16:56:57 INFO - "revision": "671a2f8542cadcf9aad318ab76250a730a03b240", 16:56:57 INFO - "stage_platform": "macosx64", 16:56:57 INFO - "builduid": "3a13c0d5d6c24f1c9da91e7d55f2bbd1", 16:56:57 INFO - "slavebuilddir": "test" 16:56:57 INFO - } 16:56:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/F3mOtD_FTWiQqkVXMdG79A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 16:56:57 INFO - Running post-action listener: _resource_record_post_action 16:56:57 INFO - [mozharness: 2017-01-14 00:56:57.734296Z] Finished read-buildbot-config step (success) 16:56:57 INFO - [mozharness: 2017-01-14 00:56:57.734437Z] Running download-and-extract step. 16:56:57 INFO - Running pre-action listener: _resource_record_pre_action 16:56:57 INFO - Running main action method: download_and_extract 16:56:57 INFO - mkdir: /builds/slave/test/build/tests 16:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:57 INFO - trying https://queue.taskcluster.net/v1/task/F3mOtD_FTWiQqkVXMdG79A/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 16:56:57 INFO - Downloading https://queue.taskcluster.net/v1/task/F3mOtD_FTWiQqkVXMdG79A/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 16:56:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F3mOtD_FTWiQqkVXMdG79A/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 16:56:59 INFO - Downloaded 1199 bytes. 16:56:59 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 16:56:59 INFO - Using the following test package requirements: 16:56:59 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 16:56:59 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:56:59 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 16:56:59 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:56:59 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 16:56:59 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:56:59 INFO - u'jsshell-mac.zip'], 16:56:59 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:56:59 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 16:56:59 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 16:56:59 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:56:59 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 16:56:59 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:56:59 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 16:56:59 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:56:59 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 16:56:59 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:56:59 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 16:56:59 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:56:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F3mOtD_FTWiQqkVXMdG79A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 16:56:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F3mOtD_FTWiQqkVXMdG79A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:56:59 INFO - Fetch https://queue.taskcluster.net/v1/task/F3mOtD_FTWiQqkVXMdG79A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 16:57:00 INFO - Expected file size: 16316917 16:57:00 INFO - Obtained file size: 16316917 16:57:06 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 16:57:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F3mOtD_FTWiQqkVXMdG79A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 16:57:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F3mOtD_FTWiQqkVXMdG79A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:57:06 INFO - Fetch https://queue.taskcluster.net/v1/task/F3mOtD_FTWiQqkVXMdG79A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 16:57:07 INFO - Expected file size: 16316917 16:57:07 INFO - Obtained file size: 16316917 16:57:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F3mOtD_FTWiQqkVXMdG79A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 16:57:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F3mOtD_FTWiQqkVXMdG79A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:57:13 INFO - Fetch https://queue.taskcluster.net/v1/task/F3mOtD_FTWiQqkVXMdG79A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 16:57:14 INFO - Expected file size: 14403555 16:57:14 INFO - Obtained file size: 14403555 16:57:14 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')]} 16:57:14 INFO - trying https://queue.taskcluster.net/v1/task/F3mOtD_FTWiQqkVXMdG79A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 16:57:14 INFO - Downloading https://queue.taskcluster.net/v1/task/F3mOtD_FTWiQqkVXMdG79A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 16:57:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F3mOtD_FTWiQqkVXMdG79A/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 16:57:16 INFO - Downloaded 70069357 bytes. 16:57:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F3mOtD_FTWiQqkVXMdG79A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 16:57:16 INFO - mkdir: /builds/slave/test/properties 16:57:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:57:16 INFO - Writing to file /builds/slave/test/properties/build_url 16:57:16 INFO - Contents: 16:57:16 INFO - build_url:https://queue.taskcluster.net/v1/task/F3mOtD_FTWiQqkVXMdG79A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 16:57:17 INFO - Running post-action listener: _resource_record_post_action 16:57:17 INFO - Running post-action listener: set_extra_try_arguments 16:57:17 INFO - [mozharness: 2017-01-14 00:57:17.555408Z] Finished download-and-extract step (success) 16:57:17 INFO - [mozharness: 2017-01-14 00:57:17.555530Z] Running populate-webroot step. 16:57:17 INFO - Running pre-action listener: _resource_record_pre_action 16:57:17 INFO - Running main action method: populate_webroot 16:57:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:57:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:57:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:57:17 INFO - '--tppagecycles', 16:57:17 INFO - '7'], 16:57:17 INFO - 'tests': ['tsvgm']}}, 16:57:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:57:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:57:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:57:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:57:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:57:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:57:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:57:17 INFO - 'talos_options': ['--disable-e10s'], 16:57:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:57:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:57:17 INFO - 'talos_options': ['--disable-e10s'], 16:57:17 INFO - 'tests': ['damp', 'tps']}, 16:57:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:57:17 INFO - 'tests': ['damp', 'tps']}, 16:57:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:57:17 INFO - 'tests': ['dromaeo_dom']}, 16:57:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:57:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:57:17 INFO - 'tests': ['basic_compositor_video']}, 16:57:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:57:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:57:17 INFO - 'tests': ['a11yr', 16:57:17 INFO - 'ts_paint', 16:57:17 INFO - 'tpaint', 16:57:17 INFO - 'sessionrestore', 16:57:17 INFO - 'sessionrestore_no_auto_restore', 16:57:17 INFO - 'tabpaint']}, 16:57:17 INFO - 'other-e10s': {'tests': ['a11yr', 16:57:17 INFO - 'ts_paint', 16:57:17 INFO - 'tpaint', 16:57:17 INFO - 'sessionrestore', 16:57:17 INFO - 'sessionrestore_no_auto_restore', 16:57:17 INFO - 'tabpaint']}, 16:57:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:57:17 INFO - 'ts_paint', 16:57:17 INFO - 'tpaint', 16:57:17 INFO - 'sessionrestore', 16:57:17 INFO - 'sessionrestore_no_auto_restore', 16:57:17 INFO - 'tabpaint']}, 16:57:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:57:17 INFO - 'ts_paint', 16:57:17 INFO - 'tpaint', 16:57:17 INFO - 'sessionrestore', 16:57:17 INFO - 'sessionrestore_no_auto_restore', 16:57:17 INFO - 'tabpaint']}, 16:57:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:57:17 INFO - 'tests': ['a11yr', 16:57:17 INFO - 'ts_paint', 16:57:17 INFO - 'tpaint', 16:57:17 INFO - 'sessionrestore', 16:57:17 INFO - 'sessionrestore_no_auto_restore', 16:57:17 INFO - 'tabpaint']}, 16:57:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:57:17 INFO - 'tests': ['a11yr', 16:57:17 INFO - 'ts_paint', 16:57:17 INFO - 'tpaint', 16:57:17 INFO - 'sessionrestore', 16:57:17 INFO - 'sessionrestore_no_auto_restore', 16:57:17 INFO - 'tabpaint']}, 16:57:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:57:17 INFO - 'tests': ['tsvgx', 16:57:17 INFO - 'tsvgr_opacity', 16:57:17 INFO - 'tart', 16:57:17 INFO - 'tscrollx', 16:57:17 INFO - 'cart', 16:57:17 INFO - 'tsvg_static']}, 16:57:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:57:17 INFO - 'tsvgr_opacity', 16:57:17 INFO - 'tart', 16:57:17 INFO - 'tscrollx', 16:57:17 INFO - 'cart', 16:57:17 INFO - 'tsvg_static']}, 16:57:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:57:17 INFO - 'talos_options': ['--disable-e10s'], 16:57:17 INFO - 'tests': ['tp5o']}, 16:57:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:57:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:57:17 INFO - 'talos_options': ['--disable-e10s', 16:57:17 INFO - '--xperf_path', 16:57:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:17 INFO - 'tests': ['tp5n']}, 16:57:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:57:17 INFO - 'talos_options': ['--xperf_path', 16:57:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:17 INFO - 'tests': ['tp5n']}}, 16:57:17 INFO - 'talos.zip': {'path': '', 16:57:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:57:17 INFO - Running post-action listener: _resource_record_post_action 16:57:17 INFO - [mozharness: 2017-01-14 00:57:17.574146Z] Finished populate-webroot step (success) 16:57:17 INFO - [mozharness: 2017-01-14 00:57:17.574261Z] Running create-virtualenv step. 16:57:17 INFO - Running pre-action listener: _resource_record_pre_action 16:57:17 INFO - Running main action method: create_virtualenv 16:57:17 INFO - Creating virtualenv /builds/slave/test/build/venv 16:57:17 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 16:57:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:57:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:57:17 INFO - Using real prefix '/tools/python27' 16:57:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:57:18 INFO - Installing distribute.............................................................................................................................................................................................done. 16:57:21 INFO - Installing pip.................done. 16:57:21 INFO - Return code: 0 16:57:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:57:21 INFO - Reading from file tmpfile_stdout 16:57:21 INFO - Output received: 16:57:21 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) 16:57:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:57:21 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')]} 16:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:21 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')]} 16:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:21 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 0x107774b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107777768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81a9d77dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107552d30>, '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 0x107479db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107547be8>, '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.cUtvhf90KY/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.u6q4Bv852e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 16:57:21 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 16:57:21 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 16:57:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cUtvhf90KY/Render', 16:57:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:21 INFO - 'HOME': '/Users/cltbld', 16:57:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:21 INFO - 'LOGNAME': 'cltbld', 16:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:21 INFO - 'MOZ_NO_REMOTE': '1', 16:57:21 INFO - 'NO_EM_RESTART': '1', 16:57:21 INFO - 'PAGER': '/bin/cat', 16:57:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:21 INFO - 'PWD': '/builds/slave/test', 16:57:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:21 INFO - 'SHELL': '/bin/bash', 16:57:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6q4Bv852e/Listeners', 16:57:21 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 16:57:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:21 INFO - 'USER': 'cltbld', 16:57:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:21 INFO - 'XPC_FLAGS': '0x0', 16:57:21 INFO - 'XPC_SERVICE_NAME': '0', 16:57:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:21 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 16:57:21 INFO - Cleaning up... 16:57:21 INFO - Return code: 0 16:57:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:57:21 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')]} 16:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:21 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')]} 16:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:21 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 0x107774b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107777768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81a9d77dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107552d30>, '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 0x107479db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107547be8>, '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.cUtvhf90KY/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.u6q4Bv852e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 16:57:21 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 16:57:21 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 16:57:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cUtvhf90KY/Render', 16:57:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:21 INFO - 'HOME': '/Users/cltbld', 16:57:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:21 INFO - 'LOGNAME': 'cltbld', 16:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:21 INFO - 'MOZ_NO_REMOTE': '1', 16:57:21 INFO - 'NO_EM_RESTART': '1', 16:57:21 INFO - 'PAGER': '/bin/cat', 16:57:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:21 INFO - 'PWD': '/builds/slave/test', 16:57:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:21 INFO - 'SHELL': '/bin/bash', 16:57:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6q4Bv852e/Listeners', 16:57:21 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 16:57:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:21 INFO - 'USER': 'cltbld', 16:57:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:21 INFO - 'XPC_FLAGS': '0x0', 16:57:21 INFO - 'XPC_SERVICE_NAME': '0', 16:57:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:22 INFO - Downloading/unpacking psutil>=3.1.1 16:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:57:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:25 INFO - Installing collected packages: psutil 16:57:25 INFO - Running setup.py install for psutil 16:57:25 INFO - building 'psutil._psutil_osx' extension 16:57:25 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 16:57:26 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 16:57:26 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 16:57:26 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 16:57:26 INFO - building 'psutil._psutil_posix' extension 16:57:26 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 16:57:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:57:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:57:26 INFO - ^ 16:57:26 INFO - 1 warning generated. 16:57:26 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 16:57:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:26 INFO - Successfully installed psutil 16:57:26 INFO - Cleaning up... 16:57:26 INFO - Return code: 0 16:57:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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')]} 16:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:26 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 0x107774b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107777768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81a9d77dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107552d30>, '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 0x107479db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107547be8>, '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.cUtvhf90KY/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.u6q4Bv852e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 16:57:26 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 16:57:26 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 16:57:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cUtvhf90KY/Render', 16:57:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:26 INFO - 'HOME': '/Users/cltbld', 16:57:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:26 INFO - 'LOGNAME': 'cltbld', 16:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:26 INFO - 'MOZ_NO_REMOTE': '1', 16:57:26 INFO - 'NO_EM_RESTART': '1', 16:57:26 INFO - 'PAGER': '/bin/cat', 16:57:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:26 INFO - 'PWD': '/builds/slave/test', 16:57:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:26 INFO - 'SHELL': '/bin/bash', 16:57:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6q4Bv852e/Listeners', 16:57:26 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 16:57:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:26 INFO - 'USER': 'cltbld', 16:57:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:26 INFO - 'XPC_FLAGS': '0x0', 16:57:26 INFO - 'XPC_SERVICE_NAME': '0', 16:57:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:57: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 16:57: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 16:57: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 16:57: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 16:57: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 16:57: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 16:57:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:57:29 INFO - Installing collected packages: mozsystemmonitor 16:57:29 INFO - Running setup.py install for mozsystemmonitor 16:57:29 INFO - Successfully installed mozsystemmonitor 16:57:29 INFO - Cleaning up... 16:57:29 INFO - Return code: 0 16:57:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107774b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107777768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81a9d77dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107552d30>, '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 0x107479db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107547be8>, '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.cUtvhf90KY/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.u6q4Bv852e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 16:57:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:57:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cUtvhf90KY/Render', 16:57:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:29 INFO - 'HOME': '/Users/cltbld', 16:57:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:29 INFO - 'LOGNAME': 'cltbld', 16:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:29 INFO - 'MOZ_NO_REMOTE': '1', 16:57:29 INFO - 'NO_EM_RESTART': '1', 16:57:29 INFO - 'PAGER': '/bin/cat', 16:57:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:29 INFO - 'PWD': '/builds/slave/test', 16:57:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:29 INFO - 'SHELL': '/bin/bash', 16:57:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6q4Bv852e/Listeners', 16:57:29 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 16:57:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:29 INFO - 'USER': 'cltbld', 16:57:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:29 INFO - 'XPC_FLAGS': '0x0', 16:57:29 INFO - 'XPC_SERVICE_NAME': '0', 16:57:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:30 INFO - Downloading/unpacking jsonschema==2.5.1 16:57: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 16:57: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 16:57: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 16:57: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 16:57: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 16:57: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 16:57:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:57:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:33 INFO - Downloading functools32-3.2.3-2.tar.gz 16:57:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:57:33 INFO - warning: no files found matching '*.txt' 16:57:33 INFO - no previously-included directories found matching 'build' 16:57:33 INFO - no previously-included directories found matching 'dist' 16:57:33 INFO - no previously-included directories found matching '.git*' 16:57:33 INFO - Installing collected packages: jsonschema, functools32 16:57:33 INFO - Running setup.py install for functools32 16:57:33 INFO - warning: no files found matching '*.txt' 16:57:33 INFO - no previously-included directories found matching 'build' 16:57:33 INFO - no previously-included directories found matching 'dist' 16:57:33 INFO - no previously-included directories found matching '.git*' 16:57:33 INFO - Successfully installed jsonschema functools32 16:57:33 INFO - Cleaning up... 16:57:33 INFO - Return code: 0 16:57:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:33 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 0x107774b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107777768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81a9d77dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107552d30>, '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 0x107479db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107547be8>, '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.cUtvhf90KY/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.u6q4Bv852e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 16:57:33 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 16:57:33 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 16:57:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cUtvhf90KY/Render', 16:57:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:33 INFO - 'HOME': '/Users/cltbld', 16:57:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:33 INFO - 'LOGNAME': 'cltbld', 16:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:33 INFO - 'MOZ_NO_REMOTE': '1', 16:57:33 INFO - 'NO_EM_RESTART': '1', 16:57:33 INFO - 'PAGER': '/bin/cat', 16:57:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:33 INFO - 'PWD': '/builds/slave/test', 16:57:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:33 INFO - 'SHELL': '/bin/bash', 16:57:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6q4Bv852e/Listeners', 16:57:33 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 16:57:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:33 INFO - 'USER': 'cltbld', 16:57:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:33 INFO - 'XPC_FLAGS': '0x0', 16:57:33 INFO - 'XPC_SERVICE_NAME': '0', 16:57:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:57:33 INFO - Cleaning up... 16:57:33 INFO - Return code: 0 16:57:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:33 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 0x107774b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107777768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81a9d77dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107552d30>, '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 0x107479db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107547be8>, '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.cUtvhf90KY/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.u6q4Bv852e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 16:57:33 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 16:57:33 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 16:57:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cUtvhf90KY/Render', 16:57:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:33 INFO - 'HOME': '/Users/cltbld', 16:57:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:33 INFO - 'LOGNAME': 'cltbld', 16:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:33 INFO - 'MOZ_NO_REMOTE': '1', 16:57:33 INFO - 'NO_EM_RESTART': '1', 16:57:33 INFO - 'PAGER': '/bin/cat', 16:57:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:33 INFO - 'PWD': '/builds/slave/test', 16:57:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:33 INFO - 'SHELL': '/bin/bash', 16:57:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6q4Bv852e/Listeners', 16:57:33 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 16:57:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:33 INFO - 'USER': 'cltbld', 16:57:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:33 INFO - 'XPC_FLAGS': '0x0', 16:57:33 INFO - 'XPC_SERVICE_NAME': '0', 16:57:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:34 INFO - Downloading/unpacking blobuploader==1.2.4 16:57: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 16:57: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 16:57: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 16:57: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 16:57: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 16:57: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 16:57:36 INFO - Downloading blobuploader-1.2.4.tar.gz 16:57:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:57:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:57:36 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 16:57:36 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 16:57:36 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 16:57:36 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 16:57:36 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 16:57:36 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 16:57:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:57:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:57:37 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 16:57:37 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 16:57:37 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 16:57:37 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 16:57:37 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 16:57:37 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 16:57:37 INFO - Downloading docopt-0.6.1.tar.gz 16:57:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:57:38 INFO - Installing collected packages: blobuploader, requests, docopt 16:57:38 INFO - Running setup.py install for blobuploader 16:57:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:57:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:57:38 INFO - Running setup.py install for requests 16:57:38 INFO - Running setup.py install for docopt 16:57:38 INFO - Successfully installed blobuploader requests docopt 16:57:38 INFO - Cleaning up... 16:57:38 INFO - Return code: 0 16:57:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:38 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 0x107774b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107777768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81a9d77dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107552d30>, '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 0x107479db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107547be8>, '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.cUtvhf90KY/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.u6q4Bv852e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 16:57:38 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 16:57:38 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 16:57:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cUtvhf90KY/Render', 16:57:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:38 INFO - 'HOME': '/Users/cltbld', 16:57:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:38 INFO - 'LOGNAME': 'cltbld', 16:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:38 INFO - 'MOZ_NO_REMOTE': '1', 16:57:38 INFO - 'NO_EM_RESTART': '1', 16:57:38 INFO - 'PAGER': '/bin/cat', 16:57:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:38 INFO - 'PWD': '/builds/slave/test', 16:57:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:38 INFO - 'SHELL': '/bin/bash', 16:57:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6q4Bv852e/Listeners', 16:57:38 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 16:57:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:38 INFO - 'USER': 'cltbld', 16:57:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:38 INFO - 'XPC_FLAGS': '0x0', 16:57:38 INFO - 'XPC_SERVICE_NAME': '0', 16:57:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:57:39 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-YcryPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:57:39 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-hnyxFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:57:39 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-p5pZqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:57:39 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-Gzw4GL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:57:39 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-LptvfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:57:39 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-SHOFwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:57:39 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-n3Vbds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:57:39 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-WGmR5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:57:40 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-tRiFo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:57:40 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-P1Vbyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:57:40 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-1eEryU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:57:40 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-eaDHcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:57:40 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-9Bl8UM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:57:40 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-lTprzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:40 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-hdK1Zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:57:40 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-rUXEtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:57:40 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-TxXhmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:57:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:57:40 INFO - Running setup.py install for manifestparser 16:57:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:57:41 INFO - Running setup.py install for mozcrash 16:57:41 INFO - Running setup.py install for mozdebug 16:57:41 INFO - Running setup.py install for mozdevice 16:57:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:57:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:57:41 INFO - Running setup.py install for mozfile 16:57:41 INFO - Running setup.py install for mozhttpd 16:57:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:57:41 INFO - Running setup.py install for mozinfo 16:57:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:57:42 INFO - Running setup.py install for mozInstall 16:57:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:57:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:57:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:57:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:57:42 INFO - Running setup.py install for mozleak 16:57:42 INFO - Running setup.py install for mozlog 16:57:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:57:42 INFO - Running setup.py install for moznetwork 16:57:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:57:42 INFO - Running setup.py install for mozprocess 16:57:42 INFO - Running setup.py install for mozprofile 16:57:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:57:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:57:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:57:42 INFO - Running setup.py install for mozrunner 16:57:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:57:43 INFO - Running setup.py install for mozscreenshot 16:57:43 INFO - Running setup.py install for moztest 16:57:43 INFO - Running setup.py install for mozversion 16:57:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:57:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:57:43 INFO - Cleaning up... 16:57:43 INFO - Return code: 0 16:57:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:43 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 0x107774b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107777768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81a9d77dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107552d30>, '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 0x107479db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107547be8>, '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.cUtvhf90KY/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.u6q4Bv852e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 16:57:43 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 16:57:43 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 16:57:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cUtvhf90KY/Render', 16:57:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:43 INFO - 'HOME': '/Users/cltbld', 16:57:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:43 INFO - 'LOGNAME': 'cltbld', 16:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:43 INFO - 'MOZ_NO_REMOTE': '1', 16:57:43 INFO - 'NO_EM_RESTART': '1', 16:57:43 INFO - 'PAGER': '/bin/cat', 16:57:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:43 INFO - 'PWD': '/builds/slave/test', 16:57:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:43 INFO - 'SHELL': '/bin/bash', 16:57:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6q4Bv852e/Listeners', 16:57:43 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 16:57:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:43 INFO - 'USER': 'cltbld', 16:57:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:43 INFO - 'XPC_FLAGS': '0x0', 16:57:43 INFO - 'XPC_SERVICE_NAME': '0', 16:57:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:57:43 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-1kf67x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:57:43 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)) 16:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:57:43 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-2bmcJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:57:44 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)) 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:57:44 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-8Q9Na8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:57:44 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)) 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:57:44 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-4I5Tsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:57:44 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)) 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:57:44 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-gDE4A5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:57:44 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)) 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:57:44 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-ujZRzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:57:44 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)) 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:57:44 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-k5h_Q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:57:44 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)) 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:57:44 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-qiXeIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:57:44 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)) 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:57:44 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-bv78d9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:57:44 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)) 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:57:44 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-CCf2Nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:57:44 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)) 16:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:57:44 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-wqJIKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:57:45 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)) 16:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:57:45 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-p5Y4Fz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:57:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:57:45 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-mwqYTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:57:45 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)) 16:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:57:45 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-UjKwd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:57:45 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)) 16:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:45 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-uwEPfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:45 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)) 16:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:57:45 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-F9I_Ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:57:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:57:45 INFO - Running setup.py (path:/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/pip-HWnZnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:57:45 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)) 16:57:45 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)) 16:57:45 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)) 16:57:45 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)) 16:57:45 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)) 16:57:45 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)) 16:57:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:48 INFO - Downloading blessings-1.6.tar.gz 16:57:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:57:48 INFO - Installing collected packages: blessings 16:57:48 INFO - Running setup.py install for blessings 16:57:48 INFO - Successfully installed blessings 16:57:48 INFO - Cleaning up... 16:57:48 INFO - Return code: 0 16:57:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:57:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:57:48 INFO - Reading from file tmpfile_stdout 16:57:48 INFO - Current package versions: 16:57:48 INFO - blessings == 1.6 16:57:48 INFO - blobuploader == 1.2.4 16:57:48 INFO - docopt == 0.6.1 16:57:48 INFO - functools32 == 3.2.3-2 16:57:48 INFO - jsonschema == 2.5.1 16:57:48 INFO - manifestparser == 1.1 16:57:48 INFO - mozInstall == 1.12 16:57:48 INFO - mozcrash == 1.0 16:57:48 INFO - mozdebug == 0.1 16:57:48 INFO - mozdevice == 0.49 16:57:48 INFO - mozfile == 1.2 16:57:48 INFO - mozhttpd == 0.7 16:57:48 INFO - mozinfo == 0.9 16:57:48 INFO - mozleak == 0.1 16:57:48 INFO - mozlog == 3.4 16:57:48 INFO - moznetwork == 0.27 16:57:48 INFO - mozprocess == 0.24 16:57:48 INFO - mozprofile == 0.28 16:57:48 INFO - mozrunner == 6.13 16:57:48 INFO - mozscreenshot == 0.1 16:57:48 INFO - mozsystemmonitor == 0.3 16:57:48 INFO - moztest == 0.8 16:57:48 INFO - mozversion == 1.4 16:57:48 INFO - psutil == 3.1.1 16:57:48 INFO - requests == 1.2.3 16:57:48 INFO - wsgiref == 0.1.2 16:57:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:49 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')]} 16:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:49 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 0x107774b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107777768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81a9d77dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107552d30>, '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 0x107479db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107547be8>, '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.cUtvhf90KY/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.u6q4Bv852e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 16:57:49 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 16:57:49 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 16:57:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cUtvhf90KY/Render', 16:57:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:49 INFO - 'HOME': '/Users/cltbld', 16:57:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:49 INFO - 'LOGNAME': 'cltbld', 16:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:49 INFO - 'MOZ_NO_REMOTE': '1', 16:57:49 INFO - 'NO_EM_RESTART': '1', 16:57:49 INFO - 'PAGER': '/bin/cat', 16:57:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:49 INFO - 'PWD': '/builds/slave/test', 16:57:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:49 INFO - 'SHELL': '/bin/bash', 16:57:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6q4Bv852e/Listeners', 16:57:49 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 16:57:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:49 INFO - 'USER': 'cltbld', 16:57:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:49 INFO - 'XPC_FLAGS': '0x0', 16:57:49 INFO - 'XPC_SERVICE_NAME': '0', 16:57:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:49 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)) 16:57:49 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)) 16:57:49 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)) 16:57:49 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)) 16:57:49 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)) 16:57:49 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)) 16:57:49 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)) 16:57:49 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)) 16:57:49 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)) 16:57:49 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)) 16:57:49 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)) 16:57:49 INFO - Cleaning up... 16:57:49 INFO - Return code: 0 16:57:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:57:49 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')]} 16:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:49 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')]} 16:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107774b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107777768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81a9d77dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107552d30>, '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 0x107479db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107547be8>, '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.cUtvhf90KY/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.u6q4Bv852e/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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 16:57:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:57:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:57:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cUtvhf90KY/Render', 16:57:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:50 INFO - 'HOME': '/Users/cltbld', 16:57:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:50 INFO - 'LOGNAME': 'cltbld', 16:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:50 INFO - 'MOZ_NO_REMOTE': '1', 16:57:50 INFO - 'NO_EM_RESTART': '1', 16:57:50 INFO - 'PAGER': '/bin/cat', 16:57:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:50 INFO - 'PWD': '/builds/slave/test', 16:57:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:50 INFO - 'SHELL': '/bin/bash', 16:57:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6q4Bv852e/Listeners', 16:57:50 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 16:57:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:50 INFO - 'USER': 'cltbld', 16:57:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:50 INFO - 'XPC_FLAGS': '0x0', 16:57:50 INFO - 'XPC_SERVICE_NAME': '0', 16:57:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:57:50 INFO - Cleaning up... 16:57:50 INFO - Return code: 0 16:57:50 INFO - Running post-action listener: _resource_record_post_action 16:57:50 INFO - Running post-action listener: _start_resource_monitoring 16:57:50 INFO - Starting resource monitoring. 16:57:50 INFO - [mozharness: 2017-01-14 00:57:50.545431Z] Finished create-virtualenv step (success) 16:57:50 INFO - [mozharness: 2017-01-14 00:57:50.546234Z] Running install step. 16:57:50 INFO - Running pre-action listener: _resource_record_pre_action 16:57:50 INFO - Running main action method: install 16:57:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:57:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:57:50 INFO - Reading from file tmpfile_stdout 16:57:50 INFO - Detecting whether we're running mozinstall >=1.0... 16:57:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:57:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:57:50 INFO - Reading from file tmpfile_stdout 16:57:50 INFO - Output received: 16:57:50 INFO - Usage: mozinstall [options] installer 16:57:50 INFO - Options: 16:57:50 INFO - -h, --help show this help message and exit 16:57:50 INFO - -d DEST, --destination=DEST 16:57:50 INFO - Directory to install application into. [default: 16:57:50 INFO - "/builds/slave/test"] 16:57:50 INFO - --app=APP Application being installed. [default: firefox] 16:57:50 INFO - mkdir: /builds/slave/test/build/application 16:57:50 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'] 16:57:50 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 16:58:12 INFO - Reading from file tmpfile_stdout 16:58:12 INFO - Output received: 16:58:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:58:12 INFO - Running post-action listener: _resource_record_post_action 16:58:12 INFO - [mozharness: 2017-01-14 00:58:12.739150Z] Finished install step (success) 16:58:12 INFO - [mozharness: 2017-01-14 00:58:12.739280Z] Running run-tests step. 16:58:12 INFO - Running pre-action listener: _resource_record_pre_action 16:58:12 INFO - Running main action method: run_tests 16:58:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:58:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:58:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:58:12 INFO - 2017-01-13 16:58:12.753 screenresolution[1628:7525] starting screenresolution argv=screenresolution get 16:58:12 INFO - 2017-01-13 16:58:12.756 screenresolution[1628:7525] Display 0: 1600x1200x32@60 16:58:12 INFO - 2017-01-13 16:58:12.761 screenresolution[1629:7528] starting screenresolution argv=screenresolution list 16:58:12 INFO - Available Modes on Display 0 16:58:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:58:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:58:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:58:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:58:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:58:12 INFO - Intel Iris: 16:58:12 INFO - Chipset Model: Intel Iris 16:58:12 INFO - Type: GPU 16:58:12 INFO - Bus: Built-In 16:58:12 INFO - VRAM (Dynamic, Max): 1536 MB 16:58:12 INFO - Vendor: Intel (0x8086) 16:58:12 INFO - Device ID: 0x0a2e 16:58:12 INFO - Revision ID: 0x0009 16:58:12 INFO - Displays: 16:58:12 INFO - Display: 16:58:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:58:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:58:12 INFO - Display Serial Number: 1600x1200 60 16:58:12 INFO - Main Display: Yes 16:58:12 INFO - Mirror: Off 16:58:12 INFO - Online: Yes 16:58:12 INFO - Rotation: Supported 16:58:12 INFO - Return code: 0 16:58:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:58:12 INFO - Python 2.7.3 16:58:12 INFO - Return code: 0 16:58:12 INFO - grabbing minidump binary from tooltool 16:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:13 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 0x107552d30>, '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 0x107479db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107547be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:58:13 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 16:58:13 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 16:58:13 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 16:58:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:58:13 INFO - Return code: 0 16:58:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:58:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:58:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:58:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:58:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:58:13 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/F3mOtD_FTWiQqkVXMdG79A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0297', '--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 16:58:13 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/F3mOtD_FTWiQqkVXMdG79A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0297 --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 16:58:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cUtvhf90KY/Render', 16:58:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:13 INFO - 'HOME': '/Users/cltbld', 16:58:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:13 INFO - 'LOGNAME': 'cltbld', 16:58:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:58:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:13 INFO - 'MOZ_NO_REMOTE': '1', 16:58:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:58:13 INFO - 'NO_EM_RESTART': '1', 16:58:13 INFO - 'PAGER': '/bin/cat', 16:58:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:13 INFO - 'PWD': '/builds/slave/test', 16:58:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:58:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:13 INFO - 'SHELL': '/bin/bash', 16:58:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u6q4Bv852e/Listeners', 16:58:13 INFO - 'TMPDIR': '/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/', 16:58:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:13 INFO - 'USER': 'cltbld', 16:58:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:13 INFO - 'XPC_FLAGS': '0x0', 16:58:13 INFO - 'XPC_SERVICE_NAME': '0', 16:58:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:13 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/F3mOtD_FTWiQqkVXMdG79A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0297', '--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 16:58:13 INFO - mozversion application_buildid: 20170113152824 16:58:13 INFO - mozversion application_changeset: 671a2f8542cadcf9aad318ab76250a730a03b240 16:58:13 INFO - mozversion application_display_name: Nightly 16:58:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:58:13 INFO - mozversion application_name: Firefox 16:58:13 INFO - mozversion application_remotingname: firefox 16:58:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:58:13 INFO - mozversion application_vendor: Mozilla 16:58:13 INFO - mozversion application_version: 53.0a1 16:58:13 INFO - mozversion platform_buildid: 20170113152824 16:58:13 INFO - mozversion platform_changeset: 671a2f8542cadcf9aad318ab76250a730a03b240 16:58:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:58:13 INFO - mozversion platform_version: 53.0a1 16:58:13 INFO - using testdate: 1484355493 16:58:13 INFO - actual date: 1484355493 16:58:13 INFO - starting webserver on 'localhost:49238' 16:58:13 INFO - SUITE-START | Running 2 tests 16:58:13 INFO - TEST-START | dromaeo_css 16:58:13 INFO - operating with platform_type : mac_ 16:58:13 INFO - Initialising browser for dromaeo_css test... 16:58:13 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/tmp4DJ1TP/profile http://localhost:49238/getInfo.html) 16:58:15 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 16:58:15 INFO - PROCESS | 1639 | colorDepth:24 16:58:15 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 16:58:15 INFO - PROCESS | 1639 | __metrics 16:58:15 INFO - PROCESS | 1639 | 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" 16:58:15 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:58:16 INFO - TEST-INFO | 1639: exit 0 16:58:16 INFO - Browser initialized. 16:58:16 INFO - Running cycle 1/1 for dromaeo_css test... 16:58:16 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/tmp4DJ1TP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:58:28 INFO - PROCESS | 1641 | RSS: Main: 235081728 16:58:28 INFO - PROCESS | 1641 | 17:01:33 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49238/tests/dromaeo/cssquery-ext.html) 17:01:34 INFO - PROCESS | 1641 | RSS: Main: 354238464 17:01:34 INFO - PROCESS | 1641 | 17:03:19 INFO - PROCESS | 1641 | ************************* 17:03:19 INFO - PROCESS | 1641 | A coding exception was thrown and uncaught in a Task. 17:03:19 INFO - PROCESS | 1641 | 17:03:19 ERROR - PROCESS | 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:03:19 INFO - PROCESS | 1641 | Full stack: 17:03:19 INFO - PROCESS | 1641 | ************************* 17:04:37 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-ext.html (next: http://localhost:49238/tests/dromaeo/cssquery-jquery.html) 17:04:38 INFO - PROCESS | 1641 | RSS: Main: 370167808 17:04:38 INFO - PROCESS | 1641 | 17:07:40 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49238/tests/dromaeo/cssquery-mootools.html) 17:07:41 INFO - PROCESS | 1641 | RSS: Main: 341692416 17:07:41 INFO - PROCESS | 1641 | 17:10:43 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49238/tests/dromaeo/cssquery-prototype.html) 17:10:44 INFO - PROCESS | 1641 | RSS: Main: 343183360 17:10:44 INFO - PROCESS | 1641 | 17:13:47 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49238/tests/dromaeo/cssquery-yui.html) 17:13:48 INFO - PROCESS | 1641 | RSS: Main: 325574656 17:13:48 INFO - PROCESS | 1641 | 17:16:51 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-yui.html (next: http://localhost:49238/tests/dromaeo/cssquery-dojo.html) 17:16:52 INFO - PROCESS | 1641 | RSS: Main: 375775232 17:16:52 INFO - PROCESS | 1641 | 17:16:52 INFO - PROCESS | 1641 | __start_tp_report 17:16:52 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 17:16:52 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 17:16:52 INFO - PROCESS | 1641 | |i|pagename|runs| 17:16:52 INFO - PROCESS | 1641 | |0;dojo.html;3030.8939187128453;3338.3990881641294;3353.765236433449;3356.9496457553128;3401.9149521261966;5606.523445507127;5659.377468478469;5689.061304884689;5691.971540142294;5711.800086996951;5695.829125126243;5756.366799652035;5761.711914404274;5763.596548241625;5773.191753154551;5180.637355385134;5204.505571970657;5229.947700522984;5255.106631872591;5272.710000949946;5307.442718514559;5316.175992721134;5318.73406329682;5318.76065577048;5332.280142180814;5298;5304.20436934461;5304.734763261841;5306.124489459235;5307.99148161848;5304.151335786275;5313.256144139824;5315.441878602768;5317.867053323659;5322.308099947021;5128.743562821844;5151.716655583941;5246.344206974129;5248.921266181011;5254.7635356409055;5678.233438485793;5690.374058853523;5733.082706766939;5764.135379693038;5768.682722450264;6213.906791398133;6229.190205273286;6244.469220116295;6256.937430625681;6268.623882567061;6193.380661933816;6232.34560371159;6274;6292.2134733158355;6299.8740025199695;5894.6757928314355;5898.764049437975;5917.763289468373;5923.466887980103;5939.881202375928;6340.841478963062;6343.777967771106;6350.650714210763;6355.3644635537;6359.554831161867;6094.360092190344;6150.646857691301;6166.969165154235;6187;6241.812745617639;6310.716017779211;6333.398327159005;6345.841353966188;6347.841303967438;6348.269948955837;6237.812865614039;6252.468540174045;6292.150559674477;6306.621602703761;6314.8421289467215;6191.597546159485;6231.40801623845;6348.714307856158;6359.96820015897;6370.617762934146;4984.551390374883;5011.198208286657;5016.673916195436;5040.193569028937;5071.771770270347;4460.107978404332;4468.329750537446;4477.485089214782;4479.888002799956;4503.392042074343;5715.371309155989;5796.304443466811;5858.297004359419;5874.265716785402;5875.853103672443;6219.129321894939;6263.812085637438;6308.243010838729;6313.3686631336495;6320.399562041599;5819.359870414251;5871.7651293947765;5876.001079816441;5893.616914900518;5900.7049647518315;5394.62237643369;5437.102878025082;5446.645968012067;5480.671159730429;5519.282493275929;6288.119663247057;6315.494760419156;6366.267879193952;6372.936270637234;6393.8721225576155;6178.814635560941;6208.782692605737;6288.6855657217875;6316.399942005502;6336.239651241881;6375.458086062551;6386.616802991835;6387.872242555216;6394;6418.839529011812;5160.819371321985;6253;6324.0513922910095;6346.492280617447;6347.238331400077;6226.657533835682;6257.530685198537;6275.937240627718;6282.371762823681;6298.307186209605;6021.909671354845;6237.345078766664;6238.6880655967925;6250.781222657185;6258.968705156627;6170.259568851767;6208.161898143873;6211.782587609412;6218.31598524171;6250.312465628686;4848.80604775805;5955.67243801595;5976.432238937294;6082.239720034996;6112.297085835008;4813.542713442217;6230.7819226326865;6234.657093859882;6240.251169859646;6253.312135664983;6063.757449702139;6072.666003369681;6080.72636731357;6085.4523092921845;6092.725827337869 17:16:52 INFO - PROCESS | 1641 | |1;ext.html;461.94687610924734;490.73990784884023;493.79013919084383;528.8281308574713;538.6229639252522;29667.96162134323;32056.839715801445;32169;32186.03441896744;32194;39783.80108099463;41866;42690.93272668185;42728.14543709124;42962.78518607403;7830.647620857061;9357.81284374312;9417.246620270362;9432.575534100948;9434.858477122849;8227.670893164266;9331.72004839856;9394.577244024036;9411.105944935254;9413.105754953269;8485.490870547786;8658;8668.566571671392;8671.826563468727;11132.276402033882;11033.227674062819;11359.545618175263;11376.374299413528;11381.943090284496;11384.666143440658;11173.273737207055;11252.49363778632;11253.324800511913;11254.437278136142;11257.887421125848;31427.37145257105;31622.841885790654;39156.80421597874;39211.607883921366;39544.40683389751;4016.650046387941;4066.0241542029994;4112.300908845504;4167.291560434703;4192.0777428965575;24607.63088553673;30433.23916902095;30866.69133308683;31064.534031989537;31469.842650786828;3173.1115287719476;3284.1953721338186;3308.8511017004294;3350.525768661781;3350.7654464187517;467222;473489;475504;475517.6224118892;476342;54008;54409;54445.72777136089;54479;54521.1821822673;58763.41236587665;60133.09800352998;61547.6922615393;61655.69172154111;61734.382656172864;15751.212439378214;15965.441209557843;15967.962082464603;15990.040597564184;16003.839961600468;12445.25328480294;12516.12387132892;12525.937370313273;12542.874571254171;12551.560695375802;12517.56188533397;13485.190888546718;14914.850851491563;15361.539153825403;15571.84428155704;5698.971505142531;6831.45348372139;6976.7209311627985;7054.541454805421;7119.501634885612;867.5598506479214;872.6334939325499;881.7663319220412;892.1747383670079;914.4878867834034;25294.367640809127;28307.71692283092;29565.85217073901;30143.246418839266;30416.695833041827;1027.1372047480152;1029.480112543176;1055.4142450939648;1068.8022715797601;1069.9144068474504;13544.322783860767;14044.016918815585;14126.048741510229;14170.85829141716;14404.639884002983;513916;526225;526286;576820;580803;49615.759606010135;49826;49858.26063045286;49991.0001799962;50007;1404.45226361719;1439.2156274830243;1452.4190323870537;1453;1457.0237940579837;22744.545109097395;25732.742672573033;26874.865625671748;27042;27080.864595676896;42292.577074228866;45085.77457112693;45209.547904520536;45230.54769452263;45265.32102018538;496553.51723241154;500629;501755;502524.48737756076;502713;23697.52604947857;23794.04823807028;24399.26802195937;24527.896244668675;25431.745682542936;41585.69724448233;42169.1566168681;42711.57288427076;42932;43028.56971430246;27900;34226.657733423344;34662.30675386528;35567.755128570374;36060;28066.228741114468;30364.848175759864;34519.65480345265;34886.12784680403;35725.28549429049;25891.61162582525;34824.303513930085;35181.82409087938;35484.46773298351;35591.11022224465;30567.54148687816;31872.5219121718;31895;31896.8405157982;32002.67997319997;19289.710654339917;23736.40658983539;24023.639645404983;24076.51846963086;24317.75682243155 17:16:52 INFO - PROCESS | 1641 | |2;jquery.html;352.72135013339454;366.9137752628134;376.33201068104114;386.7486134012893;400.3434367637076;14797.704045919088;14984.17587032714;15921.442749503783;20034.89982550089;20923.476913077182;20690.068946897387;20924.26765063223;21427.892860535674;21487.818170000643;21781.128754849786;5693.658380497183;5789.334226563936;5925.31858836235;5934.762609495615;5939.584229103964;5962.612430192024;6118.847028824271;6120.908186377208;6121.479674227674;6125.387461253861;3930.3711406175016;4021.5777343378963;4122.402251673506;4123.8969025774295;4261.659067274626;4140.068484590973;6755;6763.763268285636;6780.6948687308695;6782.186137663462;5801.419858014207;5966.612170208966;6006;6017.939820601781;6035.698215089228;13148.342582870913;13388.464461421532;13573;16259.91870040654;25087.498250035078;2366.266457398212;2572.8199026068182;2598.2724837045466;2616.2936007278117;2667.7999150063824;9731.90268097324;10012.94993525035;10232.43721595312;10535.947320263427;10599.735006624818;1708.974615230864;1784.8750587458883;1830.130687923239;1846.9261229550802;1910.5892233169934;109011;128389.35805320913;131172.34413827964;131372.34313828466;132697.33651331777;11597.594084207012;11616;11811.586594469325;11833.763324733458;11902.285862848257;15012.699746005019;15409.614759631098;15426.6143346415;15459.845401546065;15465.536033919001;8257.339412846957;8527.53098579584;8556.486610803371;8701.129887011248;8727.170918762708;8275.586220688941;8296.128906464734;8309.255056438216;8424.957875210584;8458.06961234276;4670.20142209206;4757.595604373598;4771.832985845479;4829.758512074382;4911.7544122793715;1976.2391479280293;2029.7158397824317;2032.4309193425865;2042.7242322286597;2044.672852343618;823.6581818545236;837.6314421654453;859.4456575508761;868.7133246028795;877.7761670774039;19011.61976760457;20554.58890822175;21199.72801631907;21405.143794248055;21484.570308594055;771.8572064168147;838.8591515538862;887.60057973912;919.5907821019582;921;10328.328658637165;11107.94446027781;11177.608783692533;11180.552777888955;11237;671177;674087;675871;684399;688487.557562219;138668;144569;150337;150872;158260.41739582457;977.4965892565334;1024.114141267798;1053.431147180514;1053.994730026345;1058.9205809564314;19130.7130393047;19354.8064519353;19621.566225910694;19626;19722.211111555378;56543;56568.71715641396;56826.43173568211;57025;57536.71231643815;79442.01394965172;79706.2029379722;80075.19924800677;81029;82052.76920846073;7549.207333230152;8009.519428834288;8125.634346454542;8211.21993410625;8469.957650211956;9476.573554190216;10492.055714985689;11528.654140375802;11791.34921111028;12479.87520124787;10474.423906685206;10743.785124297627;10883.401412922049;10954.507047183055;11164.274322169033;10658.040776330168;10825.783484330426;11105;11207.49566269536;11289.604863829727;9543.0456954304;10852.565897364017;10989.120870330195;11282.097432205239;11300.49147788368;7063.505554611128;7261.174278095691;7437.628118593941;8113.107558168479;8330.50016998982;8240.711575094843;9761;10719.196060295353;11274.154438417316;11491.942540287246 17:16:52 INFO - PROCESS | 1641 | |3;mootools.html;1437.4681367893882;1460.9342579583918;1462.561231630511;1482.162578143349;1482.3774014913736;6692.966535167324;8440.704575339865;8450;8450.661973521059;8487.91512084879;7165.426765858731;7385.889211661829;7398.889016664741;7987.4408791384485;8239.794005149859;2277.214361045437;2332.463533387322;2336.5677349690277;2340.496793189464;2344.6365813298967;2294.4837411582344;2318.4435735423463;2325.837191396603;2338.4270853640883;2340.0405833608224;2264.094362255103;2280.247518318951;2302.7466978632337;2310.9653355199684;2311.9422014449606;1918.9232430702755;2269.9773002270013;2291.702078729771;2292.094622624071;2294.128231272106;2226.7216597925258;2312.953740925189;2314.837961342707;2318.362450326174;2319.9652005219937;8368.288695460893;8452.535110568917;8458.915410845935;8459.323254139654;8461.069282378934;5087.847364579068;5231.843044708665;5235.424103348629;5239.240310155044;5244.160934250502;2908.6218791557176;3275.328557645677;3327.168207948013;3531.682148606612;3532.0993146747674;1083.0415082651832;1177.2877409167502;1204.2894692131683;1205.993970030153;1237.3874931908672;10256.435896025716;10655.680329590046;10690;10790.892091079146;10792.514336854782;3897.4738410314812;4461.531539188403;4596.264597664358;4631.397918270603;4700.741459219776;9257.39826911262;9475.573599188054;9553.283503737248;9556.187724043395;9570.856437153448;5182.53357197854;5272.340957380327;5284.735763211824;5286.286351342596;5308.548773354308;4204.411382406465;4543.727376357429;4784.067106914188;4829.806807727651;4860.295257187688;3748.5876553579083;3772.1889793694486;3777.4522694209736;3849.82675779585;3886.7862267574988;1071.8552995345685;1290.1098242213031;1296.1704509114174;1304.0610760252603;1304.5955753716378;827.6523859978823;839.1650307943635;844.2950136635855;879.7932485865816;884.0054938194531;5005.299258103868;5022.472640372708;5110.310108135354;5259.053370393366;5307.363116426053;932.3566738950103;947.1144479911305;972.397113789455;975.5463709375175;1017.389566260238;3362.4956256561713;3378.5945686517284;3392.8642854285554;3477.808720520345;3500;9902.504874756234;10156.796864062677;10170.644027459151;10175.745606359753;10183.898161018295;8819.867701984474;9860;9882.4564648945;9997.650082247232;10119.645812396531;7681.116671582728;7919.445638805343;7927.563983980936;7928.088269848926;7928.207179282141;5121.359830021247;5166.586673066071;5305.9204111939125;5365.409804921377;5366.382865970463;9070.138336857988;9076.500792456214;9081.59132839037;9240.907590924005;9334.533273336441;9243.352965292634;9328.440293582407;9442.575084121094;9456.385334953206;9471.384360016576;6661.4004739573675;6895.931040689529;7002.124734408199;7162.928370716226;7307.3423391894985;7997.560134192675;8062.1534738853925;8084.312833408991;8086.474379165335;8087.878681819895;6960.952456924027;7139.500234983501;7172.031775710212;7197.1363436387965;7279;6951.16586009682;6978.755743549154;7037;7135.179454362607;7146.249643787535;5011.824586139468;5671.489565939085;6081.878362432638;6105.847353816012;6114.694265286629;4571.794269257958;4627.6066534344955;4629.166749985035;4702.764861756967;4813.470518243061;4376.715513491613;4405.603495685275;4429.756363400044;4526.162659907927;4537.481697657831 17:16:52 INFO - PROCESS | 1641 | |4;prototype.html;349.6800427608738;353.63045617329885;359.5846796949523;369.31123454756886;371.92375563009585;4338.418640908654;4512.774361281935;4589.678722489427;5075;5382.900668739195;4633.698809577375;4974.651774375786;5014.699118052919;5218.425973142951;5223.294855194547;3884.35908075168;4075.531313898895;4093.9590604094024;4102.917941641165;4132.615573782787;4053.7501686563946;4097.79511024449;4126.525449573308;4129.380592911058;4168.310650518167;3382.6955573998334;3608.7654302470387;3679.319325924699;3814.542254929412;4106.480602177198;4096.7914465232825;4098.057446787241;4107.747137123191;4111.465509483778;4143.197708996596;3025.727684508383;3565.94651080234;3633.2378796284047;3655.6915991028163;3666;4282.314829627245;4671.48613652498;5112.667676601009;5138.2806407103035;5157.53582177602;4102.789677045279;4267.551907049746;4483.125790470827;4576.084783043405;4800.583463213851;4819.975900120512;5282.630215884889;5554.250176226238;5568.888622227573;5592.965301419251;3257.9086006187717;3500.352434799545;4022.2503211103262;4030.3148464760766;4058.756474611503;4896.730679812609;5491.752871120809;5558.859838961988;5698.572607054488;5981.910271345933;3775.169462718198;3786.678132358725;3787.9431808522895;3816.217675376541;3837.5394952605866;3271.214908421962;3592.8383222755037;3854.69162467002;3904.6876249899938;3915.334393153171;3791.1659434924272;4187.602177793105;4269.310334489314;4527.909441811211;4580.610648094883;5572.331320241597;5600.943990560124;5609.298837645294;5617.269754931915;5623.409541998031;1132.1452303510796;1160.2748282323548;1259.703969567151;1259.829922960407;1262.223732404583;793.9519833819419;799.2127754162145;809.8177909970327;812.7439856445319;817.9468334558235;4846.903061938741;4851.636127290467;4879.072976134523;4887.29134275528;4998.750062496933;4701.4358277006295;4732.881677958078;4866.48901865299;5289.942011597619;5332;4472.865814025585;4485.237509623372;4605.631549476034;4853.538913803183;4945.184044632667;2568.4349443122483;2711.996561272302;2806.564982427727;2819.3938303264895;2823.929401764972;4781.928271075867;5428.344354971771;5539.5014448699;5610.551155907518;5667.631603945731;4628.755053798905;4631.7767471613815;5004.520953746377;5144;5561.443855614406;4891.33966914462;5593.552515798727;5597.720113994365;5601.963636727137;5618.522425593788;4491.955080449154;4751.904961900674;4871.5385384383835;5215.6609820361555;5388.892222155457;4491.820327187007;4703.435587729495;4801.51984801531;5024.472430394756;5277.313949186581;4852.369192005017;4983.07813054586;5232.645309610766;5597.928766356475;5669.489745922887;3345.7119009181156;3607.3045668535747;3625.945610815787;3631.6368363163474;3631.8002509862213;4690.3199036138885;4918.975405123095;5198.636095473281;5420.620556561003;5686.715664216856;5592.804251851328;5623.678435567556;5628.746706398304;5635.380108188014;5688.3742788294085;5279.46895400345;5306.602004849575;5584.4136365681015;5630;5663.745131469176;5344.412114667306;5441.5102640762525;5442.619016668795;5473.562115030868;5541.362743284574;4416.6025057744955;4811.927821082617;5392.703401312965;5426.158945363317;5596.18727894019;4925.3157029418335;5416.918746218888;5438.129899216106;5442.537384322219;5493.917591236214 17:16:52 INFO - PROCESS | 1641 | |5;yui.html;715.173974059961;718.6083584446483;782.9625745886698;821.5974172655399;834.0908409833282;11938.940305298473;15346.232688365593;15407.152606606633;16927.57681057971;17831;15959.680806383865;16416.261268242928;16773.329066837312;17075.48773536793;17076.316947322124;862.3403096631066;882.3470631732536;882.7087061269798;883.4169448164213;886.0917559501498;691.695653912277;891.1222445890793;892.7768057985504;895.4269267668698;895.7581453007684;744.1553836395702;746.0636900689627;908.0646933658343;933.1321870660283;941.5668792355525;755.2938002967188;801.1907972947365;926.9304802139833;930.4370855632312;931.3387494878644;685.0204207982583;689.3692271571556;691.0877641513205;691.1050190003957;691.6921969723475;10992.890071099268;12103.818442723366;12338.444769985372;12576.874231257754;13724.65688357789;14166.575002749934;14328.355224014944;14479.42082316706;14801.925990370088;14945.850541494554;11555.76888462226;11636.360000199986;11795.882041179564;11839.11206659504;12279.815802762876;3739.9813000934823;3755.4742336072973;3767.7550959187565;3777.867774627875;3924.097457584743;104210;106684;106934;107202.46398767956;107519;11255.774884502427;11319.830202546967;11343.773124537463;11436.599719009795;11544.59593914209;24031.158909438087;24382;24413.38966525851;24414.389640259134;24476.388090297885;7823.647935842901;7843;7871;7895.407844411578;8030.879536806952;4272.87181384559;4283;4334.761588112621;4365.497967733688;4459.152760975469;3593.3711600469815;3655.94516082259;3697.279030589063;3697.630236976335;3702.2225332680437;632.3613150717808;636.9140166077613;649.3279455763262;649.6199723161909;654.7610122305324;650.5056157320471;656.9113169722121;691.1429827014466;693.5699866083061;723.7756295548397;7858.960705196438;10003.299769016245;10276;10514.684559463229;10545.31455455393;655.2890114226118;695.979120626382;702.5995182745888;705.2074575935887;730.1311439387113;4450.888727781831;4651.7179131420835;4673.088747694167;4724.267738500538;4751.429828420542;80639;99341.50329248307;99729.50135249278;102339;102936.48531757294;89348.29887758315;89716.5514172438;91983;92699.07300926905;93272;78295.60852195702;78741.2125878734;79810.40379192383;79828;80487.39025219463;9063.954680226556;9106.95446522763;9153.816923661623;9219.262459003397;9231.123043310874;40291.597084029956;46115.538844611125;46391.84020399517;47945.280820788415;48359.27461088016;50526.494735052176;51107.744461277456;58641.12038319514;59772.40227597668;62188;10003.399796012263;11763.294202347886;11978;12086.758264834478;12228;12604.684882878002;12733.29966851832;12820.807687884502;12990.415431305802;13212.14121082165;11774.882251177378;12088.576899808464;12107.515699371927;12136.817947730615;12555.686107847378;11025.897410258909;11724;11876.346800926032;11883.287002779862;12085.697857553632;11668.533258669559;12049.277043377426;12050.939745301217;12057;12083.154179207722;9327.486988215713;9783.804323913624;9966.417613862357;10113.949430252802;10233.334833235816;11314.434278286217;11380.829287560859;11384.316940983568;11656.417179141179;11782.941085294518 17:16:52 INFO - PROCESS | 1641 | __end_tp_report 17:16:52 INFO - PROCESS | 1641 | __start_cc_report 17:16:52 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1254 17:16:52 INFO - PROCESS | 1641 | __end_cc_report 17:16:52 INFO - PROCESS | 1641 | __startTimestamp1484356612001__endTimestamp 17:16:52 INFO - PROCESS | 1641 | 17:16:52 INFO - PROCESS | 1641 | ------- Summary: start ------- 17:16:52 INFO - PROCESS | 1641 | Number of tests: 6 17:16:52 INFO - PROCESS | 1641 | 17:16:52 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5794.29 Median:6072.67 stddev:663.74 (10.9%) stddev-sans-first:629.38 17:16:52 INFO - PROCESS | 1641 | Values: 3030.9 3338.4 3353.8 3356.9 3401.9 5606.5 5659.4 5689.1 5692.0 5711.8 5695.8 5756.4 5761.7 5763.6 5773.2 5180.6 5204.5 5229.9 5255.1 5272.7 5307.4 5316.2 5318.7 5318.8 5332.3 5298.0 5304.2 5304.7 5306.1 5308.0 5304.2 5313.3 5315.4 5317.9 5322.3 5128.7 5151.7 5246.3 5248.9 5254.8 5678.2 5690.4 5733.1 5764.1 5768.7 6213.9 6229.2 6244.5 6256.9 6268.6 6193.4 6232.3 6274.0 6292.2 6299.9 5894.7 5898.8 5917.8 5923.5 5939.9 6340.8 6343.8 6350.7 6355.4 6359.6 6094.4 6150.6 6167.0 6187.0 6241.8 6310.7 6333.4 6345.8 6347.8 6348.3 6237.8 6252.5 6292.2 6306.6 6314.8 6191.6 6231.4 6348.7 6360.0 6370.6 4984.6 5011.2 5016.7 5040.2 5071.8 4460.1 4468.3 4477.5 4479.9 4503.4 5715.4 5796.3 5858.3 5874.3 5875.9 6219.1 6263.8 6308.2 6313.4 6320.4 5819.4 5871.8 5876.0 5893.6 5900.7 5394.6 5437.1 5446.6 5480.7 5519.3 6288.1 6315.5 6366.3 6372.9 6393.9 6178.8 6208.8 6288.7 6316.4 6336.2 6375.5 6386.6 6387.9 6394.0 6418.8 5160.8 6253.0 6324.1 6346.5 6347.2 6226.7 6257.5 6275.9 6282.4 6298.3 6021.9 6237.3 6238.7 6250.8 6259.0 6170.3 6208.2 6211.8 6218.3 6250.3 4848.8 5955.7 5976.4 6082.2 6112.3 4813.5 6230.8 6234.7 6240.3 6253.3 6063.8 6072.7 6080.7 6085.5 6092.7 17:16:52 INFO - PROCESS | 1641 | 17:16:52 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:63034.99 Median:34855.22 stddev:135369.64 (388.4%) stddev-sans-first:135667.86 17:16:52 INFO - PROCESS | 1641 | Values: 461.9 490.7 493.8 528.8 538.6 29668.0 32056.8 32169.0 32186.0 32194.0 39783.8 41866.0 42690.9 42728.1 42962.8 7830.6 9357.8 9417.2 9432.6 9434.9 8227.7 9331.7 9394.6 9411.1 9413.1 8485.5 8658.0 8668.6 8671.8 11132.3 11033.2 11359.5 11376.4 11381.9 11384.7 11173.3 11252.5 11253.3 11254.4 11257.9 31427.4 31622.8 39156.8 39211.6 39544.4 4016.7 4066.0 4112.3 4167.3 4192.1 24607.6 30433.2 30866.7 31064.5 31469.8 3173.1 3284.2 3308.9 3350.5 3350.8 467222.0 473489.0 475504.0 475517.6 476342.0 54008.0 54409.0 54445.7 54479.0 54521.2 58763.4 60133.1 61547.7 61655.7 61734.4 15751.2 15965.4 15968.0 15990.0 16003.8 12445.3 12516.1 12525.9 12542.9 12551.6 12517.6 13485.2 14914.9 15361.5 15571.8 5699.0 6831.5 6976.7 7054.5 7119.5 867.6 872.6 881.8 892.2 914.5 25294.4 28307.7 29565.9 30143.2 30416.7 1027.1 1029.5 1055.4 1068.8 1069.9 13544.3 14044.0 14126.0 14170.9 14404.6 513916.0 526225.0 526286.0 576820.0 580803.0 49615.8 49826.0 49858.3 49991.0 50007.0 1404.5 1439.2 1452.4 1453.0 1457.0 22744.5 25732.7 26874.9 27042.0 27080.9 42292.6 45085.8 45209.5 45230.5 45265.3 496553.5 500629.0 501755.0 502524.5 502713.0 23697.5 23794.0 24399.3 24527.9 25431.7 41585.7 42169.2 42711.6 42932.0 43028.6 27900.0 34226.7 34662.3 35567.8 36060.0 28066.2 30364.8 34519.7 34886.1 35725.3 25891.6 34824.3 35181.8 35484.5 35591.1 30567.5 31872.5 31895.0 31896.8 32002.7 19289.7 23736.4 24023.6 24076.5 24317.8 17:16:52 INFO - PROCESS | 1641 | 17:16:52 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:37888.33 Median:2585.55 stddev:113423.48 (4386.8%) stddev-sans-first:113706.65 17:16:52 INFO - PROCESS | 1641 | Values: 352.7 366.9 376.3 386.7 400.3 14797.7 14984.2 15921.4 20034.9 20923.5 20690.1 20924.3 21427.9 21487.8 21781.1 5693.7 5789.3 5925.3 5934.8 5939.6 5962.6 6118.8 6120.9 6121.5 6125.4 3930.4 4021.6 4122.4 4123.9 4261.7 4140.1 6755.0 6763.8 6780.7 6782.2 5801.4 5966.6 6006.0 6017.9 6035.7 13148.3 13388.5 13573.0 16259.9 25087.5 2366.3 2572.8 2598.3 2616.3 2667.8 9731.9 10012.9 10232.4 10535.9 10599.7 1709.0 1784.9 1830.1 1846.9 1910.6 109011.0 128389.4 131172.3 131372.3 132697.3 11597.6 11616.0 11811.6 11833.8 11902.3 15012.7 15409.6 15426.6 15459.8 15465.5 8257.3 8527.5 8556.5 8701.1 8727.2 8275.6 8296.1 8309.3 8425.0 8458.1 4670.2 4757.6 4771.8 4829.8 4911.8 1976.2 2029.7 2032.4 2042.7 2044.7 823.7 837.6 859.4 868.7 877.8 19011.6 20554.6 21199.7 21405.1 21484.6 771.9 838.9 887.6 919.6 921.0 10328.3 11107.9 11177.6 11180.6 11237.0 671177.0 674087.0 675871.0 684399.0 688487.6 138668.0 144569.0 150337.0 150872.0 158260.4 977.5 1024.1 1053.4 1054.0 1058.9 19130.7 19354.8 19621.6 19626.0 19722.2 56543.0 56568.7 56826.4 57025.0 57536.7 79442.0 79706.2 80075.2 81029.0 82052.8 7549.2 8009.5 8125.6 8211.2 8470.0 9476.6 10492.1 11528.7 11791.3 12479.9 10474.4 10743.8 10883.4 10954.5 11164.3 10658.0 10825.8 11105.0 11207.5 11289.6 9543.0 10852.6 10989.1 11282.1 11300.5 7063.5 7261.2 7437.6 8113.1 8330.5 8240.7 9761.0 10719.2 11274.2 11491.9 17:16:52 INFO - PROCESS | 1641 | 17:16:52 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5346.57 Median:5115.83 stddev:2956.08 (57.8%) stddev-sans-first:2949.78 17:16:52 INFO - PROCESS | 1641 | Values: 1437.5 1460.9 1462.6 1482.2 1482.4 6693.0 8440.7 8450.0 8450.7 8487.9 7165.4 7385.9 7398.9 7987.4 8239.8 2277.2 2332.5 2336.6 2340.5 2344.6 2294.5 2318.4 2325.8 2338.4 2340.0 2264.1 2280.2 2302.7 2311.0 2311.9 1918.9 2270.0 2291.7 2292.1 2294.1 2226.7 2313.0 2314.8 2318.4 2320.0 8368.3 8452.5 8458.9 8459.3 8461.1 5087.8 5231.8 5235.4 5239.2 5244.2 2908.6 3275.3 3327.2 3531.7 3532.1 1083.0 1177.3 1204.3 1206.0 1237.4 10256.4 10655.7 10690.0 10790.9 10792.5 3897.5 4461.5 4596.3 4631.4 4700.7 9257.4 9475.6 9553.3 9556.2 9570.9 5182.5 5272.3 5284.7 5286.3 5308.5 4204.4 4543.7 4784.1 4829.8 4860.3 3748.6 3772.2 3777.5 3849.8 3886.8 1071.9 1290.1 1296.2 1304.1 1304.6 827.7 839.2 844.3 879.8 884.0 5005.3 5022.5 5110.3 5259.1 5307.4 932.4 947.1 972.4 975.5 1017.4 3362.5 3378.6 3392.9 3477.8 3500.0 9902.5 10156.8 10170.6 10175.7 10183.9 8819.9 9860.0 9882.5 9997.7 10119.6 7681.1 7919.4 7927.6 7928.1 7928.2 5121.4 5166.6 5305.9 5365.4 5366.4 9070.1 9076.5 9081.6 9240.9 9334.5 9243.4 9328.4 9442.6 9456.4 9471.4 6661.4 6895.9 7002.1 7162.9 7307.3 7997.6 8062.2 8084.3 8086.5 8087.9 6961.0 7139.5 7172.0 7197.1 7279.0 6951.2 6978.8 7037.0 7135.2 7146.2 5011.8 5671.5 6081.9 6105.8 6114.7 4571.8 4627.6 4629.2 4702.8 4813.5 4376.7 4405.6 4429.8 4526.2 4537.5 17:16:52 INFO - PROCESS | 1641 | 17:16:52 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4363.31 Median:4806.72 stddev:1318.96 (27.4%) stddev-sans-first:1287.80 17:16:52 INFO - PROCESS | 1641 | Values: 349.7 353.6 359.6 369.3 371.9 4338.4 4512.8 4589.7 5075.0 5382.9 4633.7 4974.7 5014.7 5218.4 5223.3 3884.4 4075.5 4094.0 4102.9 4132.6 4053.8 4097.8 4126.5 4129.4 4168.3 3382.7 3608.8 3679.3 3814.5 4106.5 4096.8 4098.1 4107.7 4111.5 4143.2 3025.7 3565.9 3633.2 3655.7 3666.0 4282.3 4671.5 5112.7 5138.3 5157.5 4102.8 4267.6 4483.1 4576.1 4800.6 4820.0 5282.6 5554.3 5568.9 5593.0 3257.9 3500.4 4022.3 4030.3 4058.8 4896.7 5491.8 5558.9 5698.6 5981.9 3775.2 3786.7 3787.9 3816.2 3837.5 3271.2 3592.8 3854.7 3904.7 3915.3 3791.2 4187.6 4269.3 4527.9 4580.6 5572.3 5600.9 5609.3 5617.3 5623.4 1132.1 1160.3 1259.7 1259.8 1262.2 794.0 799.2 809.8 812.7 817.9 4846.9 4851.6 4879.1 4887.3 4998.8 4701.4 4732.9 4866.5 5289.9 5332.0 4472.9 4485.2 4605.6 4853.5 4945.2 2568.4 2712.0 2806.6 2819.4 2823.9 4781.9 5428.3 5539.5 5610.6 5667.6 4628.8 4631.8 5004.5 5144.0 5561.4 4891.3 5593.6 5597.7 5602.0 5618.5 4492.0 4751.9 4871.5 5215.7 5388.9 4491.8 4703.4 4801.5 5024.5 5277.3 4852.4 4983.1 5232.6 5597.9 5669.5 3345.7 3607.3 3625.9 3631.6 3631.8 4690.3 4919.0 5198.6 5420.6 5686.7 5592.8 5623.7 5628.7 5635.4 5688.4 5279.5 5306.6 5584.4 5630.0 5663.7 5344.4 5441.5 5442.6 5473.6 5541.4 4416.6 4811.9 5392.7 5426.2 5596.2 4925.3 5416.9 5438.1 5442.5 5493.9 17:16:52 INFO - PROCESS | 1641 | 17:16:52 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:19866.50 Median:4308.88 stddev:28766.41 (667.6%) stddev-sans-first:28811.17 17:16:52 INFO - PROCESS | 1641 | Values: 715.2 718.6 783.0 821.6 834.1 11938.9 15346.2 15407.2 16927.6 17831.0 15959.7 16416.3 16773.3 17075.5 17076.3 862.3 882.3 882.7 883.4 886.1 691.7 891.1 892.8 895.4 895.8 744.2 746.1 908.1 933.1 941.6 755.3 801.2 926.9 930.4 931.3 685.0 689.4 691.1 691.1 691.7 10992.9 12103.8 12338.4 12576.9 13724.7 14166.6 14328.4 14479.4 14801.9 14945.9 11555.8 11636.4 11795.9 11839.1 12279.8 3740.0 3755.5 3767.8 3777.9 3924.1 104210.0 106684.0 106934.0 107202.5 107519.0 11255.8 11319.8 11343.8 11436.6 11544.6 24031.2 24382.0 24413.4 24414.4 24476.4 7823.6 7843.0 7871.0 7895.4 8030.9 4272.9 4283.0 4334.8 4365.5 4459.2 3593.4 3655.9 3697.3 3697.6 3702.2 632.4 636.9 649.3 649.6 654.8 650.5 656.9 691.1 693.6 723.8 7859.0 10003.3 10276.0 10514.7 10545.3 655.3 696.0 702.6 705.2 730.1 4450.9 4651.7 4673.1 4724.3 4751.4 80639.0 99341.5 99729.5 102339.0 102936.5 89348.3 89716.6 91983.0 92699.1 93272.0 78295.6 78741.2 79810.4 79828.0 80487.4 9064.0 9107.0 9153.8 9219.3 9231.1 40291.6 46115.5 46391.8 47945.3 48359.3 50526.5 51107.7 58641.1 59772.4 62188.0 10003.4 11763.3 11978.0 12086.8 12228.0 12604.7 12733.3 12820.8 12990.4 13212.1 11774.9 12088.6 12107.5 12136.8 12555.7 11025.9 11724.0 11876.3 11883.3 12085.7 11668.5 12049.3 12050.9 12057.0 12083.2 9327.5 9783.8 9966.4 10113.9 10233.3 11314.4 11380.8 11384.3 11656.4 11782.9 17:16:52 INFO - PROCESS | 1641 | -------- Summary: end -------- 17:16:52 INFO - PROCESS | 1641 | 17:16:52 INFO - TEST-INFO | 1641: exit 0 17:16:52 INFO - TEST-OK | dromaeo_css | took 1119275ms 17:16:52 INFO - TEST-START | kraken 17:16:52 INFO - operating with platform_type : mac_ 17:16:52 INFO - Initialising browser for kraken test... 17:16:52 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/tmpvpFd5C/profile http://localhost:49238/getInfo.html) 17:16:54 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 17:16:54 INFO - PROCESS | 1651 | colorDepth:24 17:16:54 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 17:16:54 INFO - PROCESS | 1651 | __metrics 17:16:55 INFO - PROCESS | 1651 | 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" 17:16:55 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:16:55 INFO - TEST-INFO | 1651: exit 0 17:16:55 INFO - Browser initialized. 17:16:55 INFO - Running cycle 1/1 for kraken test... 17:16:55 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/T/tmpvpFd5C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:17:07 INFO - PROCESS | 1652 | RSS: Main: 226975744 17:17:07 INFO - PROCESS | 1652 | 17:17:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection) 17:17:11 INFO - PROCESS | 1652 | RSS: Main: 287604736 17:17:11 INFO - PROCESS | 1652 | 17:17:14 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-dft) 17:17:14 INFO - PROCESS | 1652 | RSS: Main: 288972800 17:17:14 INFO - PROCESS | 1652 | 17:17:18 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-fft) 17:17:18 INFO - PROCESS | 1652 | RSS: Main: 380768256 17:17:18 INFO - PROCESS | 1652 | 17:17:20 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator) 17:17:21 INFO - PROCESS | 1652 | RSS: Main: 282255360 17:17:21 INFO - PROCESS | 1652 | 17:17:23 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:17:23 INFO - PROCESS | 1652 | RSS: Main: 285917184 17:17:23 INFO - PROCESS | 1652 | 17:17:26 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom) 17:17:27 INFO - PROCESS | 1652 | RSS: Main: 327528448 17:17:27 INFO - PROCESS | 1652 | 17:17:30 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate) 17:17:30 INFO - PROCESS | 1652 | RSS: Main: 329404416 17:17:30 INFO - PROCESS | 1652 | 17:17:33 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial) 17:17:34 INFO - PROCESS | 1652 | RSS: Main: 328962048 17:17:34 INFO - PROCESS | 1652 | 17:17:36 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:17:36 INFO - PROCESS | 1652 | RSS: Main: 303771648 17:17:36 INFO - PROCESS | 1652 | 17:17:38 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:17:39 INFO - PROCESS | 1652 | RSS: Main: 307531776 17:17:39 INFO - PROCESS | 1652 | 17:17:41 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:17:42 INFO - PROCESS | 1652 | RSS: Main: 309100544 17:17:42 INFO - PROCESS | 1652 | 17:17:44 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:17:45 INFO - PROCESS | 1652 | RSS: Main: 325754880 17:17:45 INFO - PROCESS | 1652 | 17:17:48 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:17:49 INFO - PROCESS | 1652 | RSS: Main: 319959040 17:17:49 INFO - PROCESS | 1652 | 17:17:51 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49238/tests/kraken/driver.html?testName=ai-astar) 17:17:51 INFO - PROCESS | 1652 | RSS: Main: 363413504 17:17:51 INFO - PROCESS | 1652 | 17:17:51 INFO - PROCESS | 1652 | __start_tp_report 17:17:51 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 17:17:51 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 17:17:51 INFO - PROCESS | 1652 | |i|pagename|runs| 17:17:51 INFO - PROCESS | 1652 | |0;ai-astar;111;113;114;109;113;114;113;112;113;111 17:17:51 INFO - PROCESS | 1652 | |1;audio-beat-detection;139;110;109;148;110;111;109;112;132;112 17:17:51 INFO - PROCESS | 1652 | |2;audio-dft;184;185;183;185;185;182;180;224;183;182 17:17:51 INFO - PROCESS | 1652 | |3;audio-fft;79;59;59;87;60;61;59;61;73;57 17:17:51 INFO - PROCESS | 1652 | |4;audio-oscillator;89;70;85;68;68;69;81;67;69;82 17:17:51 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;88;84;89;85;88;85;89;85;87;84 17:17:51 INFO - PROCESS | 1652 | |6;imaging-darkroom;93;93;93;94;93;93;92;117;149;94 17:17:51 INFO - PROCESS | 1652 | |7;imaging-desaturate;94;88;70;128;141;86;84;101;143;133 17:17:51 INFO - PROCESS | 1652 | |8;json-parse-financial;57;54;56;54;54;55;55;56;55;56 17:17:51 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;65;74;65;70;77;70;70;69;69;70 17:17:51 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;90;87;87;86;86;87;85;90;91;87 17:17:51 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;142;146;148;147;141;142;137;137;196;181 17:17:51 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;174;174;176;176;175;169;173;171;173;172 17:17:51 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;68;71;79;84;86;86;69;67;67;66 17:17:51 INFO - PROCESS | 1652 | __end_tp_report 17:17:51 INFO - PROCESS | 1652 | __start_cc_report 17:17:51 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1929 17:17:51 INFO - PROCESS | 1652 | __end_cc_report 17:17:51 INFO - PROCESS | 1652 | __startTimestamp1484356671387__endTimestamp 17:17:51 INFO - PROCESS | 1652 | 17:17:51 INFO - PROCESS | 1652 | ------- Summary: start ------- 17:17:51 INFO - PROCESS | 1652 | Number of tests: 14 17:17:51 INFO - PROCESS | 1652 | 17:17:51 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:1.57 (1.4%) stddev-sans-first:1.59 17:17:51 INFO - PROCESS | 1652 | Values: 111.0 113.0 114.0 109.0 113.0 114.0 113.0 112.0 113.0 111.0 17:17:51 INFO - PROCESS | 1652 | 17:17:51 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:119.20 Median:112.00 stddev:14.66 (13.1%) stddev-sans-first:13.68 17:17:51 INFO - PROCESS | 1652 | Values: 139.0 110.0 109.0 148.0 110.0 111.0 109.0 112.0 132.0 112.0 17:17:51 INFO - PROCESS | 1652 | 17:17:51 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:187.30 Median:184.50 stddev:13.00 (7.0%) stddev-sans-first:13.73 17:17:51 INFO - PROCESS | 1652 | Values: 184.0 185.0 183.0 185.0 185.0 182.0 180.0 224.0 183.0 182.0 17:17:51 INFO - PROCESS | 1652 | 17:17:51 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:65.50 Median:61.00 stddev:10.38 (17.0%) stddev-sans-first:9.80 17:17:51 INFO - PROCESS | 1652 | Values: 79.0 59.0 59.0 87.0 60.0 61.0 59.0 61.0 73.0 57.0 17:17:51 INFO - PROCESS | 1652 | 17:17:51 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:74.80 Median:75.50 stddev:8.43 (11.2%) stddev-sans-first:7.21 17:17:51 INFO - PROCESS | 1652 | Values: 89.0 70.0 85.0 68.0 68.0 69.0 81.0 67.0 69.0 82.0 17:17:51 INFO - PROCESS | 1652 | 17:17:51 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:87.50 stddev:2.01 (2.3%) stddev-sans-first:2.05 17:17:51 INFO - PROCESS | 1652 | Values: 88.0 84.0 89.0 85.0 88.0 85.0 89.0 85.0 87.0 84.0 17:17:51 INFO - PROCESS | 1652 | 17:17:51 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:101.10 Median:93.00 stddev:18.44 (19.8%) stddev-sans-first:19.32 17:17:51 INFO - PROCESS | 1652 | Values: 93.0 93.0 93.0 94.0 93.0 93.0 92.0 117.0 149.0 94.0 17:17:51 INFO - PROCESS | 1652 | 17:17:51 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:106.80 Median:77.00 stddev:26.82 (34.8%) stddev-sans-first:28.04 17:17:51 INFO - PROCESS | 1652 | Values: 94.0 88.0 70.0 128.0 141.0 86.0 84.0 101.0 143.0 133.0 17:17:51 INFO - PROCESS | 1652 | 17:17:51 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:1.03 (1.9%) stddev-sans-first:0.87 17:17:51 INFO - PROCESS | 1652 | Values: 57.0 54.0 56.0 54.0 54.0 55.0 55.0 56.0 55.0 56.0 17:17:51 INFO - PROCESS | 1652 | 17:17:51 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:3.60 (5.1%) stddev-sans-first:3.36 17:17:51 INFO - PROCESS | 1652 | Values: 65.0 74.0 65.0 70.0 77.0 70.0 70.0 69.0 69.0 70.0 17:17:51 INFO - PROCESS | 1652 | 17:17:51 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:87.00 stddev:2.01 (2.3%) stddev-sans-first:1.94 17:17:51 INFO - PROCESS | 1652 | Values: 90.0 87.0 87.0 86.0 86.0 87.0 85.0 90.0 91.0 87.0 17:17:51 INFO - PROCESS | 1652 | 17:17:51 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:151.70 Median:146.50 stddev:20.07 (13.7%) stddev-sans-first:20.97 17:17:51 INFO - PROCESS | 1652 | Values: 142.0 146.0 148.0 147.0 141.0 142.0 137.0 137.0 196.0 181.0 17:17:51 INFO - PROCESS | 1652 | 17:17:51 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:174.00 stddev:2.21 (1.3%) stddev-sans-first:2.33 17:17:51 INFO - PROCESS | 1652 | Values: 174.0 174.0 176.0 176.0 175.0 169.0 173.0 171.0 173.0 172.0 17:17:51 INFO - PROCESS | 1652 | 17:17:51 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:75.00 stddev:8.46 (11.3%) stddev-sans-first:8.66 17:17:51 INFO - PROCESS | 1652 | Values: 68.0 71.0 79.0 84.0 86.0 86.0 69.0 67.0 67.0 66.0 17:17:51 INFO - PROCESS | 1652 | -------- Summary: end -------- 17:17:51 INFO - PROCESS | 1652 | 17:17:52 INFO - TEST-INFO | 1652: exit 0 17:17:52 INFO - TEST-OK | kraken | took 59674ms 17:17:52 INFO - SUITE-END | took 1178s 17:17:52 INFO - Completed test suite (00:19:39) 17:17:52 INFO - javascript benchmark 17:17:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3030.8939187128453, 3338.3990881641294, 3353.765236433449, 3356.9496457553128, 3401.9149521261966, 5606.523445507127, 5659.377468478469, 5689.061304884689, 5691.971540142294, 5711.800086996951, 5695.829125126243, 5756.366799652035, 5761.711914404274, 5763.596548241625, 5773.191753154551, 5180.637355385134, 5204.505571970657, 5229.947700522984, 5255.106631872591, 5272.710000949946, 5307.442718514559, 5316.175992721134, 5318.73406329682, 5318.76065577048, 5332.280142180814, 5298.0, 5304.20436934461, 5304.734763261841, 5306.124489459235, 5307.99148161848, 5304.151335786275, 5313.256144139824, 5315.441878602768, 5317.867053323659, 5322.308099947021, 5128.743562821844, 5151.716655583941, 5246.344206974129, 5248.921266181011, 5254.7635356409055, 5678.233438485793, 5690.374058853523, 5733.082706766939, 5764.135379693038, 5768.682722450264, 6213.906791398133, 6229.190205273286, 6244.469220116295, 6256.937430625681, 6268.623882567061, 6193.380661933816, 6232.34560371159, 6274.0, 6292.2134733158355, 6299.8740025199695, 5894.6757928314355, 5898.764049437975, 5917.763289468373, 5923.466887980103, 5939.881202375928, 6340.841478963062, 6343.777967771106, 6350.650714210763, 6355.3644635537, 6359.554831161867, 6094.360092190344, 6150.646857691301, 6166.969165154235, 6187.0, 6241.812745617639, 6310.716017779211, 6333.398327159005, 6345.841353966188, 6347.841303967438, 6348.269948955837, 6237.812865614039, 6252.468540174045, 6292.150559674477, 6306.621602703761, 6314.8421289467215, 6191.597546159485, 6231.40801623845, 6348.714307856158, 6359.96820015897, 6370.617762934146, 4984.551390374883, 5011.198208286657, 5016.673916195436, 5040.193569028937, 5071.771770270347, 4460.107978404332, 4468.329750537446, 4477.485089214782, 4479.888002799956, 4503.392042074343, 5715.371309155989, 5796.304443466811, 5858.297004359419, 5874.265716785402, 5875.853103672443, 6219.129321894939, 6263.812085637438, 6308.243010838729, 6313.3686631336495, 6320.399562041599, 5819.359870414251, 5871.7651293947765, 5876.001079816441, 5893.616914900518, 5900.7049647518315, 5394.62237643369, 5437.102878025082, 5446.645968012067, 5480.671159730429, 5519.282493275929, 6288.119663247057, 6315.494760419156, 6366.267879193952, 6372.936270637234, 6393.8721225576155, 6178.814635560941, 6208.782692605737, 6288.6855657217875, 6316.399942005502, 6336.239651241881, 6375.458086062551, 6386.616802991835, 6387.872242555216, 6394.0, 6418.839529011812, 5160.819371321985, 6253.0, 6324.0513922910095, 6346.492280617447, 6347.238331400077, 6226.657533835682, 6257.530685198537, 6275.937240627718, 6282.371762823681, 6298.307186209605, 6021.909671354845, 6237.345078766664, 6238.6880655967925, 6250.781222657185, 6258.968705156627, 6170.259568851767, 6208.161898143873, 6211.782587609412, 6218.31598524171, 6250.312465628686, 4848.80604775805, 5955.67243801595, 5976.432238937294, 6082.239720034996, 6112.297085835008, 4813.542713442217, 6230.7819226326865, 6234.657093859882, 6240.251169859646, 6253.312135664983, 6063.757449702139, 6072.666003369681, 6080.72636731357, 6085.4523092921845, 6092.725827337869], "value": 5751.080168242964, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.94687610924734, 490.73990784884023, 493.79013919084383, 528.8281308574713, 538.6229639252522, 29667.96162134323, 32056.839715801445, 32169.0, 32186.03441896744, 32194.0, 39783.80108099463, 41866.0, 42690.93272668185, 42728.14543709124, 42962.78518607403, 7830.647620857061, 9357.81284374312, 9417.246620270362, 9432.575534100948, 9434.858477122849, 8227.670893164266, 9331.72004839856, 9394.577244024036, 9411.105944935254, 9413.105754953269, 8485.490870547786, 8658.0, 8668.566571671392, 8671.826563468727, 11132.276402033882, 11033.227674062819, 11359.545618175263, 11376.374299413528, 11381.943090284496, 11384.666143440658, 11173.273737207055, 11252.49363778632, 11253.324800511913, 11254.437278136142, 11257.887421125848, 31427.37145257105, 31622.841885790654, 39156.80421597874, 39211.607883921366, 39544.40683389751, 4016.650046387941, 4066.0241542029994, 4112.300908845504, 4167.291560434703, 4192.0777428965575, 24607.63088553673, 30433.23916902095, 30866.69133308683, 31064.534031989537, 31469.842650786828, 3173.1115287719476, 3284.1953721338186, 3308.8511017004294, 3350.525768661781, 3350.7654464187517, 467222.0, 473489.0, 475504.0, 475517.6224118892, 476342.0, 54008.0, 54409.0, 54445.72777136089, 54479.0, 54521.1821822673, 58763.41236587665, 60133.09800352998, 61547.6922615393, 61655.69172154111, 61734.382656172864, 15751.212439378214, 15965.441209557843, 15967.962082464603, 15990.040597564184, 16003.839961600468, 12445.25328480294, 12516.12387132892, 12525.937370313273, 12542.874571254171, 12551.560695375802, 12517.56188533397, 13485.190888546718, 14914.850851491563, 15361.539153825403, 15571.84428155704, 5698.971505142531, 6831.45348372139, 6976.7209311627985, 7054.541454805421, 7119.501634885612, 867.5598506479214, 872.6334939325499, 881.7663319220412, 892.1747383670079, 914.4878867834034, 25294.367640809127, 28307.71692283092, 29565.85217073901, 30143.246418839266, 30416.695833041827, 1027.1372047480152, 1029.480112543176, 1055.4142450939648, 1068.8022715797601, 1069.9144068474504, 13544.322783860767, 14044.016918815585, 14126.048741510229, 14170.85829141716, 14404.639884002983, 513916.0, 526225.0, 526286.0, 576820.0, 580803.0, 49615.759606010135, 49826.0, 49858.26063045286, 49991.0001799962, 50007.0, 1404.45226361719, 1439.2156274830243, 1452.4190323870537, 1453.0, 1457.0237940579837, 22744.545109097395, 25732.742672573033, 26874.865625671748, 27042.0, 27080.864595676896, 42292.577074228866, 45085.77457112693, 45209.547904520536, 45230.54769452263, 45265.32102018538, 496553.51723241154, 500629.0, 501755.0, 502524.48737756076, 502713.0, 23697.52604947857, 23794.04823807028, 24399.26802195937, 24527.896244668675, 25431.745682542936, 41585.69724448233, 42169.1566168681, 42711.57288427076, 42932.0, 43028.56971430246, 27900.0, 34226.657733423344, 34662.30675386528, 35567.755128570374, 36060.0, 28066.228741114468, 30364.848175759864, 34519.65480345265, 34886.12784680403, 35725.28549429049, 25891.61162582525, 34824.303513930085, 35181.82409087938, 35484.46773298351, 35591.11022224465, 30567.54148687816, 31872.5219121718, 31895.0, 31896.8405157982, 32002.67997319997, 19289.710654339917, 23736.40658983539, 24023.639645404983, 24076.51846963086, 24317.75682243155], "value": 18752.006432205086, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.72135013339454, 366.9137752628134, 376.33201068104114, 386.7486134012893, 400.3434367637076, 14797.704045919088, 14984.17587032714, 15921.442749503783, 20034.89982550089, 20923.476913077182, 20690.068946897387, 20924.26765063223, 21427.892860535674, 21487.818170000643, 21781.128754849786, 5693.658380497183, 5789.334226563936, 5925.31858836235, 5934.762609495615, 5939.584229103964, 5962.612430192024, 6118.847028824271, 6120.908186377208, 6121.479674227674, 6125.387461253861, 3930.3711406175016, 4021.5777343378963, 4122.402251673506, 4123.8969025774295, 4261.659067274626, 4140.068484590973, 6755.0, 6763.763268285636, 6780.6948687308695, 6782.186137663462, 5801.419858014207, 5966.612170208966, 6006.0, 6017.939820601781, 6035.698215089228, 13148.342582870913, 13388.464461421532, 13573.0, 16259.91870040654, 25087.498250035078, 2366.266457398212, 2572.8199026068182, 2598.2724837045466, 2616.2936007278117, 2667.7999150063824, 9731.90268097324, 10012.94993525035, 10232.43721595312, 10535.947320263427, 10599.735006624818, 1708.974615230864, 1784.8750587458883, 1830.130687923239, 1846.9261229550802, 1910.5892233169934, 109011.0, 128389.35805320913, 131172.34413827964, 131372.34313828466, 132697.33651331777, 11597.594084207012, 11616.0, 11811.586594469325, 11833.763324733458, 11902.285862848257, 15012.699746005019, 15409.614759631098, 15426.6143346415, 15459.845401546065, 15465.536033919001, 8257.339412846957, 8527.53098579584, 8556.486610803371, 8701.129887011248, 8727.170918762708, 8275.586220688941, 8296.128906464734, 8309.255056438216, 8424.957875210584, 8458.06961234276, 4670.20142209206, 4757.595604373598, 4771.832985845479, 4829.758512074382, 4911.7544122793715, 1976.2391479280293, 2029.7158397824317, 2032.4309193425865, 2042.7242322286597, 2044.672852343618, 823.6581818545236, 837.6314421654453, 859.4456575508761, 868.7133246028795, 877.7761670774039, 19011.61976760457, 20554.58890822175, 21199.72801631907, 21405.143794248055, 21484.570308594055, 771.8572064168147, 838.8591515538862, 887.60057973912, 919.5907821019582, 921.0, 10328.328658637165, 11107.94446027781, 11177.608783692533, 11180.552777888955, 11237.0, 671177.0, 674087.0, 675871.0, 684399.0, 688487.557562219, 138668.0, 144569.0, 150337.0, 150872.0, 158260.41739582457, 977.4965892565334, 1024.114141267798, 1053.431147180514, 1053.994730026345, 1058.9205809564314, 19130.7130393047, 19354.8064519353, 19621.566225910694, 19626.0, 19722.211111555378, 56543.0, 56568.71715641396, 56826.43173568211, 57025.0, 57536.71231643815, 79442.01394965172, 79706.2029379722, 80075.19924800677, 81029.0, 82052.76920846073, 7549.207333230152, 8009.519428834288, 8125.634346454542, 8211.21993410625, 8469.957650211956, 9476.573554190216, 10492.055714985689, 11528.654140375802, 11791.34921111028, 12479.87520124787, 10474.423906685206, 10743.785124297627, 10883.401412922049, 10954.507047183055, 11164.274322169033, 10658.040776330168, 10825.783484330426, 11105.0, 11207.49566269536, 11289.604863829727, 9543.0456954304, 10852.565897364017, 10989.120870330195, 11282.097432205239, 11300.49147788368, 7063.505554611128, 7261.174278095691, 7437.628118593941, 8113.107558168479, 8330.50016998982, 8240.711575094843, 9761.0, 10719.196060295353, 11274.154438417316, 11491.942540287246], "value": 9456.542306544166, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.4681367893882, 1460.9342579583918, 1462.561231630511, 1482.162578143349, 1482.3774014913736, 6692.966535167324, 8440.704575339865, 8450.0, 8450.661973521059, 8487.91512084879, 7165.426765858731, 7385.889211661829, 7398.889016664741, 7987.4408791384485, 8239.794005149859, 2277.214361045437, 2332.463533387322, 2336.5677349690277, 2340.496793189464, 2344.6365813298967, 2294.4837411582344, 2318.4435735423463, 2325.837191396603, 2338.4270853640883, 2340.0405833608224, 2264.094362255103, 2280.247518318951, 2302.7466978632337, 2310.9653355199684, 2311.9422014449606, 1918.9232430702755, 2269.9773002270013, 2291.702078729771, 2292.094622624071, 2294.128231272106, 2226.7216597925258, 2312.953740925189, 2314.837961342707, 2318.362450326174, 2319.9652005219937, 8368.288695460893, 8452.535110568917, 8458.915410845935, 8459.323254139654, 8461.069282378934, 5087.847364579068, 5231.843044708665, 5235.424103348629, 5239.240310155044, 5244.160934250502, 2908.6218791557176, 3275.328557645677, 3327.168207948013, 3531.682148606612, 3532.0993146747674, 1083.0415082651832, 1177.2877409167502, 1204.2894692131683, 1205.993970030153, 1237.3874931908672, 10256.435896025716, 10655.680329590046, 10690.0, 10790.892091079146, 10792.514336854782, 3897.4738410314812, 4461.531539188403, 4596.264597664358, 4631.397918270603, 4700.741459219776, 9257.39826911262, 9475.573599188054, 9553.283503737248, 9556.187724043395, 9570.856437153448, 5182.53357197854, 5272.340957380327, 5284.735763211824, 5286.286351342596, 5308.548773354308, 4204.411382406465, 4543.727376357429, 4784.067106914188, 4829.806807727651, 4860.295257187688, 3748.5876553579083, 3772.1889793694486, 3777.4522694209736, 3849.82675779585, 3886.7862267574988, 1071.8552995345685, 1290.1098242213031, 1296.1704509114174, 1304.0610760252603, 1304.5955753716378, 827.6523859978823, 839.1650307943635, 844.2950136635855, 879.7932485865816, 884.0054938194531, 5005.299258103868, 5022.472640372708, 5110.310108135354, 5259.053370393366, 5307.363116426053, 932.3566738950103, 947.1144479911305, 972.397113789455, 975.5463709375175, 1017.389566260238, 3362.4956256561713, 3378.5945686517284, 3392.8642854285554, 3477.808720520345, 3500.0, 9902.504874756234, 10156.796864062677, 10170.644027459151, 10175.745606359753, 10183.898161018295, 8819.867701984474, 9860.0, 9882.4564648945, 9997.650082247232, 10119.645812396531, 7681.116671582728, 7919.445638805343, 7927.563983980936, 7928.088269848926, 7928.207179282141, 5121.359830021247, 5166.586673066071, 5305.9204111939125, 5365.409804921377, 5366.382865970463, 9070.138336857988, 9076.500792456214, 9081.59132839037, 9240.907590924005, 9334.533273336441, 9243.352965292634, 9328.440293582407, 9442.575084121094, 9456.385334953206, 9471.384360016576, 6661.4004739573675, 6895.931040689529, 7002.124734408199, 7162.928370716226, 7307.3423391894985, 7997.560134192675, 8062.1534738853925, 8084.312833408991, 8086.474379165335, 8087.878681819895, 6960.952456924027, 7139.500234983501, 7172.031775710212, 7197.1363436387965, 7279.0, 6951.16586009682, 6978.755743549154, 7037.0, 7135.179454362607, 7146.249643787535, 5011.824586139468, 5671.489565939085, 6081.878362432638, 6105.847353816012, 6114.694265286629, 4571.794269257958, 4627.6066534344955, 4629.166749985035, 4702.764861756967, 4813.470518243061, 4376.715513491613, 4405.603495685275, 4429.756363400044, 4526.162659907927, 4537.481697657831], "value": 4342.765206694215, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.6800427608738, 353.63045617329885, 359.5846796949523, 369.31123454756886, 371.92375563009585, 4338.418640908654, 4512.774361281935, 4589.678722489427, 5075.0, 5382.900668739195, 4633.698809577375, 4974.651774375786, 5014.699118052919, 5218.425973142951, 5223.294855194547, 3884.35908075168, 4075.531313898895, 4093.9590604094024, 4102.917941641165, 4132.615573782787, 4053.7501686563946, 4097.79511024449, 4126.525449573308, 4129.380592911058, 4168.310650518167, 3382.6955573998334, 3608.7654302470387, 3679.319325924699, 3814.542254929412, 4106.480602177198, 4096.7914465232825, 4098.057446787241, 4107.747137123191, 4111.465509483778, 4143.197708996596, 3025.727684508383, 3565.94651080234, 3633.2378796284047, 3655.6915991028163, 3666.0, 4282.314829627245, 4671.48613652498, 5112.667676601009, 5138.2806407103035, 5157.53582177602, 4102.789677045279, 4267.551907049746, 4483.125790470827, 4576.084783043405, 4800.583463213851, 4819.975900120512, 5282.630215884889, 5554.250176226238, 5568.888622227573, 5592.965301419251, 3257.9086006187717, 3500.352434799545, 4022.2503211103262, 4030.3148464760766, 4058.756474611503, 4896.730679812609, 5491.752871120809, 5558.859838961988, 5698.572607054488, 5981.910271345933, 3775.169462718198, 3786.678132358725, 3787.9431808522895, 3816.217675376541, 3837.5394952605866, 3271.214908421962, 3592.8383222755037, 3854.69162467002, 3904.6876249899938, 3915.334393153171, 3791.1659434924272, 4187.602177793105, 4269.310334489314, 4527.909441811211, 4580.610648094883, 5572.331320241597, 5600.943990560124, 5609.298837645294, 5617.269754931915, 5623.409541998031, 1132.1452303510796, 1160.2748282323548, 1259.703969567151, 1259.829922960407, 1262.223732404583, 793.9519833819419, 799.2127754162145, 809.8177909970327, 812.7439856445319, 817.9468334558235, 4846.903061938741, 4851.636127290467, 4879.072976134523, 4887.29134275528, 4998.750062496933, 4701.4358277006295, 4732.881677958078, 4866.48901865299, 5289.942011597619, 5332.0, 4472.865814025585, 4485.237509623372, 4605.631549476034, 4853.538913803183, 4945.184044632667, 2568.4349443122483, 2711.996561272302, 2806.564982427727, 2819.3938303264895, 2823.929401764972, 4781.928271075867, 5428.344354971771, 5539.5014448699, 5610.551155907518, 5667.631603945731, 4628.755053798905, 4631.7767471613815, 5004.520953746377, 5144.0, 5561.443855614406, 4891.33966914462, 5593.552515798727, 5597.720113994365, 5601.963636727137, 5618.522425593788, 4491.955080449154, 4751.904961900674, 4871.5385384383835, 5215.6609820361555, 5388.892222155457, 4491.820327187007, 4703.435587729495, 4801.51984801531, 5024.472430394756, 5277.313949186581, 4852.369192005017, 4983.07813054586, 5232.645309610766, 5597.928766356475, 5669.489745922887, 3345.7119009181156, 3607.3045668535747, 3625.945610815787, 3631.6368363163474, 3631.8002509862213, 4690.3199036138885, 4918.975405123095, 5198.636095473281, 5420.620556561003, 5686.715664216856, 5592.804251851328, 5623.678435567556, 5628.746706398304, 5635.380108188014, 5688.3742788294085, 5279.46895400345, 5306.602004849575, 5584.4136365681015, 5630.0, 5663.745131469176, 5344.412114667306, 5441.5102640762525, 5442.619016668795, 5473.562115030868, 5541.362743284574, 4416.6025057744955, 4811.927821082617, 5392.703401312965, 5426.158945363317, 5596.18727894019, 4925.3157029418335, 5416.918746218888, 5438.129899216106, 5442.537384322219, 5493.917591236214], "value": 3953.680642706473, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.173974059961, 718.6083584446483, 782.9625745886698, 821.5974172655399, 834.0908409833282, 11938.940305298473, 15346.232688365593, 15407.152606606633, 16927.57681057971, 17831.0, 15959.680806383865, 16416.261268242928, 16773.329066837312, 17075.48773536793, 17076.316947322124, 862.3403096631066, 882.3470631732536, 882.7087061269798, 883.4169448164213, 886.0917559501498, 691.695653912277, 891.1222445890793, 892.7768057985504, 895.4269267668698, 895.7581453007684, 744.1553836395702, 746.0636900689627, 908.0646933658343, 933.1321870660283, 941.5668792355525, 755.2938002967188, 801.1907972947365, 926.9304802139833, 930.4370855632312, 931.3387494878644, 685.0204207982583, 689.3692271571556, 691.0877641513205, 691.1050190003957, 691.6921969723475, 10992.890071099268, 12103.818442723366, 12338.444769985372, 12576.874231257754, 13724.65688357789, 14166.575002749934, 14328.355224014944, 14479.42082316706, 14801.925990370088, 14945.850541494554, 11555.76888462226, 11636.360000199986, 11795.882041179564, 11839.11206659504, 12279.815802762876, 3739.9813000934823, 3755.4742336072973, 3767.7550959187565, 3777.867774627875, 3924.097457584743, 104210.0, 106684.0, 106934.0, 107202.46398767956, 107519.0, 11255.774884502427, 11319.830202546967, 11343.773124537463, 11436.599719009795, 11544.59593914209, 24031.158909438087, 24382.0, 24413.38966525851, 24414.389640259134, 24476.388090297885, 7823.647935842901, 7843.0, 7871.0, 7895.407844411578, 8030.879536806952, 4272.87181384559, 4283.0, 4334.761588112621, 4365.497967733688, 4459.152760975469, 3593.3711600469815, 3655.94516082259, 3697.279030589063, 3697.630236976335, 3702.2225332680437, 632.3613150717808, 636.9140166077613, 649.3279455763262, 649.6199723161909, 654.7610122305324, 650.5056157320471, 656.9113169722121, 691.1429827014466, 693.5699866083061, 723.7756295548397, 7858.960705196438, 10003.299769016245, 10276.0, 10514.684559463229, 10545.31455455393, 655.2890114226118, 695.979120626382, 702.5995182745888, 705.2074575935887, 730.1311439387113, 4450.888727781831, 4651.7179131420835, 4673.088747694167, 4724.267738500538, 4751.429828420542, 80639.0, 99341.50329248307, 99729.50135249278, 102339.0, 102936.48531757294, 89348.29887758315, 89716.5514172438, 91983.0, 92699.07300926905, 93272.0, 78295.60852195702, 78741.2125878734, 79810.40379192383, 79828.0, 80487.39025219463, 9063.954680226556, 9106.95446522763, 9153.816923661623, 9219.262459003397, 9231.123043310874, 40291.597084029956, 46115.538844611125, 46391.84020399517, 47945.280820788415, 48359.27461088016, 50526.494735052176, 51107.744461277456, 58641.12038319514, 59772.40227597668, 62188.0, 10003.399796012263, 11763.294202347886, 11978.0, 12086.758264834478, 12228.0, 12604.684882878002, 12733.29966851832, 12820.807687884502, 12990.415431305802, 13212.14121082165, 11774.882251177378, 12088.576899808464, 12107.515699371927, 12136.817947730615, 12555.686107847378, 11025.897410258909, 11724.0, 11876.346800926032, 11883.287002779862, 12085.697857553632, 11668.533258669559, 12049.277043377426, 12050.939745301217, 12057.0, 12083.154179207722, 9327.486988215713, 9783.804323913624, 9966.417613862357, 10113.949430252802, 10233.334833235816, 11314.434278286217, 11380.829287560859, 11384.316940983568, 11656.417179141179, 11782.941085294518], "value": 7354.963630078399, "unit": "score"}], "name": "dromaeo_css", "value": 7106.473403581202, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 114.0, 109.0, 113.0, 114.0, 113.0, 112.0, 113.0, 111.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 110.0, 109.0, 148.0, 110.0, 111.0, 109.0, 112.0, 132.0, 112.0], "value": 119.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 183.0, 185.0, 185.0, 182.0, 180.0, 224.0, 183.0, 182.0], "value": 187.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 59.0, 87.0, 60.0, 61.0, 59.0, 61.0, 73.0, 57.0], "value": 65.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 85.0, 68.0, 68.0, 69.0, 81.0, 67.0, 69.0, 82.0], "value": 74.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 89.0, 85.0, 88.0, 85.0, 89.0, 85.0, 87.0, 84.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 94.0, 93.0, 93.0, 92.0, 117.0, 149.0, 94.0], "value": 101.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 88.0, 70.0, 128.0, 141.0, 86.0, 84.0, 101.0, 143.0, 133.0], "value": 106.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 56.0, 54.0, 54.0, 55.0, 55.0, 56.0, 55.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 65.0, 70.0, 77.0, 70.0, 70.0, 69.0, 69.0, 70.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 87.0, 86.0, 86.0, 87.0, 85.0, 90.0, 91.0, 87.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 146.0, 148.0, 147.0, 141.0, 142.0, 137.0, 137.0, 196.0, 181.0], "value": 151.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 176.0, 176.0, 175.0, 169.0, 173.0, 171.0, 173.0, 172.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 79.0, 84.0, 86.0, 86.0, 69.0, 67.0, 67.0, 66.0], "value": 74.3, "unit": "score"}], "name": "kraken", "value": 1465.3999999999999, "alertThreshold": 2.0}]} 17:17:52 INFO - Return code: 0 17:17:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:17:52 ERROR - # TBPL SUCCESS # 17:17:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:17:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:17:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:17:52 INFO - 2017-01-13 17:17:52.724 screenresolution[1656:10079] starting screenresolution argv=screenresolution get 17:17:52 INFO - 2017-01-13 17:17:52.726 screenresolution[1656:10079] Display 0: 1600x1200x32@60 17:17:52 INFO - 2017-01-13 17:17:52.732 screenresolution[1657:10082] starting screenresolution argv=screenresolution list 17:17:52 INFO - Available Modes on Display 0 17:17:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:17:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:17:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:17:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:17:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:17:52 INFO - Intel Iris: 17:17:52 INFO - Chipset Model: Intel Iris 17:17:52 INFO - Type: GPU 17:17:52 INFO - Bus: Built-In 17:17:52 INFO - VRAM (Dynamic, Max): 1536 MB 17:17:52 INFO - Vendor: Intel (0x8086) 17:17:52 INFO - Device ID: 0x0a2e 17:17:52 INFO - Revision ID: 0x0009 17:17:52 INFO - Displays: 17:17:52 INFO - Display: 17:17:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:17:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:17:52 INFO - Display Serial Number: 1600x1200 60 17:17:52 INFO - Main Display: Yes 17:17:52 INFO - Mirror: Off 17:17:52 INFO - Online: Yes 17:17:52 INFO - Rotation: Supported 17:17:52 INFO - Return code: 0 17:17:52 INFO - Running post-action listener: _resource_record_post_action 17:17:52 INFO - [mozharness: 2017-01-14 01:17:52.969249Z] Finished run-tests step (success) 17:17:52 INFO - Running post-run listener: _resource_record_post_run 17:17:53 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 37749760; Write bytes: 551431168; Read time: 242; Write time: 1662 17:17:53 INFO - TinderboxPrint: CPU usage
53.7% 17:17:53 INFO - TinderboxPrint: I/O read bytes / time
37,749,760 / 242 17:17:53 INFO - TinderboxPrint: I/O write bytes / time
551,431,168 / 1,662 17:17:53 INFO - TinderboxPrint: CPU idle
2,223.1 (46.3%) 17:17:53 INFO - TinderboxPrint: CPU system
962.6 (20.0%) 17:17:53 INFO - TinderboxPrint: CPU user
1,619.9 (33.7%) 17:17:53 INFO - TinderboxPrint: Swap in / out
289,144,832 / 0 17:17:53 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 249580032; Write bytes: 242003968; Read time: 18084; Write time: 523 17:17:53 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 34350080; Write bytes: 297790464; Read time: 218; Write time: 1105 17:17:53 INFO - Running post-run listener: _upload_blobber_files 17:17:53 INFO - Blob upload gear active. 17:17:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:17:53 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 17:17:53 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'] 17:17:53 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 17:17:53 INFO - (blobuploader) - INFO - Open directory for files ... 17:17:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:17:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:17:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:54 INFO - (blobuploader) - INFO - Done attempting. 17:17:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:17:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:17:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:55 INFO - (blobuploader) - INFO - Done attempting. 17:17:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:17:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:17:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:57 INFO - (blobuploader) - INFO - Done attempting. 17:17:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:17:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:17:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:59 INFO - (blobuploader) - INFO - Done attempting. 17:17:59 INFO - (blobuploader) - INFO - Iteration through files over. 17:17:59 INFO - Return code: 0 17:17:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:17:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:17:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/114c40d7842105d709c9db119aa3ec8e46a5581036266a9d9aeb39282d8361acbcb71d17121d953a86bf19e3483b950e57902f500614f3bdd7efbb94f981a47c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f77f038e19b93f1da152be9dc04cdb59967a49d78a3c8ecfb91ec46fd3c10917ba684714d70b712f3578a2e3a58dab273b01593e01c24d5640f06f8771832c63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a299618e448beb345bc5478f810fc6ae3090ea39acabf5330630f3c447bc6dd32af9ea9636192ae0f01cac7602c134b13b6ba3462517a2bfbaab419d55cfb26", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40af6e6b942dcabc11c3658495e4388b673480729a67c1b4a4d70b4a064427e1dbe3bb51da0e1ed3f819cf943a164eb4bea1e24eb0691a70af63793f955bab95"} 17:17:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:17:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:17:59 INFO - Contents: 17:17:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/114c40d7842105d709c9db119aa3ec8e46a5581036266a9d9aeb39282d8361acbcb71d17121d953a86bf19e3483b950e57902f500614f3bdd7efbb94f981a47c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f77f038e19b93f1da152be9dc04cdb59967a49d78a3c8ecfb91ec46fd3c10917ba684714d70b712f3578a2e3a58dab273b01593e01c24d5640f06f8771832c63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a299618e448beb345bc5478f810fc6ae3090ea39acabf5330630f3c447bc6dd32af9ea9636192ae0f01cac7602c134b13b6ba3462517a2bfbaab419d55cfb26", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40af6e6b942dcabc11c3658495e4388b673480729a67c1b4a4d70b4a064427e1dbe3bb51da0e1ed3f819cf943a164eb4bea1e24eb0691a70af63793f955bab95"} 17:17:59 INFO - Running post-run listener: copy_logs_to_upload_dir 17:17:59 INFO - Copying logs to upload dir... 17:17:59 INFO - mkdir: /builds/slave/test/build/upload/logs 17:17:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.361352 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-13 17:17:59.547893) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 17:17:59.551506) ========= 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.cUtvhf90KY/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.u6q4Bv852e/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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/114c40d7842105d709c9db119aa3ec8e46a5581036266a9d9aeb39282d8361acbcb71d17121d953a86bf19e3483b950e57902f500614f3bdd7efbb94f981a47c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f77f038e19b93f1da152be9dc04cdb59967a49d78a3c8ecfb91ec46fd3c10917ba684714d70b712f3578a2e3a58dab273b01593e01c24d5640f06f8771832c63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a299618e448beb345bc5478f810fc6ae3090ea39acabf5330630f3c447bc6dd32af9ea9636192ae0f01cac7602c134b13b6ba3462517a2bfbaab419d55cfb26", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40af6e6b942dcabc11c3658495e4388b673480729a67c1b4a4d70b4a064427e1dbe3bb51da0e1ed3f819cf943a164eb4bea1e24eb0691a70af63793f955bab95"} build_url:https://queue.taskcluster.net/v1/task/F3mOtD_FTWiQqkVXMdG79A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010916 build_url: 'https://queue.taskcluster.net/v1/task/F3mOtD_FTWiQqkVXMdG79A/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/114c40d7842105d709c9db119aa3ec8e46a5581036266a9d9aeb39282d8361acbcb71d17121d953a86bf19e3483b950e57902f500614f3bdd7efbb94f981a47c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f77f038e19b93f1da152be9dc04cdb59967a49d78a3c8ecfb91ec46fd3c10917ba684714d70b712f3578a2e3a58dab273b01593e01c24d5640f06f8771832c63", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a299618e448beb345bc5478f810fc6ae3090ea39acabf5330630f3c447bc6dd32af9ea9636192ae0f01cac7602c134b13b6ba3462517a2bfbaab419d55cfb26", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40af6e6b942dcabc11c3658495e4388b673480729a67c1b4a4d70b4a064427e1dbe3bb51da0e1ed3f819cf943a164eb4bea1e24eb0691a70af63793f955bab95"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 17:17:59.592170) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 17:17:59.592669) ========= 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.cUtvhf90KY/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.u6q4Bv852e/Listeners TMPDIR=/var/folders/z9/ny7vg3vx1vq0s9z7q18thht400000w/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.004739 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 17:17:59.644443) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 17:17:59.645009) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 17:17:59.645577) ========= ========= Total master_lag: 0.20 =========