builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0374 starttime: 1489727992.73 results: success (0) buildid: 20170316212021 builduid: fd0ca423b45c44828d300212468b05b8 revision: 20f404abbe681ecb3203095c7583354d54302adf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-16 22:19:52.726329) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-16 22:19:52.726807) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-16 22:19:52.727081) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-16 22:19:52.754156) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 22:19:52.754546) ========= 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.xMN678Se2u/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.7Sc12PxZGY/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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-03-16 22:19: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% 18.8M=0.001s 2017-03-16 22:19:52 (18.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106800 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 22:19:52.885638) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 22:19:52.886009) ========= 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.xMN678Se2u/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.7Sc12PxZGY/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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.026245 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 22:19:52.934992) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 22:19:52.935348) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 20f404abbe681ecb3203095c7583354d54302adf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 20f404abbe681ecb3203095c7583354d54302adf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xMN678Se2u/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.7Sc12PxZGY/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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-03-16 22:19:53,048 truncating revision to first 12 chars 2017-03-16 22:19:53,048 Setting DEBUG logging. 2017-03-16 22:19:53,048 attempt 1/10 2017-03-16 22:19:53,048 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/20f404abbe68?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-16 22:19:53,734 unpacking tar archive at: mozilla-beta-20f404abbe68/testing/mozharness/ program finished with exit code 0 elapsedTime=0.968768 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 22:19:53.928412) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-16 22:19:53.928730) ========= script_repo_revision: 20f404abbe681ecb3203095c7583354d54302adf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-16 22:19:53.929175) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-16 22:19:53.929438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-16 22:19:53.949464) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-16 22:19:53.949894) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xMN678Se2u/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.7Sc12PxZGY/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 22:19:54 INFO - MultiFileLogger online at 20170316 22:19:54 in /builds/slave/test 22:19:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 22:19:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:19:54 INFO - {'append_to_log': False, 22:19:54 INFO - 'base_work_dir': '/builds/slave/test', 22:19:54 INFO - 'blob_upload_branch': 'Mozilla-Beta', 22:19:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:19:54 INFO - 'branch': 'Mozilla-Beta', 22:19:54 INFO - 'buildbot_json_path': 'buildprops.json', 22:19:54 INFO - 'config_files': ('talos/mac_config.py',), 22:19:54 INFO - 'default_actions': ('clobber', 22:19:54 INFO - 'read-buildbot-config', 22:19:54 INFO - 'download-and-extract', 22:19:54 INFO - 'populate-webroot', 22:19:54 INFO - 'create-virtualenv', 22:19:54 INFO - 'install', 22:19:54 INFO - 'run-tests'), 22:19:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:19:54 INFO - 'download_minidump_stackwalk': True, 22:19:54 INFO - 'download_symbols': 'ondemand', 22:19:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:19:54 INFO - 'tooltool.py': '/tools/tooltool.py', 22:19:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:19:54 INFO - '/tools/misc-python/virtualenv.py')}, 22:19:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:19:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:19:54 INFO - 'installer_path': 'installer.exe', 22:19:54 INFO - 'log_level': 'info', 22:19:54 INFO - 'log_name': 'talos', 22:19:54 INFO - 'log_to_console': True, 22:19:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:19:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:19:54 INFO - 'opt_config_files': (), 22:19:54 INFO - 'pip_index': False, 22:19:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:19:54 INFO - 'cmd': ('bash', 22:19:54 INFO - '-c', 22:19:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:19:54 INFO - 'enabled': True, 22:19:54 INFO - 'halt_on_failure': False, 22:19:54 INFO - 'name': 'check_screen_resolution'},), 22:19:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:19:54 INFO - 'cmd': ('bash', 22:19:54 INFO - '-c', 22:19:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:19:54 INFO - 'enabled': True, 22:19:54 INFO - 'halt_on_failure': False, 22:19:54 INFO - 'name': 'check_screen_resolution'},), 22:19:54 INFO - 'run_cmd_checks_enabled': True, 22:19:54 INFO - 'sps_profile': False, 22:19:54 INFO - 'sps_profile_interval': 0, 22:19:54 INFO - 'suite': 'dromaeojs', 22:19:54 INFO - 'system_bits': '32', 22:19:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:19:54 INFO - 'title': 't-yosemite-r7-0374', 22:19:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:19:54 INFO - 'use_talos_json': True, 22:19:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:19:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:19:54 INFO - 'work_dir': 'build'} 22:19:54 INFO - [mozharness: 2017-03-17 05:19:54.169511Z] Running clobber step. 22:19:54 INFO - Running pre-action listener: _resource_record_pre_action 22:19:54 INFO - Running main action method: clobber 22:19:54 INFO - rmtree: /builds/slave/test/build 22:19:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:19:56 INFO - Running post-action listener: _resource_record_post_action 22:19:56 INFO - [mozharness: 2017-03-17 05:19:56.722128Z] Finished clobber step (success) 22:19:56 INFO - [mozharness: 2017-03-17 05:19:56.722256Z] Running read-buildbot-config step. 22:19:56 INFO - Running pre-action listener: _resource_record_pre_action 22:19:56 INFO - Running main action method: read_buildbot_config 22:19:56 INFO - Using buildbot properties: 22:19:56 INFO - { 22:19:56 INFO - "project": "", 22:19:56 INFO - "product": "firefox", 22:19:56 INFO - "script_repo_revision": "production", 22:19:56 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 22:19:56 INFO - "repository": "", 22:19:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 22:19:56 INFO - "buildid": "20170316212021", 22:19:56 INFO - "pgo_build": "False", 22:19:56 INFO - "basedir": "/builds/slave/test", 22:19:56 INFO - "buildnumber": 5, 22:19:56 INFO - "slavename": "t-yosemite-r7-0374", 22:19:56 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 22:19:56 INFO - "platform": "yosemite_r7", 22:19:56 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 22:19:56 INFO - "branch": "mozilla-beta", 22:19:56 INFO - "repo_path": "releases/mozilla-beta", 22:19:56 INFO - "revision": "20f404abbe681ecb3203095c7583354d54302adf", 22:19:56 INFO - "stage_platform": "macosx64", 22:19:56 INFO - "builduid": "fd0ca423b45c44828d300212468b05b8", 22:19:56 INFO - "slavebuilddir": "test" 22:19:56 INFO - } 22:19:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 22:19:56 INFO - Running post-action listener: _resource_record_post_action 22:19:56 INFO - [mozharness: 2017-03-17 05:19:56.725615Z] Finished read-buildbot-config step (success) 22:19:56 INFO - [mozharness: 2017-03-17 05:19:56.725748Z] Running download-and-extract step. 22:19:56 INFO - Running pre-action listener: _resource_record_pre_action 22:19:56 INFO - Running main action method: download_and_extract 22:19:56 INFO - mkdir: /builds/slave/test/build/tests 22:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:19:56 INFO - trying https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 22:19:56 INFO - Downloading https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 22:19:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 22:19:58 INFO - Downloaded 1165 bytes. 22:19:58 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 22:19:58 INFO - Using the following test package requirements: 22:19:58 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 22:19:58 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 22:19:58 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 22:19:58 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 22:19:58 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 22:19:58 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 22:19:58 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 22:19:58 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 22:19:58 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 22:19:58 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 22:19:58 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 22:19:58 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 22:19:58 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 22:19:58 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 22:19:58 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 22:19:58 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 22:19:58 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 22:19:58 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 22:19:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 22:19:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 22:19:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 22:19:58 INFO - Expected file size: 16106566 22:19:58 INFO - Obtained file size: 16106566 22:20:05 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 22:20:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 22:20:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 22:20:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 22:20:06 INFO - Expected file size: 16106566 22:20:06 INFO - Obtained file size: 16106566 22:20:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 22:20:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 22:20:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 22:20:14 INFO - Expected file size: 14403650 22:20:14 INFO - Obtained file size: 14403650 22:20: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')]} 22:20:14 INFO - trying https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 22:20:14 INFO - Downloading https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 22:20:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 22:20:16 INFO - Downloaded 58700648 bytes. 22:20:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 22:20:16 INFO - mkdir: /builds/slave/test/properties 22:20:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:20:16 INFO - Writing to file /builds/slave/test/properties/build_url 22:20:16 INFO - Contents: 22:20:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.dmg 22:20:16 INFO - Running post-action listener: _resource_record_post_action 22:20:16 INFO - Running post-action listener: set_extra_try_arguments 22:20:16 INFO - [mozharness: 2017-03-17 05:20:16.741602Z] Finished download-and-extract step (success) 22:20:16 INFO - [mozharness: 2017-03-17 05:20:16.741729Z] Running populate-webroot step. 22:20:16 INFO - Running pre-action listener: _resource_record_pre_action 22:20:16 INFO - Running main action method: populate_webroot 22:20:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:20:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:20:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:20:16 INFO - '--tppagecycles', 22:20:16 INFO - '7'], 22:20:16 INFO - 'tests': ['tsvgm']}}, 22:20:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:20:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:20:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:20:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:20:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:20:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:20:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:20:16 INFO - 'talos_options': ['--disable-e10s'], 22:20:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:20:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:20:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:20:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:20:16 INFO - 'talos_options': ['--disable-e10s'], 22:20:16 INFO - 'tests': ['damp', 'tps']}, 22:20:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:20:16 INFO - 'tests': ['damp', 'tps']}, 22:20:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:20:16 INFO - 'tests': ['dromaeo_dom']}, 22:20:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:20:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:20:16 INFO - 'tests': ['basic_compositor_video']}, 22:20:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:20:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:20:16 INFO - 'tests': ['a11yr', 22:20:16 INFO - 'ts_paint', 22:20:16 INFO - 'tpaint', 22:20:16 INFO - 'sessionrestore', 22:20:16 INFO - 'sessionrestore_no_auto_restore', 22:20:16 INFO - 'tabpaint']}, 22:20:16 INFO - 'other-e10s': {'tests': ['a11yr', 22:20:16 INFO - 'ts_paint', 22:20:16 INFO - 'tpaint', 22:20:16 INFO - 'sessionrestore', 22:20:16 INFO - 'sessionrestore_no_auto_restore', 22:20:16 INFO - 'tabpaint']}, 22:20:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:20:16 INFO - 'ts_paint', 22:20:16 INFO - 'tpaint', 22:20:16 INFO - 'sessionrestore', 22:20:16 INFO - 'sessionrestore_no_auto_restore', 22:20:16 INFO - 'tabpaint']}, 22:20:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:20:16 INFO - 'ts_paint', 22:20:16 INFO - 'tpaint', 22:20:16 INFO - 'sessionrestore', 22:20:16 INFO - 'sessionrestore_no_auto_restore', 22:20:16 INFO - 'tabpaint']}, 22:20:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:20:16 INFO - 'tests': ['a11yr', 22:20:16 INFO - 'ts_paint', 22:20:16 INFO - 'tpaint', 22:20:16 INFO - 'sessionrestore', 22:20:16 INFO - 'sessionrestore_no_auto_restore', 22:20:16 INFO - 'tabpaint']}, 22:20:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:20:16 INFO - 'tests': ['a11yr', 22:20:16 INFO - 'ts_paint', 22:20:16 INFO - 'tpaint', 22:20:16 INFO - 'sessionrestore', 22:20:16 INFO - 'sessionrestore_no_auto_restore', 22:20:16 INFO - 'tabpaint']}, 22:20:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:20:16 INFO - 'tests': ['tsvgx', 22:20:16 INFO - 'tsvgr_opacity', 22:20:16 INFO - 'tart', 22:20:16 INFO - 'tscrollx', 22:20:16 INFO - 'cart', 22:20:16 INFO - 'tsvg_static']}, 22:20:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:20:16 INFO - 'tsvgr_opacity', 22:20:16 INFO - 'tart', 22:20:16 INFO - 'tscrollx', 22:20:16 INFO - 'cart', 22:20:16 INFO - 'tsvg_static']}, 22:20:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:20:16 INFO - 'talos_options': ['--disable-e10s'], 22:20:16 INFO - 'tests': ['tp5o']}, 22:20:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:20:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:20:16 INFO - 'talos_options': ['--disable-e10s', 22:20:16 INFO - '--xperf_path', 22:20:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:20:16 INFO - 'tests': ['tp5n']}, 22:20:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:20:16 INFO - 'talos_options': ['--xperf_path', 22:20:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:20:16 INFO - 'tests': ['tp5n']}}, 22:20:16 INFO - 'talos.zip': {'path': '', 22:20:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:20:16 INFO - Running post-action listener: _resource_record_post_action 22:20:16 INFO - [mozharness: 2017-03-17 05:20:16.762074Z] Finished populate-webroot step (success) 22:20:16 INFO - [mozharness: 2017-03-17 05:20:16.762211Z] Running create-virtualenv step. 22:20:16 INFO - Running pre-action listener: _resource_record_pre_action 22:20:16 INFO - Running main action method: create_virtualenv 22:20:16 INFO - Creating virtualenv /builds/slave/test/build/venv 22:20:16 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 22:20:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:20:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:20:16 INFO - Using real prefix '/tools/python27' 22:20:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:20:17 INFO - Installing distribute.............................................................................................................................................................................................done. 22:20:20 INFO - Installing pip.................done. 22:20:20 INFO - Return code: 0 22:20:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:20:20 INFO - Reading from file tmpfile_stdout 22:20:20 INFO - Output received: 22:20:20 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) 22:20:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:20:20 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')]} 22:20:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:20:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:20 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')]} 22:20:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:20:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:20 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 0x10a362b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a365768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29a4beef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a140d30>, '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 0x10a067db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a135be8>, '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.xMN678Se2u/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.7Sc12PxZGY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 22:20:20 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 22:20:20 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 22:20:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xMN678Se2u/Render', 22:20:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:20:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:20:20 INFO - 'HOME': '/Users/cltbld', 22:20:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:20:20 INFO - 'LOGNAME': 'cltbld', 22:20:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:20 INFO - 'MOZ_NO_REMOTE': '1', 22:20:20 INFO - 'NO_EM_RESTART': '1', 22:20:20 INFO - 'PAGER': '/bin/cat', 22:20:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:20:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:20 INFO - 'PWD': '/builds/slave/test', 22:20:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:20:20 INFO - 'SHELL': '/bin/bash', 22:20:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Sc12PxZGY/Listeners', 22:20:20 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 22:20:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:20:20 INFO - 'USER': 'cltbld', 22:20:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:20:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:20:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:20 INFO - 'XPC_FLAGS': '0x0', 22:20:20 INFO - 'XPC_SERVICE_NAME': '0', 22:20:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:20:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:20: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 22:20:21 INFO - Cleaning up... 22:20:21 INFO - Return code: 0 22:20:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:20: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')]} 22:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20: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')]} 22:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20: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 0x10a362b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a365768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29a4beef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a140d30>, '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 0x10a067db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a135be8>, '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.xMN678Se2u/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.7Sc12PxZGY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 22:20: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 22:20: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 22:20:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xMN678Se2u/Render', 22:20:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:20:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:20:21 INFO - 'HOME': '/Users/cltbld', 22:20:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:20:21 INFO - 'LOGNAME': 'cltbld', 22:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:21 INFO - 'MOZ_NO_REMOTE': '1', 22:20:21 INFO - 'NO_EM_RESTART': '1', 22:20:21 INFO - 'PAGER': '/bin/cat', 22:20:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:21 INFO - 'PWD': '/builds/slave/test', 22:20:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:20:21 INFO - 'SHELL': '/bin/bash', 22:20:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Sc12PxZGY/Listeners', 22:20:21 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 22:20:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:20:21 INFO - 'USER': 'cltbld', 22:20:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:20:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:21 INFO - 'XPC_FLAGS': '0x0', 22:20:21 INFO - 'XPC_SERVICE_NAME': '0', 22:20:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:20:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:20:21 INFO - Downloading/unpacking psutil>=3.1.1 22:20:21 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 22:20:21 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 22:20:21 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 22:20:21 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 22:20:21 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 22:20:21 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 22:20:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:20:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:20:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:20:24 INFO - Installing collected packages: psutil 22:20:24 INFO - Running setup.py install for psutil 22:20:24 INFO - building 'psutil._psutil_osx' extension 22:20:24 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 22:20: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 22:20: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 22:20:25 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 22:20:25 INFO - building 'psutil._psutil_posix' extension 22:20:25 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 22:20:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:20:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:20:25 INFO - ^ 22:20:25 INFO - 1 warning generated. 22:20:25 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 22:20:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:20:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:20:25 INFO - Successfully installed psutil 22:20:25 INFO - Cleaning up... 22:20:26 INFO - Return code: 0 22:20:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20: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 0x10a362b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a365768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29a4beef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a140d30>, '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 0x10a067db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a135be8>, '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.xMN678Se2u/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.7Sc12PxZGY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 22:20: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 22:20: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 22:20:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xMN678Se2u/Render', 22:20:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:20:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:20:26 INFO - 'HOME': '/Users/cltbld', 22:20:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:20:26 INFO - 'LOGNAME': 'cltbld', 22:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:26 INFO - 'MOZ_NO_REMOTE': '1', 22:20:26 INFO - 'NO_EM_RESTART': '1', 22:20:26 INFO - 'PAGER': '/bin/cat', 22:20:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:26 INFO - 'PWD': '/builds/slave/test', 22:20:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:20:26 INFO - 'SHELL': '/bin/bash', 22:20:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Sc12PxZGY/Listeners', 22:20:26 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 22:20:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:20:26 INFO - 'USER': 'cltbld', 22:20:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:20:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:26 INFO - 'XPC_FLAGS': '0x0', 22:20:26 INFO - 'XPC_SERVICE_NAME': '0', 22:20:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:20:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:20:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:20:26 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 22:20:26 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 22:20:26 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 22:20:26 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 22:20:26 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 22:20:26 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 22:20:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:20:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:20:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:20:29 INFO - Installing collected packages: mozsystemmonitor 22:20:29 INFO - Running setup.py install for mozsystemmonitor 22:20:29 INFO - Successfully installed mozsystemmonitor 22:20:29 INFO - Cleaning up... 22:20:29 INFO - Return code: 0 22:20:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:20: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')]} 22:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:20:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20: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')]} 22:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:20:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20: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 0x10a362b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a365768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29a4beef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a140d30>, '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 0x10a067db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a135be8>, '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.xMN678Se2u/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.7Sc12PxZGY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 22:20: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 22:20: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 22:20:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xMN678Se2u/Render', 22:20:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:20:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:20:29 INFO - 'HOME': '/Users/cltbld', 22:20:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:20:29 INFO - 'LOGNAME': 'cltbld', 22:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:29 INFO - 'MOZ_NO_REMOTE': '1', 22:20:29 INFO - 'NO_EM_RESTART': '1', 22:20:29 INFO - 'PAGER': '/bin/cat', 22:20:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:29 INFO - 'PWD': '/builds/slave/test', 22:20:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:20:29 INFO - 'SHELL': '/bin/bash', 22:20:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Sc12PxZGY/Listeners', 22:20:29 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 22:20:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:20:29 INFO - 'USER': 'cltbld', 22:20:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:20:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:29 INFO - 'XPC_FLAGS': '0x0', 22:20:29 INFO - 'XPC_SERVICE_NAME': '0', 22:20:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:20:29 INFO - Downloading/unpacking jsonschema==2.5.1 22:20:29 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 22:20:29 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 22:20:29 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 22:20:29 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 22:20:29 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 22:20:29 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 22:20:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:20:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:20: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 22:20: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 22:20: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 22:20: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 22:20: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 22:20: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 22:20:32 INFO - Downloading functools32-3.2.3-2.tar.gz 22:20:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:20:32 INFO - warning: no files found matching '*.txt' 22:20:32 INFO - no previously-included directories found matching 'build' 22:20:32 INFO - no previously-included directories found matching 'dist' 22:20:32 INFO - no previously-included directories found matching '.git*' 22:20:32 INFO - Installing collected packages: jsonschema, functools32 22:20:32 INFO - Running setup.py install for functools32 22:20:33 INFO - warning: no files found matching '*.txt' 22:20:33 INFO - no previously-included directories found matching 'build' 22:20:33 INFO - no previously-included directories found matching 'dist' 22:20:33 INFO - no previously-included directories found matching '.git*' 22:20:33 INFO - Successfully installed jsonschema functools32 22:20:33 INFO - Cleaning up... 22:20:33 INFO - Return code: 0 22:20:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:20: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')]} 22:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:20:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20: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')]} 22:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:20:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20: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 0x10a362b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a365768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29a4beef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a140d30>, '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 0x10a067db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a135be8>, '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.xMN678Se2u/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.7Sc12PxZGY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 22:20: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 22:20: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 22:20:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xMN678Se2u/Render', 22:20:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:20:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:20:33 INFO - 'HOME': '/Users/cltbld', 22:20:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:20:33 INFO - 'LOGNAME': 'cltbld', 22:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:33 INFO - 'MOZ_NO_REMOTE': '1', 22:20:33 INFO - 'NO_EM_RESTART': '1', 22:20:33 INFO - 'PAGER': '/bin/cat', 22:20:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:33 INFO - 'PWD': '/builds/slave/test', 22:20:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:20:33 INFO - 'SHELL': '/bin/bash', 22:20:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Sc12PxZGY/Listeners', 22:20:33 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 22:20:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:20:33 INFO - 'USER': 'cltbld', 22:20:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:20:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:33 INFO - 'XPC_FLAGS': '0x0', 22:20:33 INFO - 'XPC_SERVICE_NAME': '0', 22:20:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:20:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:20:33 INFO - Cleaning up... 22:20:33 INFO - Return code: 0 22:20:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:20: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')]} 22:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:20:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20: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')]} 22:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:20:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20: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 0x10a362b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a365768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29a4beef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a140d30>, '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 0x10a067db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a135be8>, '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.xMN678Se2u/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.7Sc12PxZGY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 22:20: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 22:20: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 22:20:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xMN678Se2u/Render', 22:20:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:20:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:20:33 INFO - 'HOME': '/Users/cltbld', 22:20:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:20:33 INFO - 'LOGNAME': 'cltbld', 22:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:33 INFO - 'MOZ_NO_REMOTE': '1', 22:20:33 INFO - 'NO_EM_RESTART': '1', 22:20:33 INFO - 'PAGER': '/bin/cat', 22:20:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:33 INFO - 'PWD': '/builds/slave/test', 22:20:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:20:33 INFO - 'SHELL': '/bin/bash', 22:20:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Sc12PxZGY/Listeners', 22:20:33 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 22:20:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:20:33 INFO - 'USER': 'cltbld', 22:20:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:20:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:33 INFO - 'XPC_FLAGS': '0x0', 22:20:33 INFO - 'XPC_SERVICE_NAME': '0', 22:20:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:20:33 INFO - Downloading/unpacking blobuploader==1.2.4 22:20:33 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 22:20:33 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 22:20:33 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 22:20:33 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 22:20:33 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 22:20:33 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 22:20:36 INFO - Downloading blobuploader-1.2.4.tar.gz 22:20:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:20:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:20: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 22:20: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 22:20: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 22:20: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 22:20: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 22:20: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 22:20:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:20:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:20: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 22:20: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 22:20: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 22:20: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 22:20: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 22:20: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 22:20:37 INFO - Downloading docopt-0.6.1.tar.gz 22:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:20:37 INFO - Installing collected packages: blobuploader, requests, docopt 22:20:37 INFO - Running setup.py install for blobuploader 22:20:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:20:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:20:37 INFO - Running setup.py install for requests 22:20:38 INFO - Running setup.py install for docopt 22:20:38 INFO - Successfully installed blobuploader requests docopt 22:20:38 INFO - Cleaning up... 22:20:38 INFO - Return code: 0 22:20:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:20: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')]} 22:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:20:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20: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')]} 22:20:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:20:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20: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 0x10a362b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a365768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29a4beef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a140d30>, '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 0x10a067db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a135be8>, '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.xMN678Se2u/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.7Sc12PxZGY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 22:20: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 22:20: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 22:20:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xMN678Se2u/Render', 22:20:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:20:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:20:38 INFO - 'HOME': '/Users/cltbld', 22:20:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:20:38 INFO - 'LOGNAME': 'cltbld', 22:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:38 INFO - 'MOZ_NO_REMOTE': '1', 22:20:38 INFO - 'NO_EM_RESTART': '1', 22:20:38 INFO - 'PAGER': '/bin/cat', 22:20:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:38 INFO - 'PWD': '/builds/slave/test', 22:20:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:20:38 INFO - 'SHELL': '/bin/bash', 22:20:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Sc12PxZGY/Listeners', 22:20:38 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 22:20:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:20:38 INFO - 'USER': 'cltbld', 22:20:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:20:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:38 INFO - 'XPC_FLAGS': '0x0', 22:20:38 INFO - 'XPC_SERVICE_NAME': '0', 22:20:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:20:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:20:38 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-27FEQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:20:38 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-aik41g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:20:38 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-Zg8q4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:20:39 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-YbUn7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:20:39 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-FRzCBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:20:39 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-gH01mX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:20:39 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-YYmqah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:20:39 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-GGdfno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:20:39 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-oBi2GA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:20:39 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-lyCehb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:20:39 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-NMkUXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:20:39 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-7rB3Qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:20:39 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-IEl7LL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:20:40 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-Gnfyv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:20:40 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-j9Gjb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:20:40 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-DVO5W1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:20:40 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-qwrHRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:20:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:20:40 INFO - Running setup.py install for manifestparser 22:20:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:20:40 INFO - Running setup.py install for mozcrash 22:20:40 INFO - Running setup.py install for mozdebug 22:20:40 INFO - Running setup.py install for mozdevice 22:20:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:20:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:20:41 INFO - Running setup.py install for mozfile 22:20:41 INFO - Running setup.py install for mozhttpd 22:20:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:20:41 INFO - Running setup.py install for mozinfo 22:20:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:20:41 INFO - Running setup.py install for mozInstall 22:20:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:20:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:20:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:20:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:20:41 INFO - Running setup.py install for mozleak 22:20:41 INFO - Running setup.py install for mozlog 22:20:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:20:42 INFO - Running setup.py install for moznetwork 22:20:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:20:42 INFO - Running setup.py install for mozprocess 22:20:42 INFO - Running setup.py install for mozprofile 22:20:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:20:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:20:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:20:42 INFO - Running setup.py install for mozrunner 22:20:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:20:42 INFO - Running setup.py install for mozscreenshot 22:20:42 INFO - Running setup.py install for moztest 22:20:42 INFO - Running setup.py install for mozversion 22:20:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:20:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:20:43 INFO - Cleaning up... 22:20:43 INFO - Return code: 0 22:20:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:20: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')]} 22:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20: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')]} 22:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20: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 0x10a362b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a365768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29a4beef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a140d30>, '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 0x10a067db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a135be8>, '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.xMN678Se2u/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.7Sc12PxZGY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 22:20: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 22:20: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 22:20:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xMN678Se2u/Render', 22:20:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:20:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:20:43 INFO - 'HOME': '/Users/cltbld', 22:20:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:20:43 INFO - 'LOGNAME': 'cltbld', 22:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:43 INFO - 'MOZ_NO_REMOTE': '1', 22:20:43 INFO - 'NO_EM_RESTART': '1', 22:20:43 INFO - 'PAGER': '/bin/cat', 22:20:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:43 INFO - 'PWD': '/builds/slave/test', 22:20:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:20:43 INFO - 'SHELL': '/bin/bash', 22:20:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Sc12PxZGY/Listeners', 22:20:43 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 22:20:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:20:43 INFO - 'USER': 'cltbld', 22:20:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:20:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:43 INFO - 'XPC_FLAGS': '0x0', 22:20:43 INFO - 'XPC_SERVICE_NAME': '0', 22:20:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:20:43 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-u7asAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:20: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)) 22:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:20:43 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-q3o3IR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:20:43 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)) 22:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:20:43 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-9XbiC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:20:43 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)) 22:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:20:43 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-ivlAn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:20:43 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)) 22:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:20:43 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-4yEp2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:20:43 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)) 22:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:20:43 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-XdhnEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:20: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)) 22:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:20:44 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-bovgiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:20: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)) 22:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:20:44 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-PuCLsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:20: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)) 22:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:20:44 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-TCh9nI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:20: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)) 22:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:20:44 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-xT3z0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:20: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)) 22:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:20:44 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-wZGW5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:20:44 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)) 22:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:20:44 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-p9Z6sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:20:44 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)) 22:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:20:44 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-OLS5VJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:20:44 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)) 22:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:20:44 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-ycdvPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:20:44 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)) 22:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:20:44 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-QwY_Kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:20: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)) 22:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:20:45 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-ycmoyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:20: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)) 22:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:20:45 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-bj4RPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:20: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)) 22:20: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)) 22:20: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)) 22:20: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)) 22:20: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)) 22:20: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)) 22:20:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:20: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 22:20: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 22:20: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 22:20: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 22:20: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 22:20: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 22:20:47 INFO - Downloading blessings-1.6.tar.gz 22:20:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:20:48 INFO - Installing collected packages: blessings 22:20:48 INFO - Running setup.py install for blessings 22:20:48 INFO - Successfully installed blessings 22:20:48 INFO - Cleaning up... 22:20:48 INFO - Return code: 0 22:20:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:20:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:20:48 INFO - Reading from file tmpfile_stdout 22:20:48 INFO - Current package versions: 22:20:48 INFO - blessings == 1.6 22:20:48 INFO - blobuploader == 1.2.4 22:20:48 INFO - docopt == 0.6.1 22:20:48 INFO - functools32 == 3.2.3-2 22:20:48 INFO - jsonschema == 2.5.1 22:20:48 INFO - manifestparser == 1.1 22:20:48 INFO - mozInstall == 1.12 22:20:48 INFO - mozcrash == 1.0 22:20:48 INFO - mozdebug == 0.1 22:20:48 INFO - mozdevice == 0.49 22:20:48 INFO - mozfile == 1.2 22:20:48 INFO - mozhttpd == 0.7 22:20:48 INFO - mozinfo == 0.9 22:20:48 INFO - mozleak == 0.1 22:20:48 INFO - mozlog == 3.4 22:20:48 INFO - moznetwork == 0.27 22:20:48 INFO - mozprocess == 0.24 22:20:48 INFO - mozprofile == 0.28 22:20:48 INFO - mozrunner == 6.13 22:20:48 INFO - mozscreenshot == 0.1 22:20:48 INFO - mozsystemmonitor == 0.3 22:20:48 INFO - moztest == 0.8 22:20:48 INFO - mozversion == 1.4 22:20:48 INFO - psutil == 3.1.1 22:20:48 INFO - requests == 1.2.3 22:20:48 INFO - wsgiref == 0.1.2 22:20:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:20: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')]} 22:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:20:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20: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')]} 22:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:20:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20: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 0x10a362b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a365768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29a4beef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a140d30>, '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 0x10a067db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a135be8>, '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.xMN678Se2u/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.7Sc12PxZGY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 22:20: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 22:20: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 22:20:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xMN678Se2u/Render', 22:20:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:20:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:20:49 INFO - 'HOME': '/Users/cltbld', 22:20:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:20:49 INFO - 'LOGNAME': 'cltbld', 22:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:49 INFO - 'MOZ_NO_REMOTE': '1', 22:20:49 INFO - 'NO_EM_RESTART': '1', 22:20:49 INFO - 'PAGER': '/bin/cat', 22:20:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:49 INFO - 'PWD': '/builds/slave/test', 22:20:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:20:49 INFO - 'SHELL': '/bin/bash', 22:20:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Sc12PxZGY/Listeners', 22:20:49 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 22:20:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:20:49 INFO - 'USER': 'cltbld', 22:20:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:20:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:49 INFO - 'XPC_FLAGS': '0x0', 22:20:49 INFO - 'XPC_SERVICE_NAME': '0', 22:20:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:20:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:20: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)) 22:20: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)) 22:20: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)) 22:20: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)) 22:20: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)) 22:20: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)) 22:20: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)) 22:20: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)) 22:20: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)) 22:20: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)) 22:20: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)) 22:20:49 INFO - Cleaning up... 22:20:49 INFO - Return code: 0 22:20:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:20: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')]} 22:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:20:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20: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')]} 22:20:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:20:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:20:49 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 0x10a362b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a365768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29a4beef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a140d30>, '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 0x10a067db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a135be8>, '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.xMN678Se2u/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.7Sc12PxZGY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 22:20:49 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 22:20:49 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 22:20:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xMN678Se2u/Render', 22:20:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:20:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:20:49 INFO - 'HOME': '/Users/cltbld', 22:20:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:20:49 INFO - 'LOGNAME': 'cltbld', 22:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:20:49 INFO - 'MOZ_NO_REMOTE': '1', 22:20:49 INFO - 'NO_EM_RESTART': '1', 22:20:49 INFO - 'PAGER': '/bin/cat', 22:20:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:20:49 INFO - 'PWD': '/builds/slave/test', 22:20:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:20:49 INFO - 'SHELL': '/bin/bash', 22:20:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Sc12PxZGY/Listeners', 22:20:49 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 22:20:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:20:49 INFO - 'USER': 'cltbld', 22:20:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:20:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:20:49 INFO - 'XPC_FLAGS': '0x0', 22:20:49 INFO - 'XPC_SERVICE_NAME': '0', 22:20:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:20:50 INFO - Cleaning up... 22:20:50 INFO - Return code: 0 22:20:50 INFO - Running post-action listener: _resource_record_post_action 22:20:50 INFO - Running post-action listener: _start_resource_monitoring 22:20:50 INFO - Starting resource monitoring. 22:20:50 INFO - [mozharness: 2017-03-17 05:20:50.270981Z] Finished create-virtualenv step (success) 22:20:50 INFO - [mozharness: 2017-03-17 05:20:50.271929Z] Running install step. 22:20:50 INFO - Running pre-action listener: _resource_record_pre_action 22:20:50 INFO - Running main action method: install 22:20:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:20:50 INFO - Reading from file tmpfile_stdout 22:20:50 INFO - Detecting whether we're running mozinstall >=1.0... 22:20:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:20:50 INFO - Reading from file tmpfile_stdout 22:20:50 INFO - Output received: 22:20:50 INFO - Usage: mozinstall [options] installer 22:20:50 INFO - Options: 22:20:50 INFO - -h, --help show this help message and exit 22:20:50 INFO - -d DEST, --destination=DEST 22:20:50 INFO - Directory to install application into. [default: 22:20:50 INFO - "/builds/slave/test"] 22:20:50 INFO - --app=APP Application being installed. [default: firefox] 22:20:50 INFO - mkdir: /builds/slave/test/build/application 22:20:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 22:21:05 INFO - Reading from file tmpfile_stdout 22:21:05 INFO - Output received: 22:21:05 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 22:21:05 INFO - Running post-action listener: _resource_record_post_action 22:21:05 INFO - [mozharness: 2017-03-17 05:21:05.522282Z] Finished install step (success) 22:21:05 INFO - [mozharness: 2017-03-17 05:21:05.522434Z] Running run-tests step. 22:21:05 INFO - Running pre-action listener: _resource_record_pre_action 22:21:05 INFO - Running main action method: run_tests 22:21:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:21:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:21:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:21:05 INFO - 2017-03-16 22:21:05.537 screenresolution[1618:7328] starting screenresolution argv=screenresolution get 22:21:05 INFO - 2017-03-16 22:21:05.539 screenresolution[1618:7328] Display 0: 1600x1200x32@60 22:21:05 INFO - 2017-03-16 22:21:05.545 screenresolution[1619:7330] starting screenresolution argv=screenresolution list 22:21:05 INFO - Available Modes on Display 0 22:21:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:21:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:21:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:21:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:21:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:21:05 INFO - Intel Iris: 22:21:05 INFO - Chipset Model: Intel Iris 22:21:05 INFO - Type: GPU 22:21:05 INFO - Bus: Built-In 22:21:05 INFO - VRAM (Dynamic, Max): 1536 MB 22:21:05 INFO - Vendor: Intel (0x8086) 22:21:05 INFO - Device ID: 0x0a2e 22:21:05 INFO - Revision ID: 0x0009 22:21:05 INFO - Displays: 22:21:05 INFO - Display: 22:21:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:21:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:21:05 INFO - Display Serial Number: 1600x1200 60 22:21:05 INFO - Main Display: Yes 22:21:05 INFO - Mirror: Off 22:21:05 INFO - Online: Yes 22:21:05 INFO - Rotation: Supported 22:21:05 INFO - Return code: 0 22:21:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:21:05 INFO - Python 2.7.3 22:21:05 INFO - Return code: 0 22:21:05 INFO - grabbing minidump binary from tooltool 22:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:21:05 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 0x10a140d30>, '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 0x10a067db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a135be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:21:05 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 22:21:05 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 22:21:05 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 22:21:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:21:05 INFO - Return code: 0 22:21:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:21:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:21:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:21:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:21:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:21:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0374', '--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 22:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0374 --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 22:21:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xMN678Se2u/Render', 22:21:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:21:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:21:05 INFO - 'HOME': '/Users/cltbld', 22:21:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:21:05 INFO - 'LOGNAME': 'cltbld', 22:21:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:21:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:21:05 INFO - 'MOZ_NO_REMOTE': '1', 22:21:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:21:05 INFO - 'NO_EM_RESTART': '1', 22:21:05 INFO - 'PAGER': '/bin/cat', 22:21:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:21:05 INFO - 'PWD': '/builds/slave/test', 22:21:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:21:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:21:05 INFO - 'SHELL': '/bin/bash', 22:21:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7Sc12PxZGY/Listeners', 22:21:05 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 22:21:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:21:05 INFO - 'USER': 'cltbld', 22:21:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:21:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:21:05 INFO - 'XPC_FLAGS': '0x0', 22:21:05 INFO - 'XPC_SERVICE_NAME': '0', 22:21:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:21:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0374', '--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 22:21:06 INFO - mozversion application_buildid: 20170316212021 22:21:06 INFO - mozversion application_changeset: 20f404abbe681ecb3203095c7583354d54302adf 22:21:06 INFO - mozversion application_display_name: Firefox 22:21:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:21:06 INFO - mozversion application_name: Firefox 22:21:06 INFO - mozversion application_remotingname: firefox 22:21:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 22:21:06 INFO - mozversion application_vendor: Mozilla 22:21:06 INFO - mozversion application_version: 53.0 22:21:06 INFO - mozversion platform_buildid: 20170316212021 22:21:06 INFO - mozversion platform_changeset: 20f404abbe681ecb3203095c7583354d54302adf 22:21:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 22:21:06 INFO - mozversion platform_version: 53.0 22:21:06 INFO - using testdate: 1489728066 22:21:06 INFO - actual date: 1489728066 22:21:06 INFO - starting webserver on 'localhost:49240' 22:21:06 INFO - SUITE-START | Running 2 tests 22:21:06 INFO - TEST-START | dromaeo_css 22:21:06 INFO - operating with platform_type : mac_ 22:21:06 INFO - Initialising browser for dromaeo_css test... 22:21:06 INFO - TEST-INFO | started process 1629 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/tmp1e_44L/profile http://localhost:49240/getInfo.html) 22:21:08 INFO - PROCESS | 1629 | __metrics Screen width/height:1600/1200 22:21:08 INFO - PROCESS | 1629 | colorDepth:24 22:21:08 INFO - PROCESS | 1629 | Browser inner width/height: 1024/689 22:21:08 INFO - PROCESS | 1629 | __metrics 22:21:08 INFO - PROCESS | 1629 | 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" 22:21:08 INFO - PROCESS | 1629 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:21:09 INFO - TEST-INFO | 1629: exit 0 22:21:09 INFO - Browser initialized. 22:21:09 INFO - Running cycle 1/1 for dromaeo_css test... 22:21:09 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/tmp1e_44L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:21:21 INFO - PROCESS | 1632 | RSS: Main: 166416384 22:21:21 INFO - PROCESS | 1632 | 22:24:23 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 22:24:25 INFO - PROCESS | 1632 | RSS: Main: 317140992 22:24:25 INFO - PROCESS | 1632 | 22:27:28 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 22:27:29 INFO - PROCESS | 1632 | RSS: Main: 308404224 22:27:29 INFO - PROCESS | 1632 | 22:30:31 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 22:30:32 INFO - PROCESS | 1632 | RSS: Main: 287244288 22:30:32 INFO - PROCESS | 1632 | 22:33:34 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 22:33:34 INFO - PROCESS | 1632 | RSS: Main: 276877312 22:33:34 INFO - PROCESS | 1632 | 22:36:38 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 22:36:38 INFO - PROCESS | 1632 | RSS: Main: 268566528 22:36:38 INFO - PROCESS | 1632 | 22:39:42 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 22:39:42 INFO - PROCESS | 1632 | RSS: Main: 336281600 22:39:42 INFO - PROCESS | 1632 | 22:39:42 INFO - PROCESS | 1632 | __start_tp_report 22:39:42 INFO - PROCESS | 1632 | _x_x_mozilla_page_load 22:39:42 INFO - PROCESS | 1632 | _x_x_mozilla_page_load_details 22:39:42 INFO - PROCESS | 1632 | |i|pagename|runs| 22:39:42 INFO - PROCESS | 1632 | |0;dojo.html;2819.746222839944;3347.129746265972;3354.51359552865;3397.2526044270267;3433.5021421893825;4777.355057067295;5873.647581145135;5893.174955506232;5907.881842363161;5940.613860099091;5865.208196893418;5965.671888046156;5973.761049558012;5984.850378740533;6006.3993600639915;5257.737113144337;5327.520523152915;5331.253624492555;5347.7058761768085;5387.164989426645;5167.328247327842;5277.393099793515;5299.867503312409;5304.840854774363;5450.56395488362;5341.252224688546;5369.919451208235;5372.247885296062;5404.108322126864;5440.972795136019;5383.730813459311;5386.596005299599;5388.030154572195;5394.1908713692865;5410.458954104597;5222.8694282642855;5267.26258323835;5330.227117068042;5346.893062138774;5398.838034858961;5778.88442231153;5838.766449342022;5850.6489610623075;5852.970735146297;5857.619254748428;6002.519798416116;6256.687165641745;6302.810915672537;6322.778702745428;6332.841678958017;6265.404786545271;6316.147320111772;6325.620462772248;6325.9878419453125;6335.081413195107;5919.260092488439;6006.369331220247;6027.547933905019;6071.119687645355;6080.635161890256;6344.809655710336;6367.649779262092;6393.328700486382;6410.423061924356;6422.3577642235405;5655.886882262332;6046.123312119718;6329.430351268408;6332.810015699536;6344.143540622049;6212.689365531795;6311.495080393649;6328.398802113792;6345.49236061114;6356.523260755462;6217.347178546278;6242.5942313749465;6305.527085468608;6309.621422714652;6312.400321969406;6278.497720182374;6301.054841773679;6303.810885673437;6305.5901366411035;6308.211473565804;5118.334616499831;5122.897542049138;5127.846164615067;5147.356580427447;5174.508421699932;4519.322101684774;4544.068465964469;4547.386102876136;4609.838655647103;4614.123316569841;5977.491913187341;5985.640861548234;6031;6043.939560604425;6084.421979911901;5845.181674565564;5921.726828731843;6334.461570766536;6356.9364306357265;6373.5857169283845;5851.093080572518;5972.970135149297;5995.310539288038;6002.919474494633;6019.428154325332;5459.344878614592;5517.337919449692;5560.666360018412;5584.804531841366;5599.160125981135;6526.988316810902;6533;6546.0508226307875;6553.442957348583;6559.803205903735;6293.811185664437;6320.241571011508;6329;6335.873282534416;6344.492440604833;5557.249771280825;6378.170837791057;6383;6439.774607888701;6551.44312733404;6262.561620686508;6312.936870631235;6322.683865806784;6328.240611126695;6340.778072767615;6301.527385446201;6302.149209856794;6305.180326557518;6314.936850631435;6317.399847014526;5368.597355198298;6154.876902462015;6184.536159787944;6291;6310.368963103653;6223.688815559294;6227.9377206227355;6240.781572644935;6294.622322660472;6314.526410519321;6229.626222426669;6242.65665388408;6246.500279977682;6248.094026366242;6248.781292654735;5856.799356132068;6006.459418652343;6241.812745617639;6326.398992095744;6335.081413195153;6054;6120.051392034242;6121.635889161074;6123.908141377794;6151.046587778901 22:39:42 INFO - PROCESS | 1632 | |1;ext.html;460.32562296236006;508.0575532387421;508.80411041748937;543.445685400891;643.652427689048;32654;42603.360949585745;44063.55936440635;44139.999999999956;45302;44868.102637947224;45318.773406133005;45446.545534544646;45477;45720.542794572044;9029.458232506071;9505.049495050509;9717.028297170296;9717.222622190207;9735.51322433879;9079;11921.880781192163;12085.577004804834;12124.93937530311;12267.141300108997;11702.53189872404;11762.588309409173;11769.117316201318;11804.232724872898;11886;11812.055035597132;11862;11879.762404751942;11893;11893.16747827648;11828.940855295754;11863.644090677208;11875;11881.930626243593;11919.582814601446;42406.93982650428;42723;42790.14419711619;42828.929276768016;42850.78574607138;4089.7137200395982;4104.856330028435;4119.320312148492;4136.296829538986;4139.7580725782145;29525.40949181026;29705.10884673463;31295.687043129506;31357.216069598213;31608;3377.3414184234084;3393.423118069934;3401.6768407001296;3471.114865709228;3519.5776506819348;484541.5772921148;491677;491786.54106729594;492346;493441.53279233375;66261.66869165623;66606.33393666099;66645.33354666489;66797.33202667911;66812.33187668158;68276.65861670759;68356;68372.63254734878;68491.97262041073;68493;17621.911890440464;17824.55438614019;17851.46445606634;17861.642767144585;17885.821141788674;12494.125411221126;12803.103782735305;13658.658533536742;13725.382357793924;13803.654908627164;16447.671046579002;19329.42750107354;21635.242766503095;21936.89031554864;22456.989435475443;8852.114788521096;8934.557499676737;9011.909880901238;9088.454692718458;9088.818223635622;891.1088911088912;891.4963045879058;905.0406569036842;922.6586163119689;940.8776859008285;30932;31744.36511269762;31894.521582176287;32438.83780581129;32540.674593254236;1053.7892421515728;1056;1092.1644941619668;1104.4588151805558;1170.6136974798296;16328.67342653164;16434.260458279405;16447.342106315853;16556.93395245688;16593.751093733605;652041;660114;661587;661799;661853;48596.514034859196;49106.263406048936;49501;49611.25583116184;49649.75175124101;1351.2770667692737;1399.1325378265337;1468.3759402254213;1497.213962669607;1502.4741340530727;31301;31471.685283146875;33092.503612445355;33096.834515827264;33920.66079339175;45829;53538.46461535335;53873.73063134659;54037.91924161573;54235.72882135564;460978;462843;463039;463396;464540;36364;45206.0958780816;45530.317045245014;45545.31682024706;46749.76625116853;47666.52333476621;47885.52114478811;47912.5208747922;49067.263991040876;49426;33389.16527086842;39743;40766.77699669015;42238.366424503045;42250.577494224664;39854.402183967846;40056.39915401213;40584;40691.389629155;41439.7928010358;39188.80405597954;39976.800115999235;40141.78865690679;40248.396274055325;40256.59743402529;33707.831460842535;34086.48870266898;35151.64848351586;35904;35951.820240898625;23239.651405228597;24502.14242501575;24794.74548440051;25210.11764588304;25693.743062569134 22:39:42 INFO - PROCESS | 1632 | |2;jquery.html;408.4098477699723;409.6026853951666;410.6386379985612;423.86436340371085;437.28067329243373;20515.38453846385;21091.578168436623;22381.3285601432;22435.775642243574;22469;18145.909270453663;21583.67624485634;22018;22465.663015054786;22798.2020629278;5303.920441193385;5607.803726869561;5619.100943848985;5619.4942455179025;5632.408597097307;5515.917261241085;5606.915896261559;5742.6841523716175;6122.204113465265;6215.036669316263;6181.536384771138;6194.75220991162;6195.473384762278;6203.658798766066;6206.596571222879;5957.493613042897;6160.445559899608;6206.689665516707;6293.087502312139;6320.462760665303;6017.357955396622;6121.540884433641;6214.65819379934;6220.844478888064;6226.59527130735;11948.402579871059;13894.791578126336;14015.089019213718;14064;14289.999700021002;2663.7236199474755;2707.1878436468983;2720.9591856122174;2724.209979106057;2747.821391609539;8831.514266715329;9764.462954537497;10401.427921464316;10850.67447976562;10884.6190383337;1854.805245449222;1865.822746839048;1874.3158747057362;1901.8288354048063;1918.3381733301987;114593.42703286513;119757.80242197553;120241.39879300547;122513.38743306315;128706;11956.222845515014;11997.280163190237;12217.93891030539;12243.265404075606;12332.630021099381;16430.424935127212;16432.917835410746;16439.589010274838;16464.753028704577;16503.587410314838;8980.730578082668;9144.725658230263;9190.724278271662;9198.586063627154;9282.025387334234;7351.8162045949275;8926.86609700855;8933.570628699377;9130.863037054449;9140.223081038053;4469.41897553316;4621.936954500484;4935.703857768545;4968.30443737877;5021.974890125526;1765.0245195557268;1937.321937321926;2022.464047027539;2063.4531849060013;2073.8859362734893;1021.1932573267185;1024.513356155835;1026.743314171457;1040.3913710479455;1075.537518866879;21980.900954952187;22256.06731093603;22321;22327.553448930932;22556.54886902253;1053.6891616973012;1053.794510070529;1083.7886612110563;1090.6727981605645;1101.823708206683;9335.859962100574;10374.636887708893;11690.298582085103;11699.649010529698;11718.941405292919;729336.35331823;733206;773964.0204063313;779024.4195116066;780717;151984;156890;159849;160126;166579.6684066312;836.1471299274828;876.5660997806127;1053.7471006958428;1066.7866426714688;1068.1348108032519;18778.906105469385;19139.712904306725;19477.73394729338;19535.413937581896;19541.413757587296;58670;59105.704471477366;60312.285947133365;60360.69819650874;61311.69344153251;84840;85580;86097.70853437329;88132.55933720291;88156;7072.68172932209;8530.445521041112;8574.828503429771;8764.12358764144;8831.381803273709;12658.670839561713;13281.933590331986;13712.451501939811;13743.862561374659;13848.238346891017;11142.610008649659;11310.208285419942;11653.59212427561;11661.883381166419;11729.35488548104;11164.38595877202;11295;11417.257878237888;11968.222065565711;12037.819432708691;11448.3703396314;11501.079913606723;11749.236299640495;11847.348395837967;11881.287122772661;8582.09887961755;8606.010308814566;8758.649654013769;8796.47221166732;8850.070742571937;10299;11474.655760327203;11599.014083802971;11711;11826.822597661214 22:39:42 INFO - PROCESS | 1632 | |3;mootools.html;1289.265118882237;1473.3590887963744;1473.9387640898553;1481.7184734900368;1483.985160148398;8147.91852081479;8396.370272229577;8550.615222314995;8561.571921403929;8603.139686031394;7502.81242968926;7754.147043825189;7756.146823849372;8135.918640813605;8327.791805204874;2361.5985282502015;2389.1279682915783;2391.7921449667892;2397.2448678666165;2400.531896280226;2356.964645530318;2397.1729753235104;2401.9759802401927;2403.471236328005;2404.230646193219;2119.73503312086;2205.9669104963436;2300.804431623314;2367.550165468564;2389.486260454002;2385.5109702510945;2390.318759153633;2392.449736560592;2396.74834142416;2396.892139853711;2325.8370814592704;2412.6863507744056;2416.03358656537;2416.4683769570843;2418.6734790803193;8407.8318433631;8486.74539763808;8498.78753031173;8507.064222935534;8509.106543812872;5115.335006449175;5278.947210527922;5279.1289437243195;5289.86775330616;5298.337707786527;3339.248669049469;3440.638732933031;3565.108722819295;3628.7097032237357;3636.4727114568504;1252.1172573335778;1259.0997436832617;1285.8778416050461;1295.4156457866616;1321.2204799168442;10812.405317707522;10826.404547749871;10841.674749757442;10844.295120817122;10858.511366988425;4446.777661116996;4681.274402467623;4765.976170119127;4768.403949506312;4778.713277203379;9600.423974561549;9600.903990960142;9604.279679024101;9611.951940240393;9619.230461563058;5348.786048558092;5349.304590403301;5354.357477102694;5354.8661283467445;5355.598330125256;4340.8697739067875;4426.225410553205;4836.685615434985;4849.369581954324;4889.364382630235;3883.8446462141765;3942.6057394260342;4002.2995975704134;4035.7982100894837;4051.716379853441;1127.3179726265655;1262.4760724299497;1297.2087026913575;1305.9020573457028;1308.9607311780662;909.9399199932005;919.5356345045843;932.6922115701802;937.3532262738688;985.2905907746411;5640.407757185519;5651.943480565224;5816.243888294494;5924.911126333109;5986.311574168939;571.7684337843181;573.4695406748741;580.9651420914674;596.883607696495;599.4275466929072;3989.880303590897;4004.8798536043964;4020;4024;4165.541790403053;9960.750981225383;10182.032706892833;10201.438920859275;10203.846942295871;10221.846672299922;9960.501974901226;10077.798444031077;10079.49602519871;10083.394996300245;10087.193024558017;7470.962645186739;7766.106897706836;7791.376689864797;7821.882671759929;7837.882431763528;5795.072788353843;5798.304203495608;5815.505682016907;5842.444967728059;5949.8215053548465;8982.461052336881;9305.581248843682;9306;9369.81260374775;9392.577334020121;9113.997460279497;9429;9447.102525260088;9461;9519.286053545873;6998.580085194904;7168.462365322517;7235.493515453868;7237.240089790706;7366.852662946818;7938.5236885787035;7996.760097197093;7997.360211182975;7998.360131189607;8018.518888866687;6961.860762784615;7084.433245340258;7130.85738285221;7231.3130252625915;7296.1974182838785;6977.162740471176;7055.400290975324;7106.857862842818;7188.676509557187;7225.421966242583;6387.648679322682;6553.672316384257;6557.278699343164;6560.606363618198;6565.277819439762;4942.728149951788;4986.401631804207;5029.949700502948;5064.392272927273;5115.028144652504;4960.801567937242;4985.376827896513;5087.92368114486;5161.612879034013;5242.18746094356 22:39:42 INFO - PROCESS | 1632 | |4;prototype.html;331.35882068198026;366.3186473159923;373.11943812602254;376.15177774119354;387.40339876590036;5092.414372347182;5243.947560524393;5394.811181608645;5408.566145234646;5439.809606663767;5181.248718935752;5190.558802501791;5228.529432351088;5260.711125774181;5286.726707515776;3624.0464021822195;4218.409422680827;4220.07158425146;4229.435109009671;4240.660747140221;4088.650745254074;4220.767857767822;4235.343521754133;4256.893577660568;4272;3523.5243242162364;4168.208040472316;4178.268802959486;4181.202083104264;4199.593136299343;4162.896832339433;4169.97915010423;4174.269502837006;4175.373693945902;4199.139176468817;3445.586529616437;3722.7021838252876;3730.869419570302;3738.4392341148773;3773.056735816046;4676.602488788457;5086.567641750456;5179.989901969117;5194.247049064003;5200.583953283728;4029.717919745619;4061.3704875744306;4829.855104346875;4847.491013443573;4879.243717223801;5306.70813105279;5593.300837395325;5682.51698605619;5682.971585142089;5722.055860782966;3492.6158122606494;3948.506436695413;4092.631663150301;4136.958630413687;4157.937630935508;5444.754986025639;5908.3575185697555;5908.586398952032;5909.3795151508475;5915.875983563109;4183.5398106208295;4193.343629266423;4194.8254488743205;4201.495820501559;4207.474065741782;4028.9705940555154;4182.979085104555;4201.747895126302;4258.318669012943;4286.571342865688;4040.9897525618594;4187.408784661809;4641.651876109306;4820.30105634681;4857.344258525124;5366.799612158996;5570.888582228414;5664.376918538957;5714.971425142848;5790.768369265266;1140.7262257058412;1267.97294191705;1288.0854593238905;1310.0960337367376;1387.535175716126;847.9739515186693;937.5171786529943;963.9325247232766;969.2682025071026;986.2997271937005;4925.408950925912;4970.967709697082;4974.129527332702;4978.187324161837;4993.775280112403;4706.835260765857;4774.397953115491;5484.396716361197;5502.441364765404;5505.862353441116;4773.92082107039;4920.803167873245;4935.7532123393685;4968.658462215181;4985.700857948535;2677.491276657429;2758.903438379647;2830.235836324222;2841.3464903071995;2862.327353072026;4671.369365135663;5265.868353291198;5650.491455769001;5723.484886360165;5724.942750572441;4543.432070991126;5234.633575649668;5438.782448702087;5645.4072322405555;6023.48800351975;5569.470900264469;5790.957627627067;6033.905755187205;6043.48630366415;6044.972354699712;5156.716380599103;5620.9156862647915;5822.301323841166;5861.531077513703;5874.383189765184;5009.474005229544;5311.840644780663;5732.828015159552;5739.2252045973255;5797.159411885337;4831.7437466258325;6008.819735407945;6023.186869772525;6035.69821508914;6057.7879774207695;3348.1752444918066;3569.803660798681;3930.213957208627;3960.405939109157;3964.861229856941;4612.377329060668;4881.682690625098;5413.2377997291505;5561.02682030635;5897.292324921037;5610.803621873378;5618.943810562006;5633.690147041952;5736.082226843685;5784.913226301524;4796.664233503621;5719.5396784944505;5726.79956201531;5738.675836286311;5765.94234057654;5193.85735138269;5236.372311240068;5479.2602998594675;5558.110702287776;5612.8877422450505;5700.180878811289;5712.457316554921;5724.513416359656;5731.226284451713;5777.537796976148;5387.649802762808;5562.833115006556;5594.13290939905;5607.943920560742;5689.886202276014 22:39:42 INFO - PROCESS | 1632 | |5;yui.html;703.929607039296;737.513241260768;758.9013428254323;788.9013873265842;884.7964968057347;15336.003159794605;15784.605384865385;15849.366025358986;15859.920700396482;15881.285342159601;13925;14355.354009069591;14446;14735.557933261993;14737.926310368433;895.6865097215988;901.2069378946551;905.6467977488785;910.6448485090787;913.8949020862586;895.476146454325;896.1620884473039;897.8473659477904;899.5816945120517;899.7165892743765;773.4740376543948;794.1899262751989;923.9445633262026;961.2982522758391;967.9128878400943;956.3018996132793;957.3011701457905;958.4824194934727;960.1646567486332;961.038961038961;715.1096884378982;716.1299021688674;718.7232915327585;720.1142594608608;720.4056653261081;12865.356732163355;15294.847051529454;15619;15684.372625094982;15696.686066278611;13103.86896131036;13316.600501984956;13369.866301336959;13459.259740714257;13478.39347229377;12145.149839511238;12181.756364872654;12273.631791046282;12525;12685.809712854314;4293.29160688486;4315.654747620214;4365.519792822787;4481.462224533045;4507.504174540798;109168;111299;111807.76384472346;114465;114959.42520287429;10044.497775111215;10251.179905607683;10405.635802746867;10491.370517768806;10512.894871051345;19671.409857704293;19751.22238998497;19782.604347912962;19787.109580068933;19799;7313.195548489662;7592.620368981528;7894.171112033154;8072.636731347104;8195.631196596167;4327.6105150536605;4341.500727416387;4342.399552679909;4509.346144808985;4545.886352841206;3548.9822550887598;3635.9636403635627;3645.9635403646153;3650.233450975272;3950.3876899080688;719.1370355573333;731.7219456606456;735.2757533829174;746.880499120149;749.7900587835414;680.2282631868591;692.757534862794;700.6356694518822;726.5350175887436;746.6341492668553;9856.87789492481;10267;10287.485625718684;10592.788144237073;10599.788004239872;676.9458443324522;692.2973182220051;709.6203531110831;739.3936971683275;740.8370158565107;4740.620750339965;5001.611983235389;5047.545720885138;5525.613207075467;5610.13042978339;110206;114545.4272728631;115770.6845863078;117814;119294;78042.60978695184;79482.6025869867;84483;96694.51652741691;100370;79235.60382198052;80479.59760201279;80631.59684201541;83692.16307836844;83890.58054709688;11152.776944461228;11210.43947802623;11215.831762523405;11305.321680699184;11501.597444089417;40837.79581102194;41803.7909810449;51318.48681513137;54084.18873716819;54271.72864135654;61835.6908215474;62339.37660623336;64156.07531774054;64299.71400572056;65181.02228466672;12605.87394126047;12638.368081596067;12649.123069183097;12778.936105319413;13278.933605331911;14343.211123387897;14647.267636617913;14667;14677.119372837664;14840.703185936436;10715.357078574998;13114.213147211198;13243;13844.861551384358;14139.858601414266;13040.217586944813;13338.399772010476;13525.59423217305;13831.930840345734;14197.077189982618;13571.592852214055;13572.660683482596;13754.587362379145;14045.508407205698;14198.219097949712;10325;11162.218644694793;11426.542938282375;11535.250208736405;11697.473613687574;10984.505697243483;11038.558457661604;11075.224734268524;11243.943780281046;11257.662270131908 22:39:42 INFO - PROCESS | 1632 | __end_tp_report 22:39:42 INFO - PROCESS | 1632 | __start_cc_report 22:39:42 INFO - PROCESS | 1632 | _x_x_mozilla_cycle_collect,1427 22:39:42 INFO - PROCESS | 1632 | __end_cc_report 22:39:42 INFO - PROCESS | 1632 | __startTimestamp1489729182366__endTimestamp 22:39:42 INFO - PROCESS | 1632 | 22:39:42 INFO - PROCESS | 1632 | ------- Summary: start ------- 22:39:42 INFO - PROCESS | 1632 | Number of tests: 6 22:39:42 INFO - PROCESS | 1632 | 22:39:42 INFO - PROCESS | 1632 | [#0] dojo.html Cycles:165 Average:5862.26 Median:6071.12 stddev:660.12 (10.9%) stddev-sans-first:617.50 22:39:42 INFO - PROCESS | 1632 | Values: 2819.7 3347.1 3354.5 3397.3 3433.5 4777.4 5873.6 5893.2 5907.9 5940.6 5865.2 5965.7 5973.8 5984.9 6006.4 5257.7 5327.5 5331.3 5347.7 5387.2 5167.3 5277.4 5299.9 5304.8 5450.6 5341.3 5369.9 5372.2 5404.1 5441.0 5383.7 5386.6 5388.0 5394.2 5410.5 5222.9 5267.3 5330.2 5346.9 5398.8 5778.9 5838.8 5850.6 5853.0 5857.6 6002.5 6256.7 6302.8 6322.8 6332.8 6265.4 6316.1 6325.6 6326.0 6335.1 5919.3 6006.4 6027.5 6071.1 6080.6 6344.8 6367.6 6393.3 6410.4 6422.4 5655.9 6046.1 6329.4 6332.8 6344.1 6212.7 6311.5 6328.4 6345.5 6356.5 6217.3 6242.6 6305.5 6309.6 6312.4 6278.5 6301.1 6303.8 6305.6 6308.2 5118.3 5122.9 5127.8 5147.4 5174.5 4519.3 4544.1 4547.4 4609.8 4614.1 5977.5 5985.6 6031.0 6043.9 6084.4 5845.2 5921.7 6334.5 6356.9 6373.6 5851.1 5973.0 5995.3 6002.9 6019.4 5459.3 5517.3 5560.7 5584.8 5599.2 6527.0 6533.0 6546.1 6553.4 6559.8 6293.8 6320.2 6329.0 6335.9 6344.5 5557.2 6378.2 6383.0 6439.8 6551.4 6262.6 6312.9 6322.7 6328.2 6340.8 6301.5 6302.1 6305.2 6314.9 6317.4 5368.6 6154.9 6184.5 6291.0 6310.4 6223.7 6227.9 6240.8 6294.6 6314.5 6229.6 6242.7 6246.5 6248.1 6248.8 5856.8 6006.5 6241.8 6326.4 6335.1 6054.0 6120.1 6121.6 6123.9 6151.0 22:39:42 INFO - PROCESS | 1632 | 22:39:42 INFO - PROCESS | 1632 | [#1] ext.html Cycles:180 Average:69220.94 Median:40637.69 stddev:145074.41 (357.0%) stddev-sans-first:145389.52 22:39:42 INFO - PROCESS | 1632 | Values: 460.3 508.1 508.8 543.4 643.7 32654.0 42603.4 44063.6 44140.0 45302.0 44868.1 45318.8 45446.5 45477.0 45720.5 9029.5 9505.0 9717.0 9717.2 9735.5 9079.0 11921.9 12085.6 12124.9 12267.1 11702.5 11762.6 11769.1 11804.2 11886.0 11812.1 11862.0 11879.8 11893.0 11893.2 11828.9 11863.6 11875.0 11881.9 11919.6 42406.9 42723.0 42790.1 42828.9 42850.8 4089.7 4104.9 4119.3 4136.3 4139.8 29525.4 29705.1 31295.7 31357.2 31608.0 3377.3 3393.4 3401.7 3471.1 3519.6 484541.6 491677.0 491786.5 492346.0 493441.5 66261.7 66606.3 66645.3 66797.3 66812.3 68276.7 68356.0 68372.6 68492.0 68493.0 17621.9 17824.6 17851.5 17861.6 17885.8 12494.1 12803.1 13658.7 13725.4 13803.7 16447.7 19329.4 21635.2 21936.9 22457.0 8852.1 8934.6 9011.9 9088.5 9088.8 891.1 891.5 905.0 922.7 940.9 30932.0 31744.4 31894.5 32438.8 32540.7 1053.8 1056.0 1092.2 1104.5 1170.6 16328.7 16434.3 16447.3 16556.9 16593.8 652041.0 660114.0 661587.0 661799.0 661853.0 48596.5 49106.3 49501.0 49611.3 49649.8 1351.3 1399.1 1468.4 1497.2 1502.5 31301.0 31471.7 33092.5 33096.8 33920.7 45829.0 53538.5 53873.7 54037.9 54235.7 460978.0 462843.0 463039.0 463396.0 464540.0 36364.0 45206.1 45530.3 45545.3 46749.8 47666.5 47885.5 47912.5 49067.3 49426.0 33389.2 39743.0 40766.8 42238.4 42250.6 39854.4 40056.4 40584.0 40691.4 41439.8 39188.8 39976.8 40141.8 40248.4 40256.6 33707.8 34086.5 35151.6 35904.0 35951.8 23239.7 24502.1 24794.7 25210.1 25693.7 22:39:42 INFO - PROCESS | 1632 | 22:39:42 INFO - PROCESS | 1632 | [#2] jquery.html Cycles:180 Average:40929.98 Median:22137.03 stddev:126367.04 (570.8%) stddev-sans-first:126684.90 22:39:42 INFO - PROCESS | 1632 | Values: 408.4 409.6 410.6 423.9 437.3 20515.4 21091.6 22381.3 22435.8 22469.0 18145.9 21583.7 22018.0 22465.7 22798.2 5303.9 5607.8 5619.1 5619.5 5632.4 5515.9 5606.9 5742.7 6122.2 6215.0 6181.5 6194.8 6195.5 6203.7 6206.6 5957.5 6160.4 6206.7 6293.1 6320.5 6017.4 6121.5 6214.7 6220.8 6226.6 11948.4 13894.8 14015.1 14064.0 14290.0 2663.7 2707.2 2721.0 2724.2 2747.8 8831.5 9764.5 10401.4 10850.7 10884.6 1854.8 1865.8 1874.3 1901.8 1918.3 114593.4 119757.8 120241.4 122513.4 128706.0 11956.2 11997.3 12217.9 12243.3 12332.6 16430.4 16432.9 16439.6 16464.8 16503.6 8980.7 9144.7 9190.7 9198.6 9282.0 7351.8 8926.9 8933.6 9130.9 9140.2 4469.4 4621.9 4935.7 4968.3 5022.0 1765.0 1937.3 2022.5 2063.5 2073.9 1021.2 1024.5 1026.7 1040.4 1075.5 21980.9 22256.1 22321.0 22327.6 22556.5 1053.7 1053.8 1083.8 1090.7 1101.8 9335.9 10374.6 11690.3 11699.6 11718.9 729336.4 733206.0 773964.0 779024.4 780717.0 151984.0 156890.0 159849.0 160126.0 166579.7 836.1 876.6 1053.7 1066.8 1068.1 18778.9 19139.7 19477.7 19535.4 19541.4 58670.0 59105.7 60312.3 60360.7 61311.7 84840.0 85580.0 86097.7 88132.6 88156.0 7072.7 8530.4 8574.8 8764.1 8831.4 12658.7 13281.9 13712.5 13743.9 13848.2 11142.6 11310.2 11653.6 11661.9 11729.4 11164.4 11295.0 11417.3 11968.2 12037.8 11448.4 11501.1 11749.2 11847.3 11881.3 8582.1 8606.0 8758.6 8796.5 8850.1 10299.0 11474.7 11599.0 11711.0 11826.8 22:39:42 INFO - PROCESS | 1632 | 22:39:42 INFO - PROCESS | 1632 | [#3] mootools.html Cycles:180 Average:5513.22 Median:5284.50 stddev:2980.12 (56.4%) stddev-sans-first:2971.56 22:39:42 INFO - PROCESS | 1632 | Values: 1289.3 1473.4 1473.9 1481.7 1484.0 8147.9 8396.4 8550.6 8561.6 8603.1 7502.8 7754.1 7756.1 8135.9 8327.8 2361.6 2389.1 2391.8 2397.2 2400.5 2357.0 2397.2 2402.0 2403.5 2404.2 2119.7 2206.0 2300.8 2367.6 2389.5 2385.5 2390.3 2392.4 2396.7 2396.9 2325.8 2412.7 2416.0 2416.5 2418.7 8407.8 8486.7 8498.8 8507.1 8509.1 5115.3 5278.9 5279.1 5289.9 5298.3 3339.2 3440.6 3565.1 3628.7 3636.5 1252.1 1259.1 1285.9 1295.4 1321.2 10812.4 10826.4 10841.7 10844.3 10858.5 4446.8 4681.3 4766.0 4768.4 4778.7 9600.4 9600.9 9604.3 9612.0 9619.2 5348.8 5349.3 5354.4 5354.9 5355.6 4340.9 4426.2 4836.7 4849.4 4889.4 3883.8 3942.6 4002.3 4035.8 4051.7 1127.3 1262.5 1297.2 1305.9 1309.0 909.9 919.5 932.7 937.4 985.3 5640.4 5651.9 5816.2 5924.9 5986.3 571.8 573.5 581.0 596.9 599.4 3989.9 4004.9 4020.0 4024.0 4165.5 9960.8 10182.0 10201.4 10203.8 10221.8 9960.5 10077.8 10079.5 10083.4 10087.2 7471.0 7766.1 7791.4 7821.9 7837.9 5795.1 5798.3 5815.5 5842.4 5949.8 8982.5 9305.6 9306.0 9369.8 9392.6 9114.0 9429.0 9447.1 9461.0 9519.3 6998.6 7168.5 7235.5 7237.2 7366.9 7938.5 7996.8 7997.4 7998.4 8018.5 6961.9 7084.4 7130.9 7231.3 7296.2 6977.2 7055.4 7106.9 7188.7 7225.4 6387.6 6553.7 6557.3 6560.6 6565.3 4942.7 4986.4 5029.9 5064.4 5115.0 4960.8 4985.4 5087.9 5161.6 5242.2 22:39:42 INFO - PROCESS | 1632 | 22:39:42 INFO - PROCESS | 1632 | [#4] prototype.html Cycles:180 Average:4593.30 Median:5089.49 stddev:1376.48 (27.0%) stddev-sans-first:1342.65 22:39:42 INFO - PROCESS | 1632 | Values: 331.4 366.3 373.1 376.2 387.4 5092.4 5243.9 5394.8 5408.6 5439.8 5181.2 5190.6 5228.5 5260.7 5286.7 3624.0 4218.4 4220.1 4229.4 4240.7 4088.7 4220.8 4235.3 4256.9 4272.0 3523.5 4168.2 4178.3 4181.2 4199.6 4162.9 4170.0 4174.3 4175.4 4199.1 3445.6 3722.7 3730.9 3738.4 3773.1 4676.6 5086.6 5180.0 5194.2 5200.6 4029.7 4061.4 4829.9 4847.5 4879.2 5306.7 5593.3 5682.5 5683.0 5722.1 3492.6 3948.5 4092.6 4137.0 4157.9 5444.8 5908.4 5908.6 5909.4 5915.9 4183.5 4193.3 4194.8 4201.5 4207.5 4029.0 4183.0 4201.7 4258.3 4286.6 4041.0 4187.4 4641.7 4820.3 4857.3 5366.8 5570.9 5664.4 5715.0 5790.8 1140.7 1268.0 1288.1 1310.1 1387.5 848.0 937.5 963.9 969.3 986.3 4925.4 4971.0 4974.1 4978.2 4993.8 4706.8 4774.4 5484.4 5502.4 5505.9 4773.9 4920.8 4935.8 4968.7 4985.7 2677.5 2758.9 2830.2 2841.3 2862.3 4671.4 5265.9 5650.5 5723.5 5724.9 4543.4 5234.6 5438.8 5645.4 6023.5 5569.5 5791.0 6033.9 6043.5 6045.0 5156.7 5620.9 5822.3 5861.5 5874.4 5009.5 5311.8 5732.8 5739.2 5797.2 4831.7 6008.8 6023.2 6035.7 6057.8 3348.2 3569.8 3930.2 3960.4 3964.9 4612.4 4881.7 5413.2 5561.0 5897.3 5610.8 5618.9 5633.7 5736.1 5784.9 4796.7 5719.5 5726.8 5738.7 5765.9 5193.9 5236.4 5479.3 5558.1 5612.9 5700.2 5712.5 5724.5 5731.2 5777.5 5387.6 5562.8 5594.1 5607.9 5689.9 22:39:42 INFO - PROCESS | 1632 | 22:39:42 INFO - PROCESS | 1632 | [#5] yui.html Cycles:180 Average:20969.45 Median:3592.47 stddev:30861.58 (859.1%) stddev-sans-first:30910.64 22:39:42 INFO - PROCESS | 1632 | Values: 703.9 737.5 758.9 788.9 884.8 15336.0 15784.6 15849.4 15859.9 15881.3 13925.0 14355.4 14446.0 14735.6 14737.9 895.7 901.2 905.6 910.6 913.9 895.5 896.2 897.8 899.6 899.7 773.5 794.2 923.9 961.3 967.9 956.3 957.3 958.5 960.2 961.0 715.1 716.1 718.7 720.1 720.4 12865.4 15294.8 15619.0 15684.4 15696.7 13103.9 13316.6 13369.9 13459.3 13478.4 12145.1 12181.8 12273.6 12525.0 12685.8 4293.3 4315.7 4365.5 4481.5 4507.5 109168.0 111299.0 111807.8 114465.0 114959.4 10044.5 10251.2 10405.6 10491.4 10512.9 19671.4 19751.2 19782.6 19787.1 19799.0 7313.2 7592.6 7894.2 8072.6 8195.6 4327.6 4341.5 4342.4 4509.3 4545.9 3549.0 3636.0 3646.0 3650.2 3950.4 719.1 731.7 735.3 746.9 749.8 680.2 692.8 700.6 726.5 746.6 9856.9 10267.0 10287.5 10592.8 10599.8 676.9 692.3 709.6 739.4 740.8 4740.6 5001.6 5047.5 5525.6 5610.1 110206.0 114545.4 115770.7 117814.0 119294.0 78042.6 79482.6 84483.0 96694.5 100370.0 79235.6 80479.6 80631.6 83692.2 83890.6 11152.8 11210.4 11215.8 11305.3 11501.6 40837.8 41803.8 51318.5 54084.2 54271.7 61835.7 62339.4 64156.1 64299.7 65181.0 12605.9 12638.4 12649.1 12778.9 13278.9 14343.2 14647.3 14667.0 14677.1 14840.7 10715.4 13114.2 13243.0 13844.9 14139.9 13040.2 13338.4 13525.6 13831.9 14197.1 13571.6 13572.7 13754.6 14045.5 14198.2 10325.0 11162.2 11426.5 11535.3 11697.5 10984.5 11038.6 11075.2 11243.9 11257.7 22:39:42 INFO - PROCESS | 1632 | -------- Summary: end -------- 22:39:42 INFO - PROCESS | 1632 | 22:39:42 INFO - TEST-INFO | 1632: exit 0 22:39:42 INFO - TEST-OK | dromaeo_css | took 1116839ms 22:39:42 INFO - TEST-START | kraken 22:39:42 INFO - operating with platform_type : mac_ 22:39:42 INFO - Initialising browser for kraken test... 22:39:42 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/tmpifjWZO/profile http://localhost:49240/getInfo.html) 22:39:45 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 22:39:45 INFO - PROCESS | 1643 | colorDepth:24 22:39:45 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 22:39:45 INFO - PROCESS | 1643 | __metrics 22:39:45 INFO - PROCESS | 1643 | 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" 22:39:45 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:39:45 INFO - TEST-INFO | 1643: exit 0 22:39:45 INFO - Browser initialized. 22:39:45 INFO - Running cycle 1/1 for kraken test... 22:39:45 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/tmpifjWZO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:39:57 INFO - PROCESS | 1645 | RSS: Main: 167063552 22:39:57 INFO - PROCESS | 1645 | 22:40:00 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 22:40:01 INFO - PROCESS | 1645 | RSS: Main: 215642112 22:40:01 INFO - PROCESS | 1645 | 22:40:03 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 22:40:04 INFO - PROCESS | 1645 | RSS: Main: 229392384 22:40:04 INFO - PROCESS | 1645 | 22:40:07 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 22:40:08 INFO - PROCESS | 1645 | RSS: Main: 326086656 22:40:08 INFO - PROCESS | 1645 | 22:40:10 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 22:40:10 INFO - PROCESS | 1645 | RSS: Main: 230334464 22:40:10 INFO - PROCESS | 1645 | 22:40:12 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:40:13 INFO - PROCESS | 1645 | RSS: Main: 231624704 22:40:13 INFO - PROCESS | 1645 | 22:40:16 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 22:40:16 INFO - PROCESS | 1645 | RSS: Main: 272252928 22:40:16 INFO - PROCESS | 1645 | 22:40:19 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 22:40:20 INFO - PROCESS | 1645 | RSS: Main: 273231872 22:40:20 INFO - PROCESS | 1645 | 22:40:23 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 22:40:23 INFO - PROCESS | 1645 | RSS: Main: 271237120 22:40:23 INFO - PROCESS | 1645 | 22:40:25 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:40:25 INFO - PROCESS | 1645 | RSS: Main: 246243328 22:40:25 INFO - PROCESS | 1645 | 22:40:27 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:40:28 INFO - PROCESS | 1645 | RSS: Main: 250388480 22:40:28 INFO - PROCESS | 1645 | 22:40:30 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:40:31 INFO - PROCESS | 1645 | RSS: Main: 255942656 22:40:31 INFO - PROCESS | 1645 | 22:40:33 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:40:34 INFO - PROCESS | 1645 | RSS: Main: 270077952 22:40:34 INFO - PROCESS | 1645 | 22:40:37 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:40:38 INFO - PROCESS | 1645 | RSS: Main: 264232960 22:40:38 INFO - PROCESS | 1645 | 22:40:39 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 22:40:40 INFO - PROCESS | 1645 | RSS: Main: 309235712 22:40:40 INFO - PROCESS | 1645 | 22:40:40 INFO - PROCESS | 1645 | __start_tp_report 22:40:40 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 22:40:40 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 22:40:40 INFO - PROCESS | 1645 | |i|pagename|runs| 22:40:40 INFO - PROCESS | 1645 | |0;ai-astar;111;114;113;113;113;114;113;109;106;114 22:40:40 INFO - PROCESS | 1645 | |1;audio-beat-detection;135;108;105;141;109;106;106;106;122;104 22:40:40 INFO - PROCESS | 1645 | |2;audio-dft;174;181;182;185;183;182;184;184;177;184 22:40:40 INFO - PROCESS | 1645 | |3;audio-fft;82;59;59;88;61;58;59;57;73;57 22:40:40 INFO - PROCESS | 1645 | |4;audio-oscillator;82;69;85;70;68;69;81;67;68;82 22:40:40 INFO - PROCESS | 1645 | |5;imaging-gaussian-blur;87;84;87;84;87;84;88;84;86;83 22:40:40 INFO - PROCESS | 1645 | |6;imaging-darkroom;92;93;93;93;93;93;93;93;91;92 22:40:40 INFO - PROCESS | 1645 | |7;imaging-desaturate;126;86;135;140;112;84;99;85;85;86 22:40:40 INFO - PROCESS | 1645 | |8;json-parse-financial;51;51;52;52;53;57;55;56;55;57 22:40:40 INFO - PROCESS | 1645 | |9;json-stringify-tinderbox;64;72;67;72;71;67;68;69;68;70 22:40:40 INFO - PROCESS | 1645 | |10;stanford-crypto-aes;83;81;81;83;83;82;83;80;88;81 22:40:40 INFO - PROCESS | 1645 | |11;stanford-crypto-ccm;131;133;132;129;129;129;133;134;171;131 22:40:40 INFO - PROCESS | 1645 | |12;stanford-crypto-pbkdf2;162;162;161;163;162;161;160;215;172;177 22:40:40 INFO - PROCESS | 1645 | |13;stanford-crypto-sha256-iterative;64;61;64;64;63;64;63;63;62;63 22:40:40 INFO - PROCESS | 1645 | __end_tp_report 22:40:40 INFO - PROCESS | 1645 | __start_cc_report 22:40:40 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1950 22:40:40 INFO - PROCESS | 1645 | __end_cc_report 22:40:40 INFO - PROCESS | 1645 | __startTimestamp1489729240086__endTimestamp 22:40:40 INFO - PROCESS | 1645 | 22:40:40 INFO - PROCESS | 1645 | ------- Summary: start ------- 22:40:40 INFO - PROCESS | 1645 | Number of tests: 14 22:40:40 INFO - PROCESS | 1645 | 22:40:40 INFO - PROCESS | 1645 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.62 (2.3%) stddev-sans-first:2.76 22:40:40 INFO - PROCESS | 1645 | Values: 111.0 114.0 113.0 113.0 113.0 114.0 113.0 109.0 106.0 114.0 22:40:40 INFO - PROCESS | 1645 | 22:40:40 INFO - PROCESS | 1645 | [#1] audio-beat-detection Cycles:10 Average:114.20 Median:108.50 stddev:13.61 (12.5%) stddev-sans-first:12.18 22:40:40 INFO - PROCESS | 1645 | Values: 135.0 108.0 105.0 141.0 109.0 106.0 106.0 106.0 122.0 104.0 22:40:40 INFO - PROCESS | 1645 | 22:40:40 INFO - PROCESS | 1645 | [#2] audio-dft Cycles:10 Average:181.60 Median:183.50 stddev:3.50 (1.9%) stddev-sans-first:2.40 22:40:40 INFO - PROCESS | 1645 | Values: 174.0 181.0 182.0 185.0 183.0 182.0 184.0 184.0 177.0 184.0 22:40:40 INFO - PROCESS | 1645 | 22:40:40 INFO - PROCESS | 1645 | [#3] audio-fft Cycles:10 Average:65.30 Median:60.00 stddev:11.46 (19.1%) stddev-sans-first:10.44 22:40:40 INFO - PROCESS | 1645 | Values: 82.0 59.0 59.0 88.0 61.0 58.0 59.0 57.0 73.0 57.0 22:40:40 INFO - PROCESS | 1645 | 22:40:40 INFO - PROCESS | 1645 | [#4] audio-oscillator Cycles:10 Average:74.10 Median:75.50 stddev:7.34 (9.7%) stddev-sans-first:7.21 22:40:40 INFO - PROCESS | 1645 | Values: 82.0 69.0 85.0 70.0 68.0 69.0 81.0 67.0 68.0 82.0 22:40:40 INFO - PROCESS | 1645 | 22:40:40 INFO - PROCESS | 1645 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:86.50 stddev:1.78 (2.1%) stddev-sans-first:1.79 22:40:40 INFO - PROCESS | 1645 | Values: 87.0 84.0 87.0 84.0 87.0 84.0 88.0 84.0 86.0 83.0 22:40:40 INFO - PROCESS | 1645 | 22:40:40 INFO - PROCESS | 1645 | [#6] imaging-darkroom Cycles:10 Average:92.60 Median:93.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 22:40:40 INFO - PROCESS | 1645 | Values: 92.0 93.0 93.0 93.0 93.0 93.0 93.0 93.0 91.0 92.0 22:40:40 INFO - PROCESS | 1645 | 22:40:40 INFO - PROCESS | 1645 | [#7] imaging-desaturate Cycles:10 Average:103.80 Median:85.00 stddev:22.61 (26.6%) stddev-sans-first:22.51 22:40:40 INFO - PROCESS | 1645 | Values: 126.0 86.0 135.0 140.0 112.0 84.0 99.0 85.0 85.0 86.0 22:40:40 INFO - PROCESS | 1645 | 22:40:40 INFO - PROCESS | 1645 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:55.00 stddev:2.38 (4.3%) stddev-sans-first:2.28 22:40:40 INFO - PROCESS | 1645 | Values: 51.0 51.0 52.0 52.0 53.0 57.0 55.0 56.0 55.0 57.0 22:40:40 INFO - PROCESS | 1645 | 22:40:40 INFO - PROCESS | 1645 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.50 stddev:2.53 (3.6%) stddev-sans-first:2.00 22:40:40 INFO - PROCESS | 1645 | Values: 64.0 72.0 67.0 72.0 71.0 67.0 68.0 69.0 68.0 70.0 22:40:40 INFO - PROCESS | 1645 | 22:40:40 INFO - PROCESS | 1645 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:2.22 (2.7%) stddev-sans-first:2.35 22:40:40 INFO - PROCESS | 1645 | Values: 83.0 81.0 81.0 83.0 83.0 82.0 83.0 80.0 88.0 81.0 22:40:40 INFO - PROCESS | 1645 | 22:40:40 INFO - PROCESS | 1645 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:132.50 stddev:12.71 (9.6%) stddev-sans-first:13.39 22:40:40 INFO - PROCESS | 1645 | Values: 131.0 133.0 132.0 129.0 129.0 129.0 133.0 134.0 171.0 131.0 22:40:40 INFO - PROCESS | 1645 | 22:40:40 INFO - PROCESS | 1645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:162.50 stddev:16.93 (10.4%) stddev-sans-first:17.73 22:40:40 INFO - PROCESS | 1645 | Values: 162.0 162.0 161.0 163.0 162.0 161.0 160.0 215.0 172.0 177.0 22:40:40 INFO - PROCESS | 1645 | 22:40:40 INFO - PROCESS | 1645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:0.99 (1.6%) stddev-sans-first:1.00 22:40:40 INFO - PROCESS | 1645 | Values: 64.0 61.0 64.0 64.0 63.0 64.0 63.0 63.0 62.0 63.0 22:40:40 INFO - PROCESS | 1645 | -------- Summary: end -------- 22:40:40 INFO - PROCESS | 1645 | 22:40:40 INFO - TEST-INFO | 1645: exit 0 22:40:40 INFO - TEST-OK | kraken | took 57997ms 22:40:40 INFO - SUITE-END | took 1174s 22:40:41 INFO - Completed test suite (00:19:35) 22:40:41 INFO - javascript benchmark 22:40:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2819.746222839944, 3347.129746265972, 3354.51359552865, 3397.2526044270267, 3433.5021421893825, 4777.355057067295, 5873.647581145135, 5893.174955506232, 5907.881842363161, 5940.613860099091, 5865.208196893418, 5965.671888046156, 5973.761049558012, 5984.850378740533, 6006.3993600639915, 5257.737113144337, 5327.520523152915, 5331.253624492555, 5347.7058761768085, 5387.164989426645, 5167.328247327842, 5277.393099793515, 5299.867503312409, 5304.840854774363, 5450.56395488362, 5341.252224688546, 5369.919451208235, 5372.247885296062, 5404.108322126864, 5440.972795136019, 5383.730813459311, 5386.596005299599, 5388.030154572195, 5394.1908713692865, 5410.458954104597, 5222.8694282642855, 5267.26258323835, 5330.227117068042, 5346.893062138774, 5398.838034858961, 5778.88442231153, 5838.766449342022, 5850.6489610623075, 5852.970735146297, 5857.619254748428, 6002.519798416116, 6256.687165641745, 6302.810915672537, 6322.778702745428, 6332.841678958017, 6265.404786545271, 6316.147320111772, 6325.620462772248, 6325.9878419453125, 6335.081413195107, 5919.260092488439, 6006.369331220247, 6027.547933905019, 6071.119687645355, 6080.635161890256, 6344.809655710336, 6367.649779262092, 6393.328700486382, 6410.423061924356, 6422.3577642235405, 5655.886882262332, 6046.123312119718, 6329.430351268408, 6332.810015699536, 6344.143540622049, 6212.689365531795, 6311.495080393649, 6328.398802113792, 6345.49236061114, 6356.523260755462, 6217.347178546278, 6242.5942313749465, 6305.527085468608, 6309.621422714652, 6312.400321969406, 6278.497720182374, 6301.054841773679, 6303.810885673437, 6305.5901366411035, 6308.211473565804, 5118.334616499831, 5122.897542049138, 5127.846164615067, 5147.356580427447, 5174.508421699932, 4519.322101684774, 4544.068465964469, 4547.386102876136, 4609.838655647103, 4614.123316569841, 5977.491913187341, 5985.640861548234, 6031.0, 6043.939560604425, 6084.421979911901, 5845.181674565564, 5921.726828731843, 6334.461570766536, 6356.9364306357265, 6373.5857169283845, 5851.093080572518, 5972.970135149297, 5995.310539288038, 6002.919474494633, 6019.428154325332, 5459.344878614592, 5517.337919449692, 5560.666360018412, 5584.804531841366, 5599.160125981135, 6526.988316810902, 6533.0, 6546.0508226307875, 6553.442957348583, 6559.803205903735, 6293.811185664437, 6320.241571011508, 6329.0, 6335.873282534416, 6344.492440604833, 5557.249771280825, 6378.170837791057, 6383.0, 6439.774607888701, 6551.44312733404, 6262.561620686508, 6312.936870631235, 6322.683865806784, 6328.240611126695, 6340.778072767615, 6301.527385446201, 6302.149209856794, 6305.180326557518, 6314.936850631435, 6317.399847014526, 5368.597355198298, 6154.876902462015, 6184.536159787944, 6291.0, 6310.368963103653, 6223.688815559294, 6227.9377206227355, 6240.781572644935, 6294.622322660472, 6314.526410519321, 6229.626222426669, 6242.65665388408, 6246.500279977682, 6248.094026366242, 6248.781292654735, 5856.799356132068, 6006.459418652343, 6241.812745617639, 6326.398992095744, 6335.081413195153, 6054.0, 6120.051392034242, 6121.635889161074, 6123.908141377794, 6151.046587778901], "value": 5818.86087207605, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.32562296236006, 508.0575532387421, 508.80411041748937, 543.445685400891, 643.652427689048, 32654.0, 42603.360949585745, 44063.55936440635, 44139.999999999956, 45302.0, 44868.102637947224, 45318.773406133005, 45446.545534544646, 45477.0, 45720.542794572044, 9029.458232506071, 9505.049495050509, 9717.028297170296, 9717.222622190207, 9735.51322433879, 9079.0, 11921.880781192163, 12085.577004804834, 12124.93937530311, 12267.141300108997, 11702.53189872404, 11762.588309409173, 11769.117316201318, 11804.232724872898, 11886.0, 11812.055035597132, 11862.0, 11879.762404751942, 11893.0, 11893.16747827648, 11828.940855295754, 11863.644090677208, 11875.0, 11881.930626243593, 11919.582814601446, 42406.93982650428, 42723.0, 42790.14419711619, 42828.929276768016, 42850.78574607138, 4089.7137200395982, 4104.856330028435, 4119.320312148492, 4136.296829538986, 4139.7580725782145, 29525.40949181026, 29705.10884673463, 31295.687043129506, 31357.216069598213, 31608.0, 3377.3414184234084, 3393.423118069934, 3401.6768407001296, 3471.114865709228, 3519.5776506819348, 484541.5772921148, 491677.0, 491786.54106729594, 492346.0, 493441.53279233375, 66261.66869165623, 66606.33393666099, 66645.33354666489, 66797.33202667911, 66812.33187668158, 68276.65861670759, 68356.0, 68372.63254734878, 68491.97262041073, 68493.0, 17621.911890440464, 17824.55438614019, 17851.46445606634, 17861.642767144585, 17885.821141788674, 12494.125411221126, 12803.103782735305, 13658.658533536742, 13725.382357793924, 13803.654908627164, 16447.671046579002, 19329.42750107354, 21635.242766503095, 21936.89031554864, 22456.989435475443, 8852.114788521096, 8934.557499676737, 9011.909880901238, 9088.454692718458, 9088.818223635622, 891.1088911088912, 891.4963045879058, 905.0406569036842, 922.6586163119689, 940.8776859008285, 30932.0, 31744.36511269762, 31894.521582176287, 32438.83780581129, 32540.674593254236, 1053.7892421515728, 1056.0, 1092.1644941619668, 1104.4588151805558, 1170.6136974798296, 16328.67342653164, 16434.260458279405, 16447.342106315853, 16556.93395245688, 16593.751093733605, 652041.0, 660114.0, 661587.0, 661799.0, 661853.0, 48596.514034859196, 49106.263406048936, 49501.0, 49611.25583116184, 49649.75175124101, 1351.2770667692737, 1399.1325378265337, 1468.3759402254213, 1497.213962669607, 1502.4741340530727, 31301.0, 31471.685283146875, 33092.503612445355, 33096.834515827264, 33920.66079339175, 45829.0, 53538.46461535335, 53873.73063134659, 54037.91924161573, 54235.72882135564, 460978.0, 462843.0, 463039.0, 463396.0, 464540.0, 36364.0, 45206.0958780816, 45530.317045245014, 45545.31682024706, 46749.76625116853, 47666.52333476621, 47885.52114478811, 47912.5208747922, 49067.263991040876, 49426.0, 33389.16527086842, 39743.0, 40766.77699669015, 42238.366424503045, 42250.577494224664, 39854.402183967846, 40056.39915401213, 40584.0, 40691.389629155, 41439.7928010358, 39188.80405597954, 39976.800115999235, 40141.78865690679, 40248.396274055325, 40256.59743402529, 33707.831460842535, 34086.48870266898, 35151.64848351586, 35904.0, 35951.820240898625, 23239.651405228597, 24502.14242501575, 24794.74548440051, 25210.11764588304, 25693.743062569134], "value": 21379.800232702382, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.4098477699723, 409.6026853951666, 410.6386379985612, 423.86436340371085, 437.28067329243373, 20515.38453846385, 21091.578168436623, 22381.3285601432, 22435.775642243574, 22469.0, 18145.909270453663, 21583.67624485634, 22018.0, 22465.663015054786, 22798.2020629278, 5303.920441193385, 5607.803726869561, 5619.100943848985, 5619.4942455179025, 5632.408597097307, 5515.917261241085, 5606.915896261559, 5742.6841523716175, 6122.204113465265, 6215.036669316263, 6181.536384771138, 6194.75220991162, 6195.473384762278, 6203.658798766066, 6206.596571222879, 5957.493613042897, 6160.445559899608, 6206.689665516707, 6293.087502312139, 6320.462760665303, 6017.357955396622, 6121.540884433641, 6214.65819379934, 6220.844478888064, 6226.59527130735, 11948.402579871059, 13894.791578126336, 14015.089019213718, 14064.0, 14289.999700021002, 2663.7236199474755, 2707.1878436468983, 2720.9591856122174, 2724.209979106057, 2747.821391609539, 8831.514266715329, 9764.462954537497, 10401.427921464316, 10850.67447976562, 10884.6190383337, 1854.805245449222, 1865.822746839048, 1874.3158747057362, 1901.8288354048063, 1918.3381733301987, 114593.42703286513, 119757.80242197553, 120241.39879300547, 122513.38743306315, 128706.0, 11956.222845515014, 11997.280163190237, 12217.93891030539, 12243.265404075606, 12332.630021099381, 16430.424935127212, 16432.917835410746, 16439.589010274838, 16464.753028704577, 16503.587410314838, 8980.730578082668, 9144.725658230263, 9190.724278271662, 9198.586063627154, 9282.025387334234, 7351.8162045949275, 8926.86609700855, 8933.570628699377, 9130.863037054449, 9140.223081038053, 4469.41897553316, 4621.936954500484, 4935.703857768545, 4968.30443737877, 5021.974890125526, 1765.0245195557268, 1937.321937321926, 2022.464047027539, 2063.4531849060013, 2073.8859362734893, 1021.1932573267185, 1024.513356155835, 1026.743314171457, 1040.3913710479455, 1075.537518866879, 21980.900954952187, 22256.06731093603, 22321.0, 22327.553448930932, 22556.54886902253, 1053.6891616973012, 1053.794510070529, 1083.7886612110563, 1090.6727981605645, 1101.823708206683, 9335.859962100574, 10374.636887708893, 11690.298582085103, 11699.649010529698, 11718.941405292919, 729336.35331823, 733206.0, 773964.0204063313, 779024.4195116066, 780717.0, 151984.0, 156890.0, 159849.0, 160126.0, 166579.6684066312, 836.1471299274828, 876.5660997806127, 1053.7471006958428, 1066.7866426714688, 1068.1348108032519, 18778.906105469385, 19139.712904306725, 19477.73394729338, 19535.413937581896, 19541.413757587296, 58670.0, 59105.704471477366, 60312.285947133365, 60360.69819650874, 61311.69344153251, 84840.0, 85580.0, 86097.70853437329, 88132.55933720291, 88156.0, 7072.68172932209, 8530.445521041112, 8574.828503429771, 8764.12358764144, 8831.381803273709, 12658.670839561713, 13281.933590331986, 13712.451501939811, 13743.862561374659, 13848.238346891017, 11142.610008649659, 11310.208285419942, 11653.59212427561, 11661.883381166419, 11729.35488548104, 11164.38595877202, 11295.0, 11417.257878237888, 11968.222065565711, 12037.819432708691, 11448.3703396314, 11501.079913606723, 11749.236299640495, 11847.348395837967, 11881.287122772661, 8582.09887961755, 8606.010308814566, 8758.649654013769, 8796.47221166732, 8850.070742571937, 10299.0, 11474.655760327203, 11599.014083802971, 11711.0, 11826.822597661214], "value": 10023.9600301279, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.265118882237, 1473.3590887963744, 1473.9387640898553, 1481.7184734900368, 1483.985160148398, 8147.91852081479, 8396.370272229577, 8550.615222314995, 8561.571921403929, 8603.139686031394, 7502.81242968926, 7754.147043825189, 7756.146823849372, 8135.918640813605, 8327.791805204874, 2361.5985282502015, 2389.1279682915783, 2391.7921449667892, 2397.2448678666165, 2400.531896280226, 2356.964645530318, 2397.1729753235104, 2401.9759802401927, 2403.471236328005, 2404.230646193219, 2119.73503312086, 2205.9669104963436, 2300.804431623314, 2367.550165468564, 2389.486260454002, 2385.5109702510945, 2390.318759153633, 2392.449736560592, 2396.74834142416, 2396.892139853711, 2325.8370814592704, 2412.6863507744056, 2416.03358656537, 2416.4683769570843, 2418.6734790803193, 8407.8318433631, 8486.74539763808, 8498.78753031173, 8507.064222935534, 8509.106543812872, 5115.335006449175, 5278.947210527922, 5279.1289437243195, 5289.86775330616, 5298.337707786527, 3339.248669049469, 3440.638732933031, 3565.108722819295, 3628.7097032237357, 3636.4727114568504, 1252.1172573335778, 1259.0997436832617, 1285.8778416050461, 1295.4156457866616, 1321.2204799168442, 10812.405317707522, 10826.404547749871, 10841.674749757442, 10844.295120817122, 10858.511366988425, 4446.777661116996, 4681.274402467623, 4765.976170119127, 4768.403949506312, 4778.713277203379, 9600.423974561549, 9600.903990960142, 9604.279679024101, 9611.951940240393, 9619.230461563058, 5348.786048558092, 5349.304590403301, 5354.357477102694, 5354.8661283467445, 5355.598330125256, 4340.8697739067875, 4426.225410553205, 4836.685615434985, 4849.369581954324, 4889.364382630235, 3883.8446462141765, 3942.6057394260342, 4002.2995975704134, 4035.7982100894837, 4051.716379853441, 1127.3179726265655, 1262.4760724299497, 1297.2087026913575, 1305.9020573457028, 1308.9607311780662, 909.9399199932005, 919.5356345045843, 932.6922115701802, 937.3532262738688, 985.2905907746411, 5640.407757185519, 5651.943480565224, 5816.243888294494, 5924.911126333109, 5986.311574168939, 571.7684337843181, 573.4695406748741, 580.9651420914674, 596.883607696495, 599.4275466929072, 3989.880303590897, 4004.8798536043964, 4020.0, 4024.0, 4165.541790403053, 9960.750981225383, 10182.032706892833, 10201.438920859275, 10203.846942295871, 10221.846672299922, 9960.501974901226, 10077.798444031077, 10079.49602519871, 10083.394996300245, 10087.193024558017, 7470.962645186739, 7766.106897706836, 7791.376689864797, 7821.882671759929, 7837.882431763528, 5795.072788353843, 5798.304203495608, 5815.505682016907, 5842.444967728059, 5949.8215053548465, 8982.461052336881, 9305.581248843682, 9306.0, 9369.81260374775, 9392.577334020121, 9113.997460279497, 9429.0, 9447.102525260088, 9461.0, 9519.286053545873, 6998.580085194904, 7168.462365322517, 7235.493515453868, 7237.240089790706, 7366.852662946818, 7938.5236885787035, 7996.760097197093, 7997.360211182975, 7998.360131189607, 8018.518888866687, 6961.860762784615, 7084.433245340258, 7130.85738285221, 7231.3130252625915, 7296.1974182838785, 6977.162740471176, 7055.400290975324, 7106.857862842818, 7188.676509557187, 7225.421966242583, 6387.648679322682, 6553.672316384257, 6557.278699343164, 6560.606363618198, 6565.277819439762, 4942.728149951788, 4986.401631804207, 5029.949700502948, 5064.392272927273, 5115.028144652504, 4960.801567937242, 4985.376827896513, 5087.92368114486, 5161.612879034013, 5242.18746094356], "value": 4452.246235162587, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.35882068198026, 366.3186473159923, 373.11943812602254, 376.15177774119354, 387.40339876590036, 5092.414372347182, 5243.947560524393, 5394.811181608645, 5408.566145234646, 5439.809606663767, 5181.248718935752, 5190.558802501791, 5228.529432351088, 5260.711125774181, 5286.726707515776, 3624.0464021822195, 4218.409422680827, 4220.07158425146, 4229.435109009671, 4240.660747140221, 4088.650745254074, 4220.767857767822, 4235.343521754133, 4256.893577660568, 4272.0, 3523.5243242162364, 4168.208040472316, 4178.268802959486, 4181.202083104264, 4199.593136299343, 4162.896832339433, 4169.97915010423, 4174.269502837006, 4175.373693945902, 4199.139176468817, 3445.586529616437, 3722.7021838252876, 3730.869419570302, 3738.4392341148773, 3773.056735816046, 4676.602488788457, 5086.567641750456, 5179.989901969117, 5194.247049064003, 5200.583953283728, 4029.717919745619, 4061.3704875744306, 4829.855104346875, 4847.491013443573, 4879.243717223801, 5306.70813105279, 5593.300837395325, 5682.51698605619, 5682.971585142089, 5722.055860782966, 3492.6158122606494, 3948.506436695413, 4092.631663150301, 4136.958630413687, 4157.937630935508, 5444.754986025639, 5908.3575185697555, 5908.586398952032, 5909.3795151508475, 5915.875983563109, 4183.5398106208295, 4193.343629266423, 4194.8254488743205, 4201.495820501559, 4207.474065741782, 4028.9705940555154, 4182.979085104555, 4201.747895126302, 4258.318669012943, 4286.571342865688, 4040.9897525618594, 4187.408784661809, 4641.651876109306, 4820.30105634681, 4857.344258525124, 5366.799612158996, 5570.888582228414, 5664.376918538957, 5714.971425142848, 5790.768369265266, 1140.7262257058412, 1267.97294191705, 1288.0854593238905, 1310.0960337367376, 1387.535175716126, 847.9739515186693, 937.5171786529943, 963.9325247232766, 969.2682025071026, 986.2997271937005, 4925.408950925912, 4970.967709697082, 4974.129527332702, 4978.187324161837, 4993.775280112403, 4706.835260765857, 4774.397953115491, 5484.396716361197, 5502.441364765404, 5505.862353441116, 4773.92082107039, 4920.803167873245, 4935.7532123393685, 4968.658462215181, 4985.700857948535, 2677.491276657429, 2758.903438379647, 2830.235836324222, 2841.3464903071995, 2862.327353072026, 4671.369365135663, 5265.868353291198, 5650.491455769001, 5723.484886360165, 5724.942750572441, 4543.432070991126, 5234.633575649668, 5438.782448702087, 5645.4072322405555, 6023.48800351975, 5569.470900264469, 5790.957627627067, 6033.905755187205, 6043.48630366415, 6044.972354699712, 5156.716380599103, 5620.9156862647915, 5822.301323841166, 5861.531077513703, 5874.383189765184, 5009.474005229544, 5311.840644780663, 5732.828015159552, 5739.2252045973255, 5797.159411885337, 4831.7437466258325, 6008.819735407945, 6023.186869772525, 6035.69821508914, 6057.7879774207695, 3348.1752444918066, 3569.803660798681, 3930.213957208627, 3960.405939109157, 3964.861229856941, 4612.377329060668, 4881.682690625098, 5413.2377997291505, 5561.02682030635, 5897.292324921037, 5610.803621873378, 5618.943810562006, 5633.690147041952, 5736.082226843685, 5784.913226301524, 4796.664233503621, 5719.5396784944505, 5726.79956201531, 5738.675836286311, 5765.94234057654, 5193.85735138269, 5236.372311240068, 5479.2602998594675, 5558.110702287776, 5612.8877422450505, 5700.180878811289, 5712.457316554921, 5724.513416359656, 5731.226284451713, 5777.537796976148, 5387.649802762808, 5562.833115006556, 5594.13290939905, 5607.943920560742, 5689.886202276014], "value": 4168.230717414456, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.929607039296, 737.513241260768, 758.9013428254323, 788.9013873265842, 884.7964968057347, 15336.003159794605, 15784.605384865385, 15849.366025358986, 15859.920700396482, 15881.285342159601, 13925.0, 14355.354009069591, 14446.0, 14735.557933261993, 14737.926310368433, 895.6865097215988, 901.2069378946551, 905.6467977488785, 910.6448485090787, 913.8949020862586, 895.476146454325, 896.1620884473039, 897.8473659477904, 899.5816945120517, 899.7165892743765, 773.4740376543948, 794.1899262751989, 923.9445633262026, 961.2982522758391, 967.9128878400943, 956.3018996132793, 957.3011701457905, 958.4824194934727, 960.1646567486332, 961.038961038961, 715.1096884378982, 716.1299021688674, 718.7232915327585, 720.1142594608608, 720.4056653261081, 12865.356732163355, 15294.847051529454, 15619.0, 15684.372625094982, 15696.686066278611, 13103.86896131036, 13316.600501984956, 13369.866301336959, 13459.259740714257, 13478.39347229377, 12145.149839511238, 12181.756364872654, 12273.631791046282, 12525.0, 12685.809712854314, 4293.29160688486, 4315.654747620214, 4365.519792822787, 4481.462224533045, 4507.504174540798, 109168.0, 111299.0, 111807.76384472346, 114465.0, 114959.42520287429, 10044.497775111215, 10251.179905607683, 10405.635802746867, 10491.370517768806, 10512.894871051345, 19671.409857704293, 19751.22238998497, 19782.604347912962, 19787.109580068933, 19799.0, 7313.195548489662, 7592.620368981528, 7894.171112033154, 8072.636731347104, 8195.631196596167, 4327.6105150536605, 4341.500727416387, 4342.399552679909, 4509.346144808985, 4545.886352841206, 3548.9822550887598, 3635.9636403635627, 3645.9635403646153, 3650.233450975272, 3950.3876899080688, 719.1370355573333, 731.7219456606456, 735.2757533829174, 746.880499120149, 749.7900587835414, 680.2282631868591, 692.757534862794, 700.6356694518822, 726.5350175887436, 746.6341492668553, 9856.87789492481, 10267.0, 10287.485625718684, 10592.788144237073, 10599.788004239872, 676.9458443324522, 692.2973182220051, 709.6203531110831, 739.3936971683275, 740.8370158565107, 4740.620750339965, 5001.611983235389, 5047.545720885138, 5525.613207075467, 5610.13042978339, 110206.0, 114545.4272728631, 115770.6845863078, 117814.0, 119294.0, 78042.60978695184, 79482.6025869867, 84483.0, 96694.51652741691, 100370.0, 79235.60382198052, 80479.59760201279, 80631.59684201541, 83692.16307836844, 83890.58054709688, 11152.776944461228, 11210.43947802623, 11215.831762523405, 11305.321680699184, 11501.597444089417, 40837.79581102194, 41803.7909810449, 51318.48681513137, 54084.18873716819, 54271.72864135654, 61835.6908215474, 62339.37660623336, 64156.07531774054, 64299.71400572056, 65181.02228466672, 12605.87394126047, 12638.368081596067, 12649.123069183097, 12778.936105319413, 13278.933605331911, 14343.211123387897, 14647.267636617913, 14667.0, 14677.119372837664, 14840.703185936436, 10715.357078574998, 13114.213147211198, 13243.0, 13844.861551384358, 14139.858601414266, 13040.217586944813, 13338.399772010476, 13525.59423217305, 13831.930840345734, 14197.077189982618, 13571.592852214055, 13572.660683482596, 13754.587362379145, 14045.508407205698, 14198.219097949712, 10325.0, 11162.218644694793, 11426.542938282375, 11535.250208736405, 11697.473613687574, 10984.505697243483, 11038.558457661604, 11075.224734268524, 11243.943780281046, 11257.662270131908], "value": 7723.286169540006, "unit": "score"}], "name": "dromaeo_css", "value": 7505.457561242953, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0, 109.0, 106.0, 114.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 108.0, 105.0, 141.0, 109.0, 106.0, 106.0, 106.0, 122.0, 104.0], "value": 114.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 181.0, 182.0, 185.0, 183.0, 182.0, 184.0, 184.0, 177.0, 184.0], "value": 181.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 59.0, 88.0, 61.0, 58.0, 59.0, 57.0, 73.0, 57.0], "value": 65.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 69.0, 85.0, 70.0, 68.0, 69.0, 81.0, 67.0, 68.0, 82.0], "value": 74.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 87.0, 84.0, 88.0, 84.0, 86.0, 83.0], "value": 85.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 91.0, 92.0], "value": 92.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 86.0, 135.0, 140.0, 112.0, 84.0, 99.0, 85.0, 85.0, 86.0], "value": 103.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 52.0, 53.0, 57.0, 55.0, 56.0, 55.0, 57.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 67.0, 72.0, 71.0, 67.0, 68.0, 69.0, 68.0, 70.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 81.0, 83.0, 83.0, 82.0, 83.0, 80.0, 88.0, 81.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 133.0, 132.0, 129.0, 129.0, 129.0, 133.0, 134.0, 171.0, 131.0], "value": 135.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 162.0, 161.0, 160.0, 215.0, 172.0, 177.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 64.0, 64.0, 63.0, 64.0, 63.0, 63.0, 62.0, 63.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1401.9999999999998, "alertThreshold": 2.0}]} 22:40:41 INFO - Return code: 0 22:40:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:40:41 INFO - # TBPL SUCCESS # 22:40:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:40:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:40:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:40:41 INFO - 2017-03-16 22:40:41.416 screenresolution[1649:9738] starting screenresolution argv=screenresolution get 22:40:41 INFO - 2017-03-16 22:40:41.419 screenresolution[1649:9738] Display 0: 1600x1200x32@60 22:40:41 INFO - 2017-03-16 22:40:41.425 screenresolution[1650:9742] starting screenresolution argv=screenresolution list 22:40:41 INFO - Available Modes on Display 0 22:40:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:40:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:40:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:40:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:40:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:40:41 INFO - Intel Iris: 22:40:41 INFO - Chipset Model: Intel Iris 22:40:41 INFO - Type: GPU 22:40:41 INFO - Bus: Built-In 22:40:41 INFO - VRAM (Dynamic, Max): 1536 MB 22:40:41 INFO - Vendor: Intel (0x8086) 22:40:41 INFO - Device ID: 0x0a2e 22:40:41 INFO - Revision ID: 0x0009 22:40:41 INFO - Displays: 22:40:41 INFO - Display: 22:40:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:40:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:40:41 INFO - Display Serial Number: 1600x1200 60 22:40:41 INFO - Main Display: Yes 22:40:41 INFO - Mirror: Off 22:40:41 INFO - Online: Yes 22:40:41 INFO - Rotation: Supported 22:40:41 INFO - Return code: 0 22:40:41 INFO - Running post-action listener: _resource_record_post_action 22:40:41 INFO - [mozharness: 2017-03-17 05:40:41.658928Z] Finished run-tests step (success) 22:40:41 INFO - Running post-run listener: _resource_record_post_run 22:40:41 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 37966848; Write bytes: 418963456; Read time: 242; Write time: 1420 22:40:41 INFO - TinderboxPrint: CPU usage
53.7% 22:40:41 INFO - TinderboxPrint: I/O read bytes / time
37,966,848 / 242 22:40:41 INFO - TinderboxPrint: I/O write bytes / time
418,963,456 / 1,420 22:40:41 INFO - TinderboxPrint: CPU idle
2,206.0 (46.3%) 22:40:41 INFO - TinderboxPrint: CPU system
954.4 (20.0%) 22:40:41 INFO - TinderboxPrint: CPU user
1,601.2 (33.6%) 22:40:41 INFO - TinderboxPrint: Swap in / out
160,219,136 / 0 22:40:41 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 119515648; Write bytes: 112943104; Read time: 11058; Write time: 253 22:40:41 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 35881984; Write bytes: 294916096; Read time: 223; Write time: 1130 22:40:42 INFO - Running post-run listener: _upload_blobber_files 22:40:42 INFO - Blob upload gear active. 22:40:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:40:42 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 22:40:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:40:42 INFO - (blobuploader) - INFO - Open directory for files ... 22:40:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:40:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:40:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:40:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:40:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:40:44 INFO - (blobuploader) - INFO - Done attempting. 22:40:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:40:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:40:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:40:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:40:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:40:45 INFO - (blobuploader) - INFO - Done attempting. 22:40:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:40:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:40:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:40:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:40:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:40:46 INFO - (blobuploader) - INFO - Done attempting. 22:40:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:40:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:40:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:40:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:40:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:40:48 INFO - (blobuploader) - INFO - Done attempting. 22:40:48 INFO - (blobuploader) - INFO - Iteration through files over. 22:40:48 INFO - Return code: 0 22:40:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:40:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:40:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0396ee79b5232aee62d44bb5076345f599f7724dc623c20b2b27f7b2c73beb97226b8d2e6bbbfa5a21e1077695eeda6081136662728a29d946a1c5e8df07dba8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e70b05151e0c2a5559e40525c45d9e836a7a86a3dbc5e0599633d4096f98dc152bad3b11a55a9f2b9f5128a662cb0c4a72fb95a92c592f9acb07c44bdf5b38f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34c5d35a9fbf76eda1be873a80d698c385613132eafa71cb31d748e92b7f175fee40a506f962390f7778d16893cbaab864a81bcb096ce1892f870fafddacc494", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3cf0d35378d7a5b23f75533eb108d680a625442a6e0aa72c693a0bae66483b4bd14eaf4efe2c543dace678d88ff7fd3f8f9648e966ccb853f1e4d504d2cb4545"} 22:40:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:40:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:40:48 INFO - Contents: 22:40:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0396ee79b5232aee62d44bb5076345f599f7724dc623c20b2b27f7b2c73beb97226b8d2e6bbbfa5a21e1077695eeda6081136662728a29d946a1c5e8df07dba8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e70b05151e0c2a5559e40525c45d9e836a7a86a3dbc5e0599633d4096f98dc152bad3b11a55a9f2b9f5128a662cb0c4a72fb95a92c592f9acb07c44bdf5b38f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34c5d35a9fbf76eda1be873a80d698c385613132eafa71cb31d748e92b7f175fee40a506f962390f7778d16893cbaab864a81bcb096ce1892f870fafddacc494", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3cf0d35378d7a5b23f75533eb108d680a625442a6e0aa72c693a0bae66483b4bd14eaf4efe2c543dace678d88ff7fd3f8f9648e966ccb853f1e4d504d2cb4545"} 22:40:48 INFO - Running post-run listener: copy_logs_to_upload_dir 22:40:48 INFO - Copying logs to upload dir... 22:40:48 INFO - mkdir: /builds/slave/test/build/upload/logs 22:40:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.508220 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-16 22:40:48.499291) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-16 22:40:48.502654) ========= 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.xMN678Se2u/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.7Sc12PxZGY/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0396ee79b5232aee62d44bb5076345f599f7724dc623c20b2b27f7b2c73beb97226b8d2e6bbbfa5a21e1077695eeda6081136662728a29d946a1c5e8df07dba8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e70b05151e0c2a5559e40525c45d9e836a7a86a3dbc5e0599633d4096f98dc152bad3b11a55a9f2b9f5128a662cb0c4a72fb95a92c592f9acb07c44bdf5b38f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34c5d35a9fbf76eda1be873a80d698c385613132eafa71cb31d748e92b7f175fee40a506f962390f7778d16893cbaab864a81bcb096ce1892f870fafddacc494", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3cf0d35378d7a5b23f75533eb108d680a625442a6e0aa72c693a0bae66483b4bd14eaf4efe2c543dace678d88ff7fd3f8f9648e966ccb853f1e4d504d2cb4545"} build_url:https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011091 build_url: 'https://queue.taskcluster.net/v1/task/Hx9WZ7GfRkKqhME7lMDNmw/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0396ee79b5232aee62d44bb5076345f599f7724dc623c20b2b27f7b2c73beb97226b8d2e6bbbfa5a21e1077695eeda6081136662728a29d946a1c5e8df07dba8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e70b05151e0c2a5559e40525c45d9e836a7a86a3dbc5e0599633d4096f98dc152bad3b11a55a9f2b9f5128a662cb0c4a72fb95a92c592f9acb07c44bdf5b38f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34c5d35a9fbf76eda1be873a80d698c385613132eafa71cb31d748e92b7f175fee40a506f962390f7778d16893cbaab864a81bcb096ce1892f870fafddacc494", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3cf0d35378d7a5b23f75533eb108d680a625442a6e0aa72c693a0bae66483b4bd14eaf4efe2c543dace678d88ff7fd3f8f9648e966ccb853f1e4d504d2cb4545"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-16 22:40:48.541167) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 22:40:48.541521) ========= 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.xMN678Se2u/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.7Sc12PxZGY/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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.005027 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-16 22:40:48.590241) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-16 22:40:48.590619) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-16 22:40:48.591066) ========= ========= Total master_lag: 0.18 =========