builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0224 starttime: 1475005983.67 results: success (0) buildid: 20160927120422 builduid: f2fc5c85d23643dfb69d1e0a9dd5b1a8 revision: 515ab50a00a2e7c72a5eb7e0625a3aa6c8e4404b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 12:53:03.674690) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 12:53:03.675089) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 12:53:03.675367) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 12:53:03.726882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:53:03.730204) ========= 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.uR62rkhhVY/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.sHD85xq9Sc/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-27 12:53:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.05M=0.001s 2016-09-27 12:53:04 (8.05 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.658195 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:53:04.409494) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:53:04.409797) ========= 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.uR62rkhhVY/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.sHD85xq9Sc/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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.020009 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:53:04.464985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:53:04.465309) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 515ab50a00a2e7c72a5eb7e0625a3aa6c8e4404b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 515ab50a00a2e7c72a5eb7e0625a3aa6c8e4404b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uR62rkhhVY/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.sHD85xq9Sc/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-27 12:53:04,551 truncating revision to first 12 chars 2016-09-27 12:53:04,551 Setting DEBUG logging. 2016-09-27 12:53:04,551 attempt 1/10 2016-09-27 12:53:04,551 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/515ab50a00a2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 12:53:04,836 unpacking tar archive at: mozilla-aurora-515ab50a00a2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559680 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 12:53:05.046834) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 12:53:05.050201) ========= script_repo_revision: 515ab50a00a2e7c72a5eb7e0625a3aa6c8e4404b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 12:53:05.050614) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 12:53:05.050891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 12:53:05.069201) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-27 12:53:05.069511) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uR62rkhhVY/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.sHD85xq9Sc/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 12:53:05 INFO - MultiFileLogger online at 20160927 12:53:05 in /builds/slave/test 12:53:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:53:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:53:05 INFO - {'append_to_log': False, 12:53:05 INFO - 'base_work_dir': '/builds/slave/test', 12:53:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:53:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:53:05 INFO - 'branch': 'Mozilla-Aurora', 12:53:05 INFO - 'buildbot_json_path': 'buildprops.json', 12:53:05 INFO - 'config_files': ('talos/mac_config.py',), 12:53:05 INFO - 'default_actions': ('clobber', 12:53:05 INFO - 'read-buildbot-config', 12:53:05 INFO - 'download-and-extract', 12:53:05 INFO - 'populate-webroot', 12:53:05 INFO - 'create-virtualenv', 12:53:05 INFO - 'install', 12:53:05 INFO - 'run-tests'), 12:53:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:53:05 INFO - 'download_minidump_stackwalk': True, 12:53:05 INFO - 'download_symbols': 'ondemand', 12:53:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:53:05 INFO - 'tooltool.py': '/tools/tooltool.py', 12:53:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:53:05 INFO - '/tools/misc-python/virtualenv.py')}, 12:53:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:53:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:53:05 INFO - 'installer_path': 'installer.exe', 12:53:05 INFO - 'log_level': 'info', 12:53:05 INFO - 'log_name': 'talos', 12:53:05 INFO - 'log_to_console': True, 12:53:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:53:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:53:05 INFO - 'opt_config_files': (), 12:53:05 INFO - 'pip_index': False, 12:53:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:53:05 INFO - 'cmd': ('bash', 12:53:05 INFO - '-c', 12:53:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:53:05 INFO - 'enabled': True, 12:53:05 INFO - 'halt_on_failure': False, 12:53:05 INFO - 'name': 'check_screen_resolution'},), 12:53:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:53:05 INFO - 'cmd': ('bash', 12:53:05 INFO - '-c', 12:53:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:53:05 INFO - 'enabled': True, 12:53:05 INFO - 'halt_on_failure': False, 12:53:05 INFO - 'name': 'check_screen_resolution'},), 12:53:05 INFO - 'run_cmd_checks_enabled': True, 12:53:05 INFO - 'sps_profile': False, 12:53:05 INFO - 'sps_profile_interval': 0, 12:53:05 INFO - 'suite': 'dromaeojs', 12:53:05 INFO - 'system_bits': '32', 12:53:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:53:05 INFO - 'title': 't-yosemite-r7-0224', 12:53:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:53:05 INFO - 'use_talos_json': True, 12:53:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:53:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:53:05 INFO - 'work_dir': 'build'} 12:53:05 INFO - [mozharness: 2016-09-27 19:53:05.268056Z] Running clobber step. 12:53:05 INFO - Running pre-action listener: _resource_record_pre_action 12:53:05 INFO - Running main action method: clobber 12:53:05 INFO - rmtree: /builds/slave/test/build 12:53:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:53:06 INFO - Running post-action listener: _resource_record_post_action 12:53:06 INFO - [mozharness: 2016-09-27 19:53:06.687838Z] Finished clobber step (success) 12:53:06 INFO - [mozharness: 2016-09-27 19:53:06.688092Z] Running read-buildbot-config step. 12:53:06 INFO - Running pre-action listener: _resource_record_pre_action 12:53:06 INFO - Running main action method: read_buildbot_config 12:53:06 INFO - Using buildbot properties: 12:53:06 INFO - { 12:53:06 INFO - "project": "", 12:53:06 INFO - "product": "firefox", 12:53:06 INFO - "script_repo_revision": "production", 12:53:06 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 12:53:06 INFO - "repository": "", 12:53:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 12:53:06 INFO - "buildid": "20160927120422", 12:53:06 INFO - "pgo_build": "False", 12:53:06 INFO - "basedir": "/builds/slave/test", 12:53:06 INFO - "buildnumber": 78, 12:53:06 INFO - "slavename": "t-yosemite-r7-0224", 12:53:06 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 12:53:06 INFO - "platform": "yosemite_r7", 12:53:06 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 12:53:06 INFO - "branch": "mozilla-aurora", 12:53:06 INFO - "repo_path": "releases/mozilla-aurora", 12:53:06 INFO - "revision": "515ab50a00a2e7c72a5eb7e0625a3aa6c8e4404b", 12:53:06 INFO - "stage_platform": "macosx64", 12:53:06 INFO - "builduid": "f2fc5c85d23643dfb69d1e0a9dd5b1a8", 12:53:06 INFO - "slavebuilddir": "test" 12:53:06 INFO - } 12:53:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 12:53:06 INFO - Running post-action listener: _resource_record_post_action 12:53:06 INFO - [mozharness: 2016-09-27 19:53:06.693981Z] Finished read-buildbot-config step (success) 12:53:06 INFO - [mozharness: 2016-09-27 19:53:06.694137Z] Running download-and-extract step. 12:53:06 INFO - Running pre-action listener: _resource_record_pre_action 12:53:06 INFO - Running main action method: download_and_extract 12:53:06 INFO - mkdir: /builds/slave/test/build/tests 12:53:06 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')]} 12:53:06 INFO - trying https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 12:53:06 INFO - Downloading https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 12:53:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 12:53:07 INFO - Downloaded 1199 bytes. 12:53:07 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 12:53:07 INFO - Using the following test package requirements: 12:53:07 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 12:53:07 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:53:07 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 12:53:07 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:53:07 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 12:53:07 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:53:07 INFO - u'jsshell-mac.zip'], 12:53:07 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:53:07 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 12:53:07 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 12:53:07 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:53:07 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 12:53:07 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:53:07 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 12:53:07 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:53:07 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 12:53:07 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:53:07 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 12:53:07 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 12:53:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 12:53:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:53:07 INFO - Fetch https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 12:53:08 INFO - Expected file size: 16431889 12:53:14 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 12:53:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 12:53:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:53:14 INFO - Fetch https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 12:53:15 INFO - Expected file size: 16431889 12:53:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 12:53:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 12:53:22 INFO - Fetch https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 12:53:22 INFO - Expected file size: 14414059 12:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:23 INFO - trying https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:53:23 INFO - Downloading https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 12:53:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 12:53:26 INFO - Downloaded 115261872 bytes. 12:53:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:53:26 INFO - mkdir: /builds/slave/test/properties 12:53:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:53:26 INFO - Writing to file /builds/slave/test/properties/build_url 12:53:26 INFO - Contents: 12:53:26 INFO - build_url:https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:53:27 INFO - Running post-action listener: _resource_record_post_action 12:53:27 INFO - Running post-action listener: set_extra_try_arguments 12:53:27 INFO - [mozharness: 2016-09-27 19:53:27.287557Z] Finished download-and-extract step (success) 12:53:27 INFO - [mozharness: 2016-09-27 19:53:27.287707Z] Running populate-webroot step. 12:53:27 INFO - Running pre-action listener: _resource_record_pre_action 12:53:27 INFO - Running main action method: populate_webroot 12:53:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:53:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:53:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:53:27 INFO - '--tppagecycles', 12:53:27 INFO - '7'], 12:53:27 INFO - 'tests': ['tsvgm']}}, 12:53:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:53:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:53:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:53:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:53:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:53:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:53:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:27 INFO - 'talos_options': ['--disable-e10s'], 12:53:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:53:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:53:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:27 INFO - 'talos_options': ['--disable-e10s'], 12:53:27 INFO - 'tests': ['damp', 'tps']}, 12:53:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:27 INFO - 'tests': ['damp', 'tps']}, 12:53:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:53:27 INFO - 'tests': ['dromaeo_dom']}, 12:53:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:53:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:53:27 INFO - 'tests': ['basic_compositor_video']}, 12:53:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:53:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:53:27 INFO - 'tests': ['a11yr', 12:53:27 INFO - 'ts_paint', 12:53:27 INFO - 'tpaint', 12:53:27 INFO - 'sessionrestore', 12:53:27 INFO - 'sessionrestore_no_auto_restore', 12:53:27 INFO - 'tabpaint']}, 12:53:27 INFO - 'other-e10s': {'tests': ['a11yr', 12:53:27 INFO - 'ts_paint', 12:53:27 INFO - 'tpaint', 12:53:27 INFO - 'sessionrestore', 12:53:27 INFO - 'sessionrestore_no_auto_restore', 12:53:27 INFO - 'tabpaint']}, 12:53:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:53:27 INFO - 'ts_paint', 12:53:27 INFO - 'tpaint', 12:53:27 INFO - 'sessionrestore', 12:53:27 INFO - 'sessionrestore_no_auto_restore', 12:53:27 INFO - 'tabpaint']}, 12:53:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:53:27 INFO - 'ts_paint', 12:53:27 INFO - 'tpaint', 12:53:27 INFO - 'sessionrestore', 12:53:27 INFO - 'sessionrestore_no_auto_restore', 12:53:27 INFO - 'tabpaint']}, 12:53:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:53:27 INFO - 'tests': ['a11yr', 12:53:27 INFO - 'ts_paint', 12:53:27 INFO - 'tpaint', 12:53:27 INFO - 'sessionrestore', 12:53:27 INFO - 'sessionrestore_no_auto_restore', 12:53:27 INFO - 'tabpaint']}, 12:53:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:53:27 INFO - 'tests': ['a11yr', 12:53:27 INFO - 'ts_paint', 12:53:27 INFO - 'tpaint', 12:53:27 INFO - 'sessionrestore', 12:53:27 INFO - 'sessionrestore_no_auto_restore', 12:53:27 INFO - 'tabpaint']}, 12:53:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:53:27 INFO - 'tests': ['tsvgx', 12:53:27 INFO - 'tsvgr_opacity', 12:53:27 INFO - 'tart', 12:53:27 INFO - 'tscrollx', 12:53:27 INFO - 'cart']}, 12:53:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:53:27 INFO - 'tsvgr_opacity', 12:53:27 INFO - 'tart', 12:53:27 INFO - 'tscrollx', 12:53:27 INFO - 'cart']}, 12:53:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:27 INFO - 'talos_options': ['--disable-e10s'], 12:53:27 INFO - 'tests': ['tp5o']}, 12:53:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:27 INFO - 'tests': ['tp5o']}, 12:53:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:27 INFO - 'talos_options': ['--disable-e10s', 12:53:27 INFO - '--xperf_path', 12:53:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:53:27 INFO - 'tests': ['tp5n']}, 12:53:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:27 INFO - 'talos_options': ['--xperf_path', 12:53:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:53:27 INFO - 'tests': ['tp5n']}}, 12:53:27 INFO - 'talos.zip': {'path': '', 12:53:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:53:27 INFO - Running post-action listener: _resource_record_post_action 12:53:27 INFO - [mozharness: 2016-09-27 19:53:27.306767Z] Finished populate-webroot step (success) 12:53:27 INFO - [mozharness: 2016-09-27 19:53:27.306899Z] Running create-virtualenv step. 12:53:27 INFO - Running pre-action listener: _resource_record_pre_action 12:53:27 INFO - Running main action method: create_virtualenv 12:53:27 INFO - Creating virtualenv /builds/slave/test/build/venv 12:53:27 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 12:53:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:53:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:53:27 INFO - Using real prefix '/tools/python27' 12:53:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:53:28 INFO - Installing distribute.............................................................................................................................................................................................done. 12:53:30 INFO - Installing pip.................done. 12:53:30 INFO - Return code: 0 12:53:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:30 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 0x108905490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10887b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee30585b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108719d30>, '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 0x10857fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108711b20>, '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.uR62rkhhVY/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.sHD85xq9Sc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 12:53:30 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 12:53:30 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 12:53:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uR62rkhhVY/Render', 12:53:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:30 INFO - 'HOME': '/Users/cltbld', 12:53:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:30 INFO - 'LOGNAME': 'cltbld', 12:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:30 INFO - 'MOZ_NO_REMOTE': '1', 12:53:30 INFO - 'NO_EM_RESTART': '1', 12:53:30 INFO - 'PAGER': '/bin/cat', 12:53:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:30 INFO - 'PWD': '/builds/slave/test', 12:53:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:30 INFO - 'SHELL': '/bin/bash', 12:53:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHD85xq9Sc/Listeners', 12:53:30 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 12:53:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:30 INFO - 'USER': 'cltbld', 12:53:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:30 INFO - 'XPC_FLAGS': '0x0', 12:53:30 INFO - 'XPC_SERVICE_NAME': '0', 12:53:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:31 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 12:53:31 INFO - Cleaning up... 12:53:31 INFO - Return code: 0 12:53:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108905490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10887b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee30585b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108719d30>, '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 0x10857fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108711b20>, '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.uR62rkhhVY/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.sHD85xq9Sc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 12:53:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uR62rkhhVY/Render', 12:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:31 INFO - 'HOME': '/Users/cltbld', 12:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:31 INFO - 'LOGNAME': 'cltbld', 12:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:31 INFO - 'MOZ_NO_REMOTE': '1', 12:53:31 INFO - 'NO_EM_RESTART': '1', 12:53:31 INFO - 'PAGER': '/bin/cat', 12:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:31 INFO - 'PWD': '/builds/slave/test', 12:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:31 INFO - 'SHELL': '/bin/bash', 12:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHD85xq9Sc/Listeners', 12:53:31 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 12:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:31 INFO - 'USER': 'cltbld', 12:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:31 INFO - 'XPC_FLAGS': '0x0', 12:53:31 INFO - 'XPC_SERVICE_NAME': '0', 12:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:31 INFO - Downloading/unpacking psutil>=3.1.1 12:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:53:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:53:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:53:34 INFO - Installing collected packages: psutil 12:53:34 INFO - Running setup.py install for psutil 12:53:35 INFO - building 'psutil._psutil_osx' extension 12:53:35 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 12:53:35 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 12:53:35 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 12:53:35 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 12:53:35 INFO - building 'psutil._psutil_posix' extension 12:53:35 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 12:53:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:53:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:53:35 INFO - ^ 12:53:35 INFO - 1 warning generated. 12:53:35 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 12:53:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:53:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:53:35 INFO - Successfully installed psutil 12:53:35 INFO - Cleaning up... 12:53:35 INFO - Return code: 0 12:53:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:53:35 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')]} 12:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:35 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')]} 12:53:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:35 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 0x108905490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10887b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee30585b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108719d30>, '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 0x10857fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108711b20>, '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.uR62rkhhVY/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.sHD85xq9Sc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 12:53:35 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 12:53:35 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 12:53:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uR62rkhhVY/Render', 12:53:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:35 INFO - 'HOME': '/Users/cltbld', 12:53:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:35 INFO - 'LOGNAME': 'cltbld', 12:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:35 INFO - 'MOZ_NO_REMOTE': '1', 12:53:35 INFO - 'NO_EM_RESTART': '1', 12:53:35 INFO - 'PAGER': '/bin/cat', 12:53:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:35 INFO - 'PWD': '/builds/slave/test', 12:53:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:35 INFO - 'SHELL': '/bin/bash', 12:53:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHD85xq9Sc/Listeners', 12:53:35 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 12:53:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:35 INFO - 'USER': 'cltbld', 12:53:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:35 INFO - 'XPC_FLAGS': '0x0', 12:53:35 INFO - 'XPC_SERVICE_NAME': '0', 12:53:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:53: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 12:53: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 12:53: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 12:53: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 12:53: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 12:53: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 12:53:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:53:38 INFO - Installing collected packages: mozsystemmonitor 12:53:38 INFO - Running setup.py install for mozsystemmonitor 12:53:38 INFO - Successfully installed mozsystemmonitor 12:53:38 INFO - Cleaning up... 12:53:38 INFO - Return code: 0 12:53:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:53: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')]} 12:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53: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')]} 12:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108905490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10887b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee30585b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108719d30>, '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 0x10857fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108711b20>, '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.uR62rkhhVY/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.sHD85xq9Sc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 12:53:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:53:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uR62rkhhVY/Render', 12:53:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:38 INFO - 'HOME': '/Users/cltbld', 12:53:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:38 INFO - 'LOGNAME': 'cltbld', 12:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:38 INFO - 'MOZ_NO_REMOTE': '1', 12:53:38 INFO - 'NO_EM_RESTART': '1', 12:53:38 INFO - 'PAGER': '/bin/cat', 12:53:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:38 INFO - 'PWD': '/builds/slave/test', 12:53:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:38 INFO - 'SHELL': '/bin/bash', 12:53:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHD85xq9Sc/Listeners', 12:53:38 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 12:53:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:38 INFO - 'USER': 'cltbld', 12:53:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:38 INFO - 'XPC_FLAGS': '0x0', 12:53:38 INFO - 'XPC_SERVICE_NAME': '0', 12:53:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:39 INFO - Downloading/unpacking jsonschema==2.5.1 12:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:53:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:53:41 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 12:53:41 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 12:53:41 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 12:53:41 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 12:53:41 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 12:53:41 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 12:53:41 INFO - Downloading functools32-3.2.3-2.tar.gz 12:53:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:53:41 INFO - warning: no files found matching '*.txt' 12:53:41 INFO - no previously-included directories found matching 'build' 12:53:41 INFO - no previously-included directories found matching 'dist' 12:53:41 INFO - no previously-included directories found matching '.git*' 12:53:41 INFO - Installing collected packages: jsonschema, functools32 12:53:42 INFO - Running setup.py install for functools32 12:53:42 INFO - warning: no files found matching '*.txt' 12:53:42 INFO - no previously-included directories found matching 'build' 12:53:42 INFO - no previously-included directories found matching 'dist' 12:53:42 INFO - no previously-included directories found matching '.git*' 12:53:42 INFO - Successfully installed jsonschema functools32 12:53:42 INFO - Cleaning up... 12:53:42 INFO - Return code: 0 12:53:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:53:42 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')]} 12:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:42 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')]} 12:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:42 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 0x108905490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10887b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee30585b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108719d30>, '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 0x10857fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108711b20>, '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.uR62rkhhVY/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.sHD85xq9Sc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 12:53:42 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 12:53:42 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 12:53:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uR62rkhhVY/Render', 12:53:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:42 INFO - 'HOME': '/Users/cltbld', 12:53:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:42 INFO - 'LOGNAME': 'cltbld', 12:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:42 INFO - 'MOZ_NO_REMOTE': '1', 12:53:42 INFO - 'NO_EM_RESTART': '1', 12:53:42 INFO - 'PAGER': '/bin/cat', 12:53:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:42 INFO - 'PWD': '/builds/slave/test', 12:53:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:42 INFO - 'SHELL': '/bin/bash', 12:53:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHD85xq9Sc/Listeners', 12:53:42 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 12:53:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:42 INFO - 'USER': 'cltbld', 12:53:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:42 INFO - 'XPC_FLAGS': '0x0', 12:53:42 INFO - 'XPC_SERVICE_NAME': '0', 12:53:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:53:42 INFO - Cleaning up... 12:53:42 INFO - Return code: 0 12:53:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:53:42 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')]} 12:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:42 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')]} 12:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:42 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 0x108905490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10887b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee30585b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108719d30>, '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 0x10857fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108711b20>, '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.uR62rkhhVY/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.sHD85xq9Sc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 12:53:42 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 12:53:42 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 12:53:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uR62rkhhVY/Render', 12:53:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:42 INFO - 'HOME': '/Users/cltbld', 12:53:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:42 INFO - 'LOGNAME': 'cltbld', 12:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:42 INFO - 'MOZ_NO_REMOTE': '1', 12:53:42 INFO - 'NO_EM_RESTART': '1', 12:53:42 INFO - 'PAGER': '/bin/cat', 12:53:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:42 INFO - 'PWD': '/builds/slave/test', 12:53:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:42 INFO - 'SHELL': '/bin/bash', 12:53:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHD85xq9Sc/Listeners', 12:53:42 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 12:53:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:42 INFO - 'USER': 'cltbld', 12:53:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:42 INFO - 'XPC_FLAGS': '0x0', 12:53:42 INFO - 'XPC_SERVICE_NAME': '0', 12:53:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:42 INFO - Downloading/unpacking blobuploader==1.2.4 12:53:42 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 12:53:42 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 12:53:42 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 12:53:42 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 12:53:42 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 12:53:42 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 12:53:45 INFO - Downloading blobuploader-1.2.4.tar.gz 12:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:53:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:53: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 12:53: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 12:53: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 12:53: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 12:53: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 12:53: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 12:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:53:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:53: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 12:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:46 INFO - Downloading docopt-0.6.1.tar.gz 12:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:53:46 INFO - Installing collected packages: blobuploader, requests, docopt 12:53:46 INFO - Running setup.py install for blobuploader 12:53:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:53:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:53:46 INFO - Running setup.py install for requests 12:53:47 INFO - Running setup.py install for docopt 12:53:47 INFO - Successfully installed blobuploader requests docopt 12:53:47 INFO - Cleaning up... 12:53:47 INFO - Return code: 0 12:53:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:53:47 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')]} 12:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:47 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')]} 12:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:47 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 0x108905490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10887b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee30585b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108719d30>, '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 0x10857fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108711b20>, '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.uR62rkhhVY/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.sHD85xq9Sc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 12:53:47 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 12:53:47 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 12:53:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uR62rkhhVY/Render', 12:53:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:47 INFO - 'HOME': '/Users/cltbld', 12:53:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:47 INFO - 'LOGNAME': 'cltbld', 12:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:47 INFO - 'MOZ_NO_REMOTE': '1', 12:53:47 INFO - 'NO_EM_RESTART': '1', 12:53:47 INFO - 'PAGER': '/bin/cat', 12:53:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:47 INFO - 'PWD': '/builds/slave/test', 12:53:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:47 INFO - 'SHELL': '/bin/bash', 12:53:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHD85xq9Sc/Listeners', 12:53:47 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 12:53:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:47 INFO - 'USER': 'cltbld', 12:53:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:47 INFO - 'XPC_FLAGS': '0x0', 12:53:47 INFO - 'XPC_SERVICE_NAME': '0', 12:53:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:53:47 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-Ln_ntq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:53:47 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-6PokUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:53:47 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-15e4b2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:53:48 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-3pb_vV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:53:48 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-v4zc7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:53:48 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-B1uzWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:53:48 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-5HdIVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:53:48 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-n75Qfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:53:48 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-z_HiAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:53:48 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-uQkHmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:53:48 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-tnFUyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:53:48 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-fTTfEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:53:48 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-xWjK8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:53:49 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-Z9GTsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:49 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-Uqhw6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:53:49 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-TcRVXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:53:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:53:49 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-xf64ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:53:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:53:49 INFO - Running setup.py install for manifestparser 12:53:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:53:49 INFO - Running setup.py install for mozcrash 12:53:49 INFO - Running setup.py install for mozdebug 12:53:49 INFO - Running setup.py install for mozdevice 12:53:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:53:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:53:50 INFO - Running setup.py install for mozfile 12:53:50 INFO - Running setup.py install for mozhttpd 12:53:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:53:50 INFO - Running setup.py install for mozinfo 12:53:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:53:50 INFO - Running setup.py install for mozInstall 12:53:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:53:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:53:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:53:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:53:50 INFO - Running setup.py install for mozleak 12:53:50 INFO - Running setup.py install for mozlog 12:53:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:53:50 INFO - Running setup.py install for moznetwork 12:53:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:53:51 INFO - Running setup.py install for mozprocess 12:53:51 INFO - Running setup.py install for mozprofile 12:53:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:53:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:53:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:53:51 INFO - Running setup.py install for mozrunner 12:53:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:53:51 INFO - Running setup.py install for mozscreenshot 12:53:51 INFO - Running setup.py install for moztest 12:53:51 INFO - Running setup.py install for mozversion 12:53:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:53:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:53:52 INFO - Cleaning up... 12:53:52 INFO - Return code: 0 12:53:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:52 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 0x108905490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10887b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee30585b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108719d30>, '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 0x10857fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108711b20>, '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.uR62rkhhVY/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.sHD85xq9Sc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 12:53:52 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 12:53:52 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 12:53:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uR62rkhhVY/Render', 12:53:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:52 INFO - 'HOME': '/Users/cltbld', 12:53:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:52 INFO - 'LOGNAME': 'cltbld', 12:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:52 INFO - 'MOZ_NO_REMOTE': '1', 12:53:52 INFO - 'NO_EM_RESTART': '1', 12:53:52 INFO - 'PAGER': '/bin/cat', 12:53:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:52 INFO - 'PWD': '/builds/slave/test', 12:53:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:52 INFO - 'SHELL': '/bin/bash', 12:53:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHD85xq9Sc/Listeners', 12:53:52 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 12:53:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:52 INFO - 'USER': 'cltbld', 12:53:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:52 INFO - 'XPC_FLAGS': '0x0', 12:53:52 INFO - 'XPC_SERVICE_NAME': '0', 12:53:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:53:52 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-Gb2MyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:53:52 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)) 12:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:53:52 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-nCj25k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:53:52 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-HuBMOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:53:52 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)) 12:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:53:52 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-Sn1dv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:53:52 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-W63ntF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:53:52 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)) 12:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:53:52 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-FbnlOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:53:52 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)) 12:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:53:52 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-ra9E7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:53:53 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)) 12:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:53:53 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-hWMQy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:53:53 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)) 12:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:53:53 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-hvVs4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:53:53 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)) 12:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:53:53 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-uvHnGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:53:53 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)) 12:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:53:53 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-RJg3rd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:53:53 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)) 12:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:53:53 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-_oQJko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:53:53 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-1BVpfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:53:53 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)) 12:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:53:53 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-yC3AI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:53 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-LVS_bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:53 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)) 12:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:53:53 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-tOLyFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:53:54 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-w2OBLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:53:54 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)) 12:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:53:54 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)) 12:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:53:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:53:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:53:54 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 12:53:54 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 12:53:54 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 12:53:54 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 12:53:54 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 12:53:54 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 12:53:56 INFO - Downloading blessings-1.6.tar.gz 12:53:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:53:56 INFO - Installing collected packages: blessings 12:53:56 INFO - Running setup.py install for blessings 12:53:56 INFO - Successfully installed blessings 12:53:56 INFO - Cleaning up... 12:53:56 INFO - Return code: 0 12:53:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:53:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:53:57 INFO - Reading from file tmpfile_stdout 12:53:57 INFO - Current package versions: 12:53:57 INFO - blessings == 1.6 12:53:57 INFO - blobuploader == 1.2.4 12:53:57 INFO - docopt == 0.6.1 12:53:57 INFO - functools32 == 3.2.3-2 12:53:57 INFO - jsonschema == 2.5.1 12:53:57 INFO - manifestparser == 1.1 12:53:57 INFO - mozInstall == 1.12 12:53:57 INFO - mozcrash == 0.17 12:53:57 INFO - mozdebug == 0.1 12:53:57 INFO - mozdevice == 0.48 12:53:57 INFO - mozfile == 1.2 12:53:57 INFO - mozhttpd == 0.7 12:53:57 INFO - mozinfo == 0.9 12:53:57 INFO - mozleak == 0.1 12:53:57 INFO - mozlog == 3.4 12:53:57 INFO - moznetwork == 0.27 12:53:57 INFO - mozprocess == 0.23 12:53:57 INFO - mozprofile == 0.28 12:53:57 INFO - mozrunner == 6.12 12:53:57 INFO - mozscreenshot == 0.1 12:53:57 INFO - mozsystemmonitor == 0.3 12:53:57 INFO - moztest == 0.7 12:53:57 INFO - mozversion == 1.4 12:53:57 INFO - psutil == 3.1.1 12:53:57 INFO - requests == 1.2.3 12:53:57 INFO - wsgiref == 0.1.2 12:53:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:57 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 0x108905490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10887b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee30585b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108719d30>, '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 0x10857fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108711b20>, '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.uR62rkhhVY/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.sHD85xq9Sc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 12:53:57 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 12:53:57 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 12:53:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uR62rkhhVY/Render', 12:53:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:57 INFO - 'HOME': '/Users/cltbld', 12:53:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:57 INFO - 'LOGNAME': 'cltbld', 12:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:57 INFO - 'MOZ_NO_REMOTE': '1', 12:53:57 INFO - 'NO_EM_RESTART': '1', 12:53:57 INFO - 'PAGER': '/bin/cat', 12:53:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:57 INFO - 'PWD': '/builds/slave/test', 12:53:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:57 INFO - 'SHELL': '/bin/bash', 12:53:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHD85xq9Sc/Listeners', 12:53:57 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 12:53:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:57 INFO - 'USER': 'cltbld', 12:53:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:57 INFO - 'XPC_FLAGS': '0x0', 12:53:57 INFO - 'XPC_SERVICE_NAME': '0', 12:53:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:57 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)) 12:53:57 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)) 12:53:57 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)) 12:53:57 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)) 12:53:57 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)) 12:53:57 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)) 12:53:57 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)) 12:53:57 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)) 12:53:57 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)) 12:53:57 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)) 12:53:57 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)) 12:53:57 INFO - Cleaning up... 12:53:57 INFO - Return code: 0 12:53:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:57 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 0x108905490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10887b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee30585b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108719d30>, '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 0x10857fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108711b20>, '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.uR62rkhhVY/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.sHD85xq9Sc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 12:53:57 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 12:53:57 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 12:53:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uR62rkhhVY/Render', 12:53:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:53:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:53:57 INFO - 'HOME': '/Users/cltbld', 12:53:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:53:57 INFO - 'LOGNAME': 'cltbld', 12:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:57 INFO - 'MOZ_NO_REMOTE': '1', 12:53:57 INFO - 'NO_EM_RESTART': '1', 12:53:57 INFO - 'PAGER': '/bin/cat', 12:53:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:57 INFO - 'PWD': '/builds/slave/test', 12:53:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:53:57 INFO - 'SHELL': '/bin/bash', 12:53:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHD85xq9Sc/Listeners', 12:53:57 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 12:53:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:53:57 INFO - 'USER': 'cltbld', 12:53:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:53:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:57 INFO - 'XPC_FLAGS': '0x0', 12:53:57 INFO - 'XPC_SERVICE_NAME': '0', 12:53:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:53:57 INFO - Cleaning up... 12:53:57 INFO - Return code: 0 12:53:57 INFO - Running post-action listener: _resource_record_post_action 12:53:57 INFO - Running post-action listener: _start_resource_monitoring 12:53:57 INFO - Starting resource monitoring. 12:53:57 INFO - [mozharness: 2016-09-27 19:53:57.798483Z] Finished create-virtualenv step (success) 12:53:57 INFO - [mozharness: 2016-09-27 19:53:57.799553Z] Running install step. 12:53:57 INFO - Running pre-action listener: _resource_record_pre_action 12:53:57 INFO - Running main action method: install 12:53:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:53:58 INFO - Reading from file tmpfile_stdout 12:53:58 INFO - Detecting whether we're running mozinstall >=1.0... 12:53:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:53:58 INFO - Reading from file tmpfile_stdout 12:53:58 INFO - Output received: 12:53:58 INFO - Usage: mozinstall [options] installer 12:53:58 INFO - Options: 12:53:58 INFO - -h, --help show this help message and exit 12:53:58 INFO - -d DEST, --destination=DEST 12:53:58 INFO - Directory to install application into. [default: 12:53:58 INFO - "/builds/slave/test"] 12:53:58 INFO - --app=APP Application being installed. [default: firefox] 12:53:58 INFO - mkdir: /builds/slave/test/build/application 12:53:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 12:54:30 INFO - Reading from file tmpfile_stdout 12:54:30 INFO - Output received: 12:54:30 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 12:54:30 INFO - Running post-action listener: _resource_record_post_action 12:54:30 INFO - [mozharness: 2016-09-27 19:54:30.641266Z] Finished install step (success) 12:54:30 INFO - [mozharness: 2016-09-27 19:54:30.641417Z] Running run-tests step. 12:54:30 INFO - Running pre-action listener: _resource_record_pre_action 12:54:30 INFO - Running main action method: run_tests 12:54:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:54:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:54:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:54:30 INFO - 2016-09-27 12:54:30.655 screenresolution[1946:18987] starting screenresolution argv=screenresolution get 12:54:30 INFO - 2016-09-27 12:54:30.658 screenresolution[1946:18987] Display 0: 1600x1200x32@60 12:54:30 INFO - 2016-09-27 12:54:30.664 screenresolution[1947:18989] starting screenresolution argv=screenresolution list 12:54:30 INFO - Available Modes on Display 0 12:54:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:54:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:54:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:54:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:54:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:54:30 INFO - Intel Iris: 12:54:30 INFO - Chipset Model: Intel Iris 12:54:30 INFO - Type: GPU 12:54:30 INFO - Bus: Built-In 12:54:30 INFO - VRAM (Dynamic, Max): 1536 MB 12:54:30 INFO - Vendor: Intel (0x8086) 12:54:30 INFO - Device ID: 0x0a2e 12:54:30 INFO - Revision ID: 0x0009 12:54:30 INFO - Displays: 12:54:30 INFO - Display: 12:54:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:54:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:54:30 INFO - Display Serial Number: 1600x1200 60 12:54:30 INFO - Main Display: Yes 12:54:30 INFO - Mirror: Off 12:54:30 INFO - Online: Yes 12:54:30 INFO - Rotation: Supported 12:54:30 INFO - Return code: 0 12:54:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:54:30 INFO - Python 2.7.3 12:54:30 INFO - Return code: 0 12:54:30 INFO - grabbing minidump binary from tooltool 12:54:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:30 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 0x108719d30>, '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 0x10857fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108711b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:54:30 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 12:54:30 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 12:54:30 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 12:54:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:54:31 INFO - Return code: 0 12:54:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:54:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:54:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:54:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:54:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:54:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0224', '--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 12:54:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0224 --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 12:54:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uR62rkhhVY/Render', 12:54:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:54:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:54:31 INFO - 'HOME': '/Users/cltbld', 12:54:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:54:31 INFO - 'LOGNAME': 'cltbld', 12:54:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:54:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:31 INFO - 'MOZ_NO_REMOTE': '1', 12:54:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:54:31 INFO - 'NO_EM_RESTART': '1', 12:54:31 INFO - 'PAGER': '/bin/cat', 12:54:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:31 INFO - 'PWD': '/builds/slave/test', 12:54:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:54:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:54:31 INFO - 'SHELL': '/bin/bash', 12:54:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHD85xq9Sc/Listeners', 12:54:31 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 12:54:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:54:31 INFO - 'USER': 'cltbld', 12:54:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:54:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:31 INFO - 'XPC_FLAGS': '0x0', 12:54:31 INFO - 'XPC_SERVICE_NAME': '0', 12:54:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:54:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0224', '--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 12:54:31 INFO - mozversion application_buildid: 20160927120422 12:54:31 INFO - mozversion application_changeset: 515ab50a00a2e7c72a5eb7e0625a3aa6c8e4404b 12:54:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:54:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:54:31 INFO - mozversion application_name: Firefox 12:54:31 INFO - mozversion application_remotingname: firefox-dev 12:54:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:54:31 INFO - mozversion application_vendor: Mozilla 12:54:31 INFO - mozversion application_version: 51.0a2 12:54:31 INFO - mozversion platform_buildid: 20160927120422 12:54:31 INFO - mozversion platform_changeset: 515ab50a00a2e7c72a5eb7e0625a3aa6c8e4404b 12:54:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:54:31 INFO - mozversion platform_version: 51.0a2 12:54:31 INFO - using testdate: 1475006071 12:54:31 INFO - actual date: 1475006071 12:54:31 INFO - starting webserver on 'localhost:54465' 12:54:31 INFO - SUITE-START | Running 2 tests 12:54:31 INFO - TEST-START | dromaeo_css 12:54:31 INFO - operating with platform_type : mac_ 12:54:31 INFO - Initialising browser for dromaeo_css test... 12:54:31 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmpqGWVmm/profile http://localhost:54465/getInfo.html) 12:54:33 INFO - PROCESS | 1957 | __metrics Screen width/height:1600/1200 12:54:33 INFO - PROCESS | 1957 | colorDepth:24 12:54:33 INFO - PROCESS | 1957 | Browser inner width/height: 1024/689 12:54:33 INFO - PROCESS | 1957 | __metrics 12:54:33 INFO - PROCESS | 1957 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:54:33 INFO - PROCESS | 1957 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:54:34 INFO - TEST-INFO | 1957: exit 0 12:54:34 INFO - Browser initialized. 12:54:34 INFO - Running cycle 1/1 for dromaeo_css test... 12:54:34 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmpqGWVmm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:54:46 INFO - PROCESS | 1959 | RSS: Main: 219418624 12:54:46 INFO - PROCESS | 1959 | 12:55:37 INFO - PROCESS | 1959 | 1475006137349 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:57:49 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:54465/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54465/tests/dromaeo/cssquery-ext.html) 12:57:50 INFO - PROCESS | 1959 | RSS: Main: 347389952 12:57:50 INFO - PROCESS | 1959 | 13:00:53 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:54465/tests/dromaeo/cssquery-ext.html (next: http://localhost:54465/tests/dromaeo/cssquery-jquery.html) 13:00:54 INFO - PROCESS | 1959 | RSS: Main: 351584256 13:00:54 INFO - PROCESS | 1959 | 13:03:56 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:54465/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54465/tests/dromaeo/cssquery-mootools.html) 13:03:57 INFO - PROCESS | 1959 | RSS: Main: 317243392 13:03:57 INFO - PROCESS | 1959 | 13:06:59 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:54465/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54465/tests/dromaeo/cssquery-prototype.html) 13:06:59 INFO - PROCESS | 1959 | RSS: Main: 325341184 13:06:59 INFO - PROCESS | 1959 | 13:10:03 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:54465/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54465/tests/dromaeo/cssquery-yui.html) 13:10:03 INFO - PROCESS | 1959 | RSS: Main: 311648256 13:10:03 INFO - PROCESS | 1959 | 13:13:06 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:54465/tests/dromaeo/cssquery-yui.html (next: http://localhost:54465/tests/dromaeo/cssquery-dojo.html) 13:13:07 INFO - PROCESS | 1959 | RSS: Main: 561815552 13:13:07 INFO - PROCESS | 1959 | 13:13:07 INFO - PROCESS | 1959 | __start_tp_report 13:13:07 INFO - PROCESS | 1959 | _x_x_mozilla_page_load 13:13:07 INFO - PROCESS | 1959 | _x_x_mozilla_page_load_details 13:13:07 INFO - PROCESS | 1959 | |i|pagename|runs| 13:13:07 INFO - PROCESS | 1959 | |0;dojo.html;2823.3929705113396;3275.83620818959;3290.3912776136403;3333.4166520858844;3344.6488118747516;5641.125625528045;5673.943260567393;5742.913856292159;5752.079667253241;5763.10671845864;5632.859178520539;5676.602637815345;5703.3441154267275;5727.742251598677;5781.39295373986;5125.82059627914;5149.613778966574;5154.304168937202;5163.81926632568;5243.370795504545;5173.741312934357;5207.010667973092;5213.582913366921;5293.841184764444;5296.390915044781;5290.576753859682;5297.576193904479;5306.177542480922;5306.840794776143;5344.625876188668;5261.0793111205385;5276.525112739833;5299.54953828925;5333.4399888011785;5376.4085950545405;5194.428612852583;5301;5308.097623403992;5317.893642127175;5343.225232341328;5583.162525621149;5664.20701101846;5673.716314184274;5868.9413105868825;5871.031279838821;6126.853582554517;6182.474489668383;6201.286852011986;6255.030470277069;6261.405166509175;6253.249610046778;6254.718537665816;6284.088807122987;6296.401841825019;6308.2745484269435;5719.7140142992685;5788.392218817048;5917.053271476543;5951.345352011362;5956.463918247378;6149.446549810538;6199.876002479925;6207.720652570645;6223.626582405071;6254.593451425642;6194.34959329273;6208.565400422018;6212.161358216673;6215.223097112861;6234.470070044006;4713.457952335525;5245.475452454801;6210.689465526705;6247.843803904848;6278.6860656966965;6092.055731361646;6133.248135464543;6145.525073982301;6203.844903877439;6205.379462053758;6140.881395918401;6205.9760139577365;6211.534134939898;6213.689315534296;6214.502839772807;4962.60299176065;4963.801447942042;4968.552830245295;4968.801247950041;4992.700437973734;4434.246178149658;4444.9776551392715;4445.555444455593;4445.644348452116;4476.149531588988;5622.746976386073;5672.829815105553;5714.685692286881;5826.883462330729;5853.414658534112;6222.502199824004;6258.061290806416;6264.686765661699;6266.122742816009;6271.4669253114;5886.558508111909;5905.940940590625;5906.704664766745;5920.585559010914;5957.821265362046;5361.27622770921;5399;5458.181272809111;5477.561795056386;5487.807926722546;6178.598391104564;6215.409536094064;6238.937610623836;6244.313125556185;6254.8123556294295;6222.657753823583;6229.844253893689;6233;6249.093881387264;6255.280642725963;6245.5628106032145;6245.750169993149;6301.023341382093;6311.305756366704;6320.557560970872;6071.757129714939;6117.755289788359;6118.990366589463;6125.998614523495;6241.812745617639;6145.35473775265;6198.659073750807;6243.719032643633;6244.812655620339;6252.09344645033;6100.23747031621;6162.753489860355;6171.352008039091;6176.81469555914;6191.473724733448;6031.638101713911;6087.421694938974;6184.752609895734;6190.1952746142715;6213.068039794067;5993.101034844808;6016.548758843017;6045.75816967334;6078.574499784972;6122.6938653068055;6213.471854892385;6221.875562488815;6233.127362169391;6239.407256310643;6241.78153764616;5901.527877769854;5999.5500337473995;6085.361037091218;6085.4523092921845;6106.023036314168 13:13:07 INFO - PROCESS | 1959 | |1;ext.html;477.615519506797;510.77015343095593;518.0829931022091;524.4860037163578;556.3462931056008;30369.240768980788;40973.385399219;42480;42525.574744252546;42602.14795704084;43611.3458298125;43901.12197756043;43982.78008609961;44001.33997990024;44113.558864411345;9643.951780241088;9850.655227067055;9868.161206297473;9868.753281167956;9875.70372888811;8724.302055835518;8952.283817294634;8970.686025989091;9079.636814527412;9084.000759916404;12026.398680066006;12319.815202771966;12331.568395106173;12337.93831030848;12344.62966111018;11934.582289619864;12028.939855300667;12030.33833139177;12043.27740335574;12048.819267710991;8639.43843650167;8862;11902.88097119035;11987.280763154238;11994.040476761926;40298.19403611941;40669.389959150634;40699.796501017605;43093.784531077144;43172;3395.6604339566093;3423.2639982403653;3427.4687423449404;3460.1003739028033;3701.9814900925594;29460.852695736383;30408.69591304103;31689.798509905915;31838.522422163685;32110.87611933571;3124.297033167542;3158.3999040182293;3170.6036745406823;3299.5050742388594;3413.573303337083;526685;529076;531139;531708;532953;63206;63614.681926590994;63646;63733.72532549323;63737.68131159314;65756.34243657599;65935;65943;66021.66989165024;66156.66921665361;14710.485133020293;17091.48725538236;17321.307147714204;17327.826721732872;17353.913230433765;13327;13378.732425351438;13383.130096543693;13383.197008179346;13383.732325353438;13020.89322407587;13606.863931360758;15328.616784580474;17369.2183851727;17723.46829595114;5467.835964921059;6298.842528936813;6302.590331628429;6345.206849143857;6363.809085727436;877.526135886614;983.5721461164273;1032.6540608895955;1033.963811266602;1073.9248252622242;28701.712982869903;30238.84880575627;30659.080227593207;30714.078577642707;31102.844485777878;1089.515165751233;1139.794836929344;1141.3209140561353;1147.3746807989667;1203.151777996528;15471.381144754308;15785.68428631421;15850.365985360457;16109.436169734237;16323.020618762912;681226;684825;685982;688735;688991;49872.75063624659;50640;57889.13166302509;58773.706131469924;59472;1340.9865901341057;1365.7473367427058;1393.6167553922346;1395.9948836837664;1399.6290982889543;30051.05325408295;31696;32043.239358596515;32248.83875580607;32354.514682280256;51759.482405176976;52338.73830630975;52399.73800131128;52428.47571524236;52505;441395;452348;452894;453221;453273;26136.8693156533;26378.86810565935;26388.208353749418;26416.207513774618;26423.943042278093;46607.30089048599;46904.29643555281;47187.52812471968;47641.761791190824;47810.521894781996;38088.857334280015;38390;38980.80509597434;39501.40747888727;40590.59409405986;38404.80797595994;38721.6127838718;39148.80425597854;39814.2037159261;39958.2008359837;36840.63159368479;38179.61820381872;38678;38841.805790971994;38842.61157388503;28198;32671.673283266864;34383.14042148966;34500.82749586236;34540.48189277213;20394;21386.465338366666;22206.222782202545;26227.60658590161;26646.934122635652 13:13:07 INFO - PROCESS | 1959 | |2;jquery.html;353.59513357205986;371.9907002324942;374.69979172272224;385.5219527785546;405.6450605719995;14892.77660835087;15165.241737913102;16751.999999999985;20730.792692073075;21276.680849787266;20038.499037524034;20413.775173489565;20606.587868242663;20818.89590552045;21426.89286553565;5991.430814072667;6016.157737916695;6138.600990935597;6244.906326405107;6252.218472690914;5986.191864098335;6165.044418115177;6170.1670274513035;6171.567990240685;6186.381361863822;4174.519930208035;4401.789507885325;6226.688665566726;6804.863902721942;6868.690908909111;6660.300668429793;6752.527323087385;6861.519693621449;6919.342662447085;6922.06552115463;5956.315023772278;5961.374055724174;5962.5528085393335;5968.134620480006;5976.880462390772;25322.87338563314;25332;25442.491150177077;25570.849311781014;26230.86884565584;2375.7267914189915;2455.7667021633097;2493.30187547487;2691.609716591103;2813.5779633055;15131.394744210218;15796.526104216891;15991.92004039984;16546.503604891754;16630.168491575372;1872.5318670332417;1973.4671638657483;1976.3379267945256;1976.8616196866226;1981.504623844039;116831;118228.40885795516;118258;121482.39258803737;121578.17632735516;10761.677149685365;10868.891311086945;11269.94365028186;11321.377324247082;11389.715257118472;12934.611961641165;12972.156809807333;13695.589132326046;14022.298885055707;14117.647058823612;7766.145723970359;8470.788230294293;8547.487150770974;8875.201231889161;8913.019567847532;7437.367823734935;8108.39187060961;8388.951381077366;8933.19601235892;8970.37207395476;5625.943740562624;6600.141981542369;6732.495062870206;6743.730250790011;6883.174019117738;1586.4526738275276;1664.625459271654;1785.3215778004535;1802.4862914069427;1886.3114963038392;380.1920918049146;395.0479344779126;406.37215502048815;423.4748911349904;794.9705131854263;11212.719682008015;11784.469698863571;11797.29216247028;11934.940325298317;12203.20679155852;427.74976638666107;437.8445651793631;439.89222640453295;441.15298626636934;442.9579189976947;5979.222701048836;6053.4551890330085;6061.121137435047;6152.907706384408;6237.220347456568;564850;613822;630849;649402;651269;138484;138756;138956;140500;142422;898.2544488074882;942.7501712046313;952.8523078922778;1031.9845202321972;1036.0985942230157;17492.737608935622;19275.61448771045;19810.108545115218;19941.900290498455;20352.59294814125;55101.72449137729;55637;56594.717026414604;57169.714151428976;57588.13617795653;74757.6262118686;74965.25034749582;78198;78707.60646196733;79396.20603793889;5612.943870561242;6813.557118787263;7053.365197132282;8046.798830029296;8190.180981901762;12151.149419540901;12452.31512266834;12800.61598152057;12834.29411382383;13022.934885325512;10556.366618002945;10696.304740191863;10749.301295415773;10762.569497220024;10993.450327483433;10489.632862849763;10721.839172412576;10796.514156863117;10819.945900270763;11116.722081948015;9297.488638124969;11020.614278500214;11103.777924441627;11458;11553.480093395985;7234.638268086469;7259.52813067149;7299.6350182489605;7403.851922961619;7453.813654658677;10213.795724085328;10857.457127143452;11057.336559806437;11065;11313.321200727654 13:13:07 INFO - PROCESS | 1959 | |3;mootools.html;1538.8845836562255;1547.4815936661219;1768.9380871669493;1899.8860068395888;1930.2279088364662;8672.783180420485;9150.084991500864;9177.77055573611;9180.678676246333;9180.724578262663;7934.44458887878;8223.38324625654;8237.794055148624;8687.13128687131;8913.777155571113;2347.1784875293683;2402.9639555406598;2405.56699794037;2406.831521793475;2408.927732168038;2196.5826492966285;2406.9879650601724;2410.927672169838;2453.5706251406023;2456.778889899909;2081.157131361801;2227.7883601057874;2232.8660280383147;2364.988175059122;2446.804255659552;2424.248482970276;2454.791342735861;2455.1161581830524;2458.2748089313695;2460.987695061513;2423.854568725882;2449.204008697163;2457.4225057111566;2459.323685986368;2463.027104293794;8926.37515373924;9149.634014639407;9158.908410915872;9159.221466175382;9191.402558833654;5307.522322990911;5476.205950137208;5477.5070243677865;5479.506844383985;5488.670679759187;3178.6503484616674;3524.1542029912894;3614.548181477315;3739.9626003739886;3741.925161496782;1091.476091476096;1092.9398883061428;1100.2408338246585;1118.6476259978162;1119.770447058351;12094.395280236042;12190.81713774294;12192.939035304767;12195.45120469572;12214.145009849313;4740.715557066587;4813.711177329372;4817.867801066746;4927.236278376858;4944.456109827916;10221.182305415548;10232.59069637221;10238.59045638181;10239.283250172566;10240.436775977392;5467.917981230285;5471.37079235885;5471.8084867029465;5475.616706830563;5509.338879334506;4948.356713627278;4968.22992436173;4976.800927962913;4982.6512144149565;5004.149294619923;3996.080901392696;4000.7799571023875;4071.6539094176733;4098.836046558164;4112.424260603518;1307.078509650694;1307.9476820927057;1308.149702693257;1324.43711422645;1326.1645163546905;643.6492111799081;770.8283409218069;881.8897637795276;939.5208443693765;945.2937447906457;5955.821325360246;5990.251218597676;6031.095335699592;6063.181470501514;6101.420365065401;913.0641092879719;957.899420560845;963.2534785541261;977.154761131616;1003.7390278527636;3370.5112758649857;3753.11801726594;3784.829682664287;3949.4865667463046;4163.708540402143;10770.353778773298;11138.49876755548;11164.274322169033;11176.994070533528;11241.943790280997;11078.667639970814;11079.778404431867;11087.667369978752;11087.944560277147;11096;6538.705758240891;8241.175882411831;8265.256126948483;8357.707480238163;8399.999999999878;5912.408759124053;5941.346451890202;6012.8797424052145;6104.694765261808;6173.135760993375;9914.30599858032;10157;10377.481125943521;10455.68632941013;10458.111060559937;10617.1506279499;10636.468176590985;10637.680869573926;10644.604963883374;10644.946775266384;7695.115061767969;7696.114946780968;7887.84224315522;7889.487183333065;7900.249476299742;8421.24208821209;8488.10874858131;8495.95752021236;8569.143085691381;8597.097304783158;7644.464887458047;7697.615119243904;7731.884021739791;7743.109542402696;7940.126586075412;7488.625568721651;7506.587137707478;7541.132769731551;7566.772996810105;7667.884981725167;7095.929040709527;7246.058012458347;7249.311315425026;7252.818679533054;7257.419406447577;5005.549500544968;5013.623978201576;5059.544640982329;5076.7207803571155;5098.592112631055;4414.713043652152;5076.492350764894;5101.540861322499;5210.296609957607;5230.947690523046 13:13:07 INFO - PROCESS | 1959 | |4;prototype.html;298.50895277268893;303.7676177724041;312.10426077158553;314.15492325644004;314.69160222981475;5314.681119132854;5549.306336707911;5560.277163968689;5598.63608865424;5664.546836253095;5331.386890507592;5454.509094181523;5465.207544905987;5493.285872836525;5535.723213839312;3831.386978083507;3857.3828187490008;4256.361545768129;4257.126439653237;4269.444972153624;3441.4321636929876;4246.617804397603;4271.807768650403;4293.184294983943;4309.870703878889;4216.451861258032;4221.585768767452;4240.469941257343;4259.829606815723;4269.167512335096;4198.9370159447635;4215.810288537024;4230.7038507304505;4232.280512312914;4233.809478573472;3201.943358691626;3618.5115009473648;3669.412893936984;3674.393725035366;3697.500837386945;4541.182587134314;5067.9239811402485;5435.9886841868765;5459;5501.559875210014;4904;4919.508049195088;4947.724046938412;4966.261808367079;4972.403311602595;5656.943430565683;5780.71096445176;5913.438223368773;5943.821685349447;5956.404359564052;3797.5063241778394;3858.0354911272184;4035.7376770509823;4073.5722749111214;4084.65280451162;6105.267367915834;6122.265328160604;6130.540209484307;6178.567500274982;6193.4425901669065;3864.42033694948;3878.1274213302345;4152.730072545275;4167.395727619478;4167.8332866685;3880.1075752577067;4177.979110104491;4216.7259128156575;4223.429836972031;4226.091390351089;4133.9793301033305;4911.607071434277;4921.384826896638;4922.187839006596;4932.679375840559;5145.099607568661;5928.7332070056955;5930.733117009745;5936.7328470218945;5947.524198064145;1297.8702129786946;1338.788396501168;1366.071071671273;1432.3196481671123;1441.819772528434;721.6319676964786;809.5304723260494;859.7705281447465;879.7712594725417;883.5245140615189;4216.494020717533;4591.724496530219;4603.976980115078;4612.169809434267;4641.6518761092375;4194.706370554093;4538.636909047268;4880.731559764247;5019.447860735316;5064.645474816727;3909.4917660703927;4426.822927082945;4450.732956022649;4577.267637178035;4582.885427864263;2165.6318425867325;2252.583272094635;2411.481531470742;2680.4267902813126;2687.8924843006453;4480.171168333869;4772.665913386029;5158.174692049254;5213.322268105122;5223.895522089537;4707.105649926503;5023.949760502422;5078.822241221614;5124.282600435942;5149.356330458692;5401.756920938567;6349.68251587428;6397.45621622158;6403.871922561522;6417.2299324081405;5022.4977502249485;5069.88462538241;6188.4739797117745;6195.411435913581;6207.765204526458;4782.760861956958;5280.524752772269;5639.6334238274385;6074.420650630779;6177.938220617736;5536.394445610727;6304.71628776697;6319.842003949938;6323.336049714898;6327.240731112296;3779.848806047837;3895.8831235062994;3914.9804250978564;3925.4896863407575;3968.265870813909;5466.032228397853;5723.027085395576;6038.9165737820385;6062.636241825505;6097;5658.434156584309;5831.533477321889;5906.822795316148;5908.527317814651;5910.876933382644;5522.355245537926;5852.824415267549;5899.643082091057;5959;6011.489023433057;5455.563554915518;5763.164341170591;5765.769369225184;5766.971165144148;5822.427944454888;4919.778609962632;5067.36336252325;5169.974150129226;5397.8110766123;5505.587080968863;5072.746362681925;5787.334456537384;5787.479126878601;5793.797217097382;5797.2173756542325 13:13:07 INFO - PROCESS | 1959 | |5;yui.html;712.1952194020756;717.974870879519;765.0903881167235;786.1745167574046;805.4482679364636;15033.924830375847;15711.685766284667;16307;16345.918270408662;16395.67208655826;14907.478238261663;14922.179280139588;14925.925370373134;15163.848361516382;15184.240787960585;682.2086379799433;840.7729912923522;867.9826403471927;871.1636828644508;872.2542226396434;691.1636919327619;700.3941590524211;852.9402941794077;871.5511511571545;881.6253092435721;917.3440989692368;920.2178148573726;921;921.6037104045258;922.446532080753;713.636045616734;910.8451563234199;912.4297314178639;912.6851236323424;914.4787471141452;547.1819629653693;552.4696291560067;552.5358698693117;553.2033871225423;650.9414152726278;15590.22048897562;15709.528714138594;15963.521094367188;15978.201089945573;15986.600334991603;13066.673333166651;14148;14277.214753188571;14282.571522854227;14360.856391436057;12307.876921230763;12493.475375445534;12500.249985000839;12695.984321254278;13348.99882508806;4572.1312950539295;4627.907441851178;4659.370984917026;4707.270373092176;4819.42166939966;116669;120637;123068;124452;125560;10624.096951759188;11104.222704410613;11184.720381990515;11303.208775385645;11434.828477572843;22479.100835966707;22715.886420567793;22897.542049159256;23097.769022309898;23137;8042.638081286356;8098.830479383744;8198.262156405952;8285.25432711059;8359.456635318686;3974.682025437958;4269.701120921506;4400.44994375703;4549.112922979987;4550.977245113753;3436.8281585921104;3550.840212190458;3553.09396103997;3554.4845997330244;3554.9466757998653;638.0939066525544;645.2676212498753;654.3881470824793;658.9127938900756;661.6823924516259;524.4781442464772;619.553921176761;621.5555877547575;634.5336177909234;635.6503922842418;8698.782170496135;9198.540072996324;9252.352335336596;9254.4910029949;9334;608.1334098909036;611.1779656362186;620.3579295429209;632.2602555010649;639.8912184928573;4214.494260688737;4498;4504.864854054384;4550.226461501553;4594.724316541018;146207;147595.52404476033;156943;159292;166330;134751;138153;142075.28962355328;144222.557774423;144258;102539.48730256301;116211.99999999831;118411;119119;119890;9166.908330916605;9790.410850253671;9817.232375979112;10028.849567256351;10179.440130792582;56391.87216255734;60022.79954400975;61404.07893881506;62323.376766233574;63515.6824215876;66851.66574167098;78490;83865.58067209624;90760.54619726859;91556.08443915742;11046.116310694964;11318.151138664469;11378.54485820558;11488.770224595293;12897.742045158857;13703.314834258048;14139.293035348397;14402.639934001734;14796.852031479548;15694.450694225647;11815.586454474053;13305.800412994007;14100.224487653277;14119.43522259098;14449.133052016912;12480.875191247971;13492.86507134916;13624.250666213453;14243;14476.782848257495;12734.554290599785;13700.93149534246;14494.710105798036;14501.564953051426;14523.201223932785;10712;11232.382218978035;11840.407979600814;12103.394830258629;12126.818097728717;9403.388779729295;10302.024825600984;10862.340475208717;11484.540618375171;11744.177907546731 13:13:07 INFO - PROCESS | 1959 | __end_tp_report 13:13:07 INFO - PROCESS | 1959 | __start_cc_report 13:13:07 INFO - PROCESS | 1959 | _x_x_mozilla_cycle_collect,1241 13:13:07 INFO - PROCESS | 1959 | __end_cc_report 13:13:07 INFO - PROCESS | 1959 | __startTimestamp1475007187057__endTimestamp 13:13:07 INFO - PROCESS | 1959 | 13:13:07 INFO - PROCESS | 1959 | ------- Summary: start ------- 13:13:07 INFO - PROCESS | 1959 | Number of tests: 6 13:13:07 INFO - PROCESS | 1959 | 13:13:07 INFO - PROCESS | 1959 | [#0] dojo.html Cycles:165 Average:5758.55 Median:6045.76 stddev:652.73 (10.8%) stddev-sans-first:612.77 13:13:07 INFO - PROCESS | 1959 | Values: 2823.4 3275.8 3290.4 3333.4 3344.6 5641.1 5673.9 5742.9 5752.1 5763.1 5632.9 5676.6 5703.3 5727.7 5781.4 5125.8 5149.6 5154.3 5163.8 5243.4 5173.7 5207.0 5213.6 5293.8 5296.4 5290.6 5297.6 5306.2 5306.8 5344.6 5261.1 5276.5 5299.5 5333.4 5376.4 5194.4 5301.0 5308.1 5317.9 5343.2 5583.2 5664.2 5673.7 5868.9 5871.0 6126.9 6182.5 6201.3 6255.0 6261.4 6253.2 6254.7 6284.1 6296.4 6308.3 5719.7 5788.4 5917.1 5951.3 5956.5 6149.4 6199.9 6207.7 6223.6 6254.6 6194.3 6208.6 6212.2 6215.2 6234.5 4713.5 5245.5 6210.7 6247.8 6278.7 6092.1 6133.2 6145.5 6203.8 6205.4 6140.9 6206.0 6211.5 6213.7 6214.5 4962.6 4963.8 4968.6 4968.8 4992.7 4434.2 4445.0 4445.6 4445.6 4476.1 5622.7 5672.8 5714.7 5826.9 5853.4 6222.5 6258.1 6264.7 6266.1 6271.5 5886.6 5905.9 5906.7 5920.6 5957.8 5361.3 5399.0 5458.2 5477.6 5487.8 6178.6 6215.4 6238.9 6244.3 6254.8 6222.7 6229.8 6233.0 6249.1 6255.3 6245.6 6245.8 6301.0 6311.3 6320.6 6071.8 6117.8 6119.0 6126.0 6241.8 6145.4 6198.7 6243.7 6244.8 6252.1 6100.2 6162.8 6171.4 6176.8 6191.5 6031.6 6087.4 6184.8 6190.2 6213.1 5993.1 6016.5 6045.8 6078.6 6122.7 6213.5 6221.9 6233.1 6239.4 6241.8 5901.5 5999.6 6085.4 6085.5 6106.0 13:13:07 INFO - PROCESS | 1959 | 13:13:07 INFO - PROCESS | 1959 | [#1] ext.html Cycles:180 Average:69470.47 Median:38397.40 stddev:150806.73 (392.8%) stddev-sans-first:151140.82 13:13:07 INFO - PROCESS | 1959 | Values: 477.6 510.8 518.1 524.5 556.3 30369.2 40973.4 42480.0 42525.6 42602.1 43611.3 43901.1 43982.8 44001.3 44113.6 9644.0 9850.7 9868.2 9868.8 9875.7 8724.3 8952.3 8970.7 9079.6 9084.0 12026.4 12319.8 12331.6 12337.9 12344.6 11934.6 12028.9 12030.3 12043.3 12048.8 8639.4 8862.0 11902.9 11987.3 11994.0 40298.2 40669.4 40699.8 43093.8 43172.0 3395.7 3423.3 3427.5 3460.1 3702.0 29460.9 30408.7 31689.8 31838.5 32110.9 3124.3 3158.4 3170.6 3299.5 3413.6 526685.0 529076.0 531139.0 531708.0 532953.0 63206.0 63614.7 63646.0 63733.7 63737.7 65756.3 65935.0 65943.0 66021.7 66156.7 14710.5 17091.5 17321.3 17327.8 17353.9 13327.0 13378.7 13383.1 13383.2 13383.7 13020.9 13606.9 15328.6 17369.2 17723.5 5467.8 6298.8 6302.6 6345.2 6363.8 877.5 983.6 1032.7 1034.0 1073.9 28701.7 30238.8 30659.1 30714.1 31102.8 1089.5 1139.8 1141.3 1147.4 1203.2 15471.4 15785.7 15850.4 16109.4 16323.0 681226.0 684825.0 685982.0 688735.0 688991.0 49872.8 50640.0 57889.1 58773.7 59472.0 1341.0 1365.7 1393.6 1396.0 1399.6 30051.1 31696.0 32043.2 32248.8 32354.5 51759.5 52338.7 52399.7 52428.5 52505.0 441395.0 452348.0 452894.0 453221.0 453273.0 26136.9 26378.9 26388.2 26416.2 26423.9 46607.3 46904.3 47187.5 47641.8 47810.5 38088.9 38390.0 38980.8 39501.4 40590.6 38404.8 38721.6 39148.8 39814.2 39958.2 36840.6 38179.6 38678.0 38841.8 38842.6 28198.0 32671.7 34383.1 34500.8 34540.5 20394.0 21386.5 22206.2 26227.6 26646.9 13:13:07 INFO - PROCESS | 1959 | 13:13:07 INFO - PROCESS | 1959 | [#2] jquery.html Cycles:180 Average:35829.18 Median:1583.59 stddev:104146.20 (6576.6%) stddev-sans-first:104404.29 13:13:07 INFO - PROCESS | 1959 | Values: 353.6 372.0 374.7 385.5 405.6 14892.8 15165.2 16752.0 20730.8 21276.7 20038.5 20413.8 20606.6 20818.9 21426.9 5991.4 6016.2 6138.6 6244.9 6252.2 5986.2 6165.0 6170.2 6171.6 6186.4 4174.5 4401.8 6226.7 6804.9 6868.7 6660.3 6752.5 6861.5 6919.3 6922.1 5956.3 5961.4 5962.6 5968.1 5976.9 25322.9 25332.0 25442.5 25570.8 26230.9 2375.7 2455.8 2493.3 2691.6 2813.6 15131.4 15796.5 15991.9 16546.5 16630.2 1872.5 1973.5 1976.3 1976.9 1981.5 116831.0 118228.4 118258.0 121482.4 121578.2 10761.7 10868.9 11269.9 11321.4 11389.7 12934.6 12972.2 13695.6 14022.3 14117.6 7766.1 8470.8 8547.5 8875.2 8913.0 7437.4 8108.4 8389.0 8933.2 8970.4 5625.9 6600.1 6732.5 6743.7 6883.2 1586.5 1664.6 1785.3 1802.5 1886.3 380.2 395.0 406.4 423.5 795.0 11212.7 11784.5 11797.3 11934.9 12203.2 427.7 437.8 439.9 441.2 443.0 5979.2 6053.5 6061.1 6152.9 6237.2 564850.0 613822.0 630849.0 649402.0 651269.0 138484.0 138756.0 138956.0 140500.0 142422.0 898.3 942.8 952.9 1032.0 1036.1 17492.7 19275.6 19810.1 19941.9 20352.6 55101.7 55637.0 56594.7 57169.7 57588.1 74757.6 74965.3 78198.0 78707.6 79396.2 5612.9 6813.6 7053.4 8046.8 8190.2 12151.1 12452.3 12800.6 12834.3 13022.9 10556.4 10696.3 10749.3 10762.6 10993.5 10489.6 10721.8 10796.5 10819.9 11116.7 9297.5 11020.6 11103.8 11458.0 11553.5 7234.6 7259.5 7299.6 7403.9 7453.8 10213.8 10857.5 11057.3 11065.0 11313.3 13:13:07 INFO - PROCESS | 1959 | 13:13:07 INFO - PROCESS | 1959 | [#3] mootools.html Cycles:180 Average:5863.90 Median:4946.41 stddev:3318.12 (67.1%) stddev-sans-first:3311.51 13:13:07 INFO - PROCESS | 1959 | Values: 1538.9 1547.5 1768.9 1899.9 1930.2 8672.8 9150.1 9177.8 9180.7 9180.7 7934.4 8223.4 8237.8 8687.1 8913.8 2347.2 2403.0 2405.6 2406.8 2408.9 2196.6 2407.0 2410.9 2453.6 2456.8 2081.2 2227.8 2232.9 2365.0 2446.8 2424.2 2454.8 2455.1 2458.3 2461.0 2423.9 2449.2 2457.4 2459.3 2463.0 8926.4 9149.6 9158.9 9159.2 9191.4 5307.5 5476.2 5477.5 5479.5 5488.7 3178.7 3524.2 3614.5 3740.0 3741.9 1091.5 1092.9 1100.2 1118.6 1119.8 12094.4 12190.8 12192.9 12195.5 12214.1 4740.7 4813.7 4817.9 4927.2 4944.5 10221.2 10232.6 10238.6 10239.3 10240.4 5467.9 5471.4 5471.8 5475.6 5509.3 4948.4 4968.2 4976.8 4982.7 5004.1 3996.1 4000.8 4071.7 4098.8 4112.4 1307.1 1307.9 1308.1 1324.4 1326.2 643.6 770.8 881.9 939.5 945.3 5955.8 5990.3 6031.1 6063.2 6101.4 913.1 957.9 963.3 977.2 1003.7 3370.5 3753.1 3784.8 3949.5 4163.7 10770.4 11138.5 11164.3 11177.0 11241.9 11078.7 11079.8 11087.7 11087.9 11096.0 6538.7 8241.2 8265.3 8357.7 8400.0 5912.4 5941.3 6012.9 6104.7 6173.1 9914.3 10157.0 10377.5 10455.7 10458.1 10617.2 10636.5 10637.7 10644.6 10644.9 7695.1 7696.1 7887.8 7889.5 7900.2 8421.2 8488.1 8496.0 8569.1 8597.1 7644.5 7697.6 7731.9 7743.1 7940.1 7488.6 7506.6 7541.1 7566.8 7667.9 7095.9 7246.1 7249.3 7252.8 7257.4 5005.5 5013.6 5059.5 5076.7 5098.6 4414.7 5076.5 5101.5 5210.3 5230.9 13:13:07 INFO - PROCESS | 1959 | 13:13:07 INFO - PROCESS | 1959 | [#4] prototype.html Cycles:180 Average:4622.43 Median:5023.22 stddev:1452.22 (28.9%) stddev-sans-first:1419.56 13:13:07 INFO - PROCESS | 1959 | Values: 298.5 303.8 312.1 314.2 314.7 5314.7 5549.3 5560.3 5598.6 5664.5 5331.4 5454.5 5465.2 5493.3 5535.7 3831.4 3857.4 4256.4 4257.1 4269.4 3441.4 4246.6 4271.8 4293.2 4309.9 4216.5 4221.6 4240.5 4259.8 4269.2 4198.9 4215.8 4230.7 4232.3 4233.8 3201.9 3618.5 3669.4 3674.4 3697.5 4541.2 5067.9 5436.0 5459.0 5501.6 4904.0 4919.5 4947.7 4966.3 4972.4 5656.9 5780.7 5913.4 5943.8 5956.4 3797.5 3858.0 4035.7 4073.6 4084.7 6105.3 6122.3 6130.5 6178.6 6193.4 3864.4 3878.1 4152.7 4167.4 4167.8 3880.1 4178.0 4216.7 4223.4 4226.1 4134.0 4911.6 4921.4 4922.2 4932.7 5145.1 5928.7 5930.7 5936.7 5947.5 1297.9 1338.8 1366.1 1432.3 1441.8 721.6 809.5 859.8 879.8 883.5 4216.5 4591.7 4604.0 4612.2 4641.7 4194.7 4538.6 4880.7 5019.4 5064.6 3909.5 4426.8 4450.7 4577.3 4582.9 2165.6 2252.6 2411.5 2680.4 2687.9 4480.2 4772.7 5158.2 5213.3 5223.9 4707.1 5023.9 5078.8 5124.3 5149.4 5401.8 6349.7 6397.5 6403.9 6417.2 5022.5 5069.9 6188.5 6195.4 6207.8 4782.8 5280.5 5639.6 6074.4 6177.9 5536.4 6304.7 6319.8 6323.3 6327.2 3779.8 3895.9 3915.0 3925.5 3968.3 5466.0 5723.0 6038.9 6062.6 6097.0 5658.4 5831.5 5906.8 5908.5 5910.9 5522.4 5852.8 5899.6 5959.0 6011.5 5455.6 5763.2 5765.8 5767.0 5822.4 4919.8 5067.4 5170.0 5397.8 5505.6 5072.7 5787.3 5787.5 5793.8 5797.2 13:13:07 INFO - PROCESS | 1959 | 13:13:07 INFO - PROCESS | 1959 | [#5] yui.html Cycles:180 Average:25677.17 Median:13286.91 stddev:41700.01 (313.8%) stddev-sans-first:41774.86 13:13:07 INFO - PROCESS | 1959 | Values: 712.2 718.0 765.1 786.2 805.4 15033.9 15711.7 16307.0 16345.9 16395.7 14907.5 14922.2 14925.9 15163.8 15184.2 682.2 840.8 868.0 871.2 872.3 691.2 700.4 852.9 871.6 881.6 917.3 920.2 921.0 921.6 922.4 713.6 910.8 912.4 912.7 914.5 547.2 552.5 552.5 553.2 650.9 15590.2 15709.5 15963.5 15978.2 15986.6 13066.7 14148.0 14277.2 14282.6 14360.9 12307.9 12493.5 12500.2 12696.0 13349.0 4572.1 4627.9 4659.4 4707.3 4819.4 116669.0 120637.0 123068.0 124452.0 125560.0 10624.1 11104.2 11184.7 11303.2 11434.8 22479.1 22715.9 22897.5 23097.8 23137.0 8042.6 8098.8 8198.3 8285.3 8359.5 3974.7 4269.7 4400.4 4549.1 4551.0 3436.8 3550.8 3553.1 3554.5 3554.9 638.1 645.3 654.4 658.9 661.7 524.5 619.6 621.6 634.5 635.7 8698.8 9198.5 9252.4 9254.5 9334.0 608.1 611.2 620.4 632.3 639.9 4214.5 4498.0 4504.9 4550.2 4594.7 146207.0 147595.5 156943.0 159292.0 166330.0 134751.0 138153.0 142075.3 144222.6 144258.0 102539.5 116212.0 118411.0 119119.0 119890.0 9166.9 9790.4 9817.2 10028.8 10179.4 56391.9 60022.8 61404.1 62323.4 63515.7 66851.7 78490.0 83865.6 90760.5 91556.1 11046.1 11318.2 11378.5 11488.8 12897.7 13703.3 14139.3 14402.6 14796.9 15694.5 11815.6 13305.8 14100.2 14119.4 14449.1 12480.9 13492.9 13624.3 14243.0 14476.8 12734.6 13700.9 14494.7 14501.6 14523.2 10712.0 11232.4 11840.4 12103.4 12126.8 9403.4 10302.0 10862.3 11484.5 11744.2 13:13:07 INFO - PROCESS | 1959 | -------- Summary: end -------- 13:13:07 INFO - PROCESS | 1959 | 13:13:07 INFO - TEST-INFO | 1959: exit 0 13:13:07 INFO - TEST-OK | dromaeo_css | took 1116469ms 13:13:07 INFO - TEST-START | kraken 13:13:07 INFO - operating with platform_type : mac_ 13:13:07 INFO - Initialising browser for kraken test... 13:13:07 INFO - TEST-INFO | started process 1962 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmpcvjWni/profile http://localhost:54465/getInfo.html) 13:13:10 INFO - PROCESS | 1962 | __metrics Screen width/height:1600/1200 13:13:10 INFO - PROCESS | 1962 | colorDepth:24 13:13:10 INFO - PROCESS | 1962 | Browser inner width/height: 1024/689 13:13:10 INFO - PROCESS | 1962 | __metrics 13:13:10 INFO - PROCESS | 1962 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:13:10 INFO - PROCESS | 1962 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:13:10 INFO - TEST-INFO | 1962: exit 0 13:13:10 INFO - Browser initialized. 13:13:10 INFO - Running cycle 1/1 for kraken test... 13:13:10 INFO - TEST-INFO | started process 1963 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmpcvjWni/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:13:23 INFO - PROCESS | 1963 | RSS: Main: 219066368 13:13:23 INFO - PROCESS | 1963 | 13:13:25 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54465/tests/kraken/driver.html?testName=audio-beat-detection) 13:13:26 INFO - PROCESS | 1963 | RSS: Main: 268570624 13:13:26 INFO - PROCESS | 1963 | 13:13:29 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54465/tests/kraken/driver.html?testName=audio-dft) 13:13:29 INFO - PROCESS | 1963 | RSS: Main: 280559616 13:13:29 INFO - PROCESS | 1963 | 13:13:32 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54465/tests/kraken/driver.html?testName=audio-fft) 13:13:33 INFO - PROCESS | 1963 | RSS: Main: 378011648 13:13:33 INFO - PROCESS | 1963 | 13:13:35 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54465/tests/kraken/driver.html?testName=audio-oscillator) 13:13:36 INFO - PROCESS | 1963 | RSS: Main: 279302144 13:13:36 INFO - PROCESS | 1963 | 13:13:38 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54465/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:13:38 INFO - PROCESS | 1963 | RSS: Main: 280518656 13:13:38 INFO - PROCESS | 1963 | 13:13:41 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54465/tests/kraken/driver.html?testName=imaging-darkroom) 13:13:42 INFO - PROCESS | 1963 | RSS: Main: 317587456 13:13:42 INFO - PROCESS | 1963 | 13:13:45 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54465/tests/kraken/driver.html?testName=imaging-desaturate) 13:13:45 INFO - PROCESS | 1963 | RSS: Main: 317960192 13:13:45 INFO - PROCESS | 1963 | 13:13:48 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54465/tests/kraken/driver.html?testName=json-parse-financial) 13:13:49 INFO - PROCESS | 1963 | RSS: Main: 315916288 13:13:49 INFO - PROCESS | 1963 | 13:13:50 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54465/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:13:51 INFO - PROCESS | 1963 | RSS: Main: 288915456 13:13:51 INFO - PROCESS | 1963 | 13:13:53 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54465/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:13:53 INFO - PROCESS | 1963 | RSS: Main: 295387136 13:13:53 INFO - PROCESS | 1963 | 13:13:55 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54465/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:13:56 INFO - PROCESS | 1963 | RSS: Main: 303288320 13:13:56 INFO - PROCESS | 1963 | 13:13:59 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:13:59 INFO - PROCESS | 1963 | RSS: Main: 317763584 13:13:59 INFO - PROCESS | 1963 | 13:14:02 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:14:03 INFO - PROCESS | 1963 | RSS: Main: 309895168 13:14:03 INFO - PROCESS | 1963 | 13:14:05 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54465/tests/kraken/driver.html?testName=ai-astar) 13:14:05 INFO - PROCESS | 1963 | RSS: Main: 353374208 13:14:05 INFO - PROCESS | 1963 | 13:14:05 INFO - PROCESS | 1963 | __start_tp_report 13:14:05 INFO - PROCESS | 1963 | _x_x_mozilla_page_load 13:14:05 INFO - PROCESS | 1963 | _x_x_mozilla_page_load_details 13:14:05 INFO - PROCESS | 1963 | |i|pagename|runs| 13:14:05 INFO - PROCESS | 1963 | |0;ai-astar;115;115;115;114;115;114;114;115;114;113 13:14:05 INFO - PROCESS | 1963 | |1;audio-beat-detection;146;110;110;146;103;109;109;109;134;107 13:14:05 INFO - PROCESS | 1963 | |2;audio-dft;185;184;184;187;184;181;184;183;185;186 13:14:05 INFO - PROCESS | 1963 | |3;audio-fft;81;59;75;113;77;57;57;58;82;58 13:14:05 INFO - PROCESS | 1963 | |4;audio-oscillator;83;70;99;72;68;69;91;68;68;89 13:14:05 INFO - PROCESS | 1963 | |5;imaging-gaussian-blur;87;84;92;130;87;84;88;84;87;84 13:14:05 INFO - PROCESS | 1963 | |6;imaging-darkroom;93;94;94;95;95;94;95;94;95;94 13:14:05 INFO - PROCESS | 1963 | |7;imaging-desaturate;84;85;83;85;84;86;85;86;86;86 13:14:05 INFO - PROCESS | 1963 | |8;json-parse-financial;56;55;53;52;55;58;57;56;56;56 13:14:05 INFO - PROCESS | 1963 | |9;json-stringify-tinderbox;67;74;66;77;71;69;71;70;71;74 13:14:05 INFO - PROCESS | 1963 | |10;stanford-crypto-aes;83;85;86;83;80;83;86;89;89;111 13:14:05 INFO - PROCESS | 1963 | |11;stanford-crypto-ccm;132;136;135;133;133;134;137;136;140;139 13:14:05 INFO - PROCESS | 1963 | |12;stanford-crypto-pbkdf2;154;169;215;152;205;208;164;162;161;163 13:14:05 INFO - PROCESS | 1963 | |13;stanford-crypto-sha256-iterative;65;69;64;85;66;67;69;66;66;67 13:14:05 INFO - PROCESS | 1963 | __end_tp_report 13:14:05 INFO - PROCESS | 1963 | __start_cc_report 13:14:05 INFO - PROCESS | 1963 | _x_x_mozilla_cycle_collect,1981 13:14:05 INFO - PROCESS | 1963 | __end_cc_report 13:14:05 INFO - PROCESS | 1963 | __startTimestamp1475007245571__endTimestamp 13:14:05 INFO - PROCESS | 1963 | 13:14:05 INFO - PROCESS | 1963 | ------- Summary: start ------- 13:14:05 INFO - PROCESS | 1963 | Number of tests: 14 13:14:05 INFO - PROCESS | 1963 | 13:14:05 INFO - PROCESS | 1963 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 13:14:05 INFO - PROCESS | 1963 | Values: 115.0 115.0 115.0 114.0 115.0 114.0 114.0 115.0 114.0 113.0 13:14:05 INFO - PROCESS | 1963 | 13:14:05 INFO - PROCESS | 1963 | [#1] audio-beat-detection Cycles:10 Average:118.30 Median:110.00 stddev:16.80 (15.3%) stddev-sans-first:14.52 13:14:05 INFO - PROCESS | 1963 | Values: 146.0 110.0 110.0 146.0 103.0 109.0 109.0 109.0 134.0 107.0 13:14:05 INFO - PROCESS | 1963 | 13:14:05 INFO - PROCESS | 1963 | [#2] audio-dft Cycles:10 Average:184.30 Median:184.50 stddev:1.64 (0.9%) stddev-sans-first:1.72 13:14:05 INFO - PROCESS | 1963 | Values: 185.0 184.0 184.0 187.0 184.0 181.0 184.0 183.0 185.0 186.0 13:14:05 INFO - PROCESS | 1963 | 13:14:05 INFO - PROCESS | 1963 | [#3] audio-fft Cycles:10 Average:71.70 Median:67.00 stddev:17.97 (26.8%) stddev-sans-first:18.74 13:14:05 INFO - PROCESS | 1963 | Values: 81.0 59.0 75.0 113.0 77.0 57.0 57.0 58.0 82.0 58.0 13:14:05 INFO - PROCESS | 1963 | 13:14:05 INFO - PROCESS | 1963 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:77.50 stddev:11.72 (15.1%) stddev-sans-first:12.27 13:14:05 INFO - PROCESS | 1963 | Values: 83.0 70.0 99.0 72.0 68.0 69.0 91.0 68.0 68.0 89.0 13:14:05 INFO - PROCESS | 1963 | 13:14:05 INFO - PROCESS | 1963 | [#5] imaging-gaussian-blur Cycles:10 Average:90.70 Median:87.00 stddev:14.04 (16.1%) stddev-sans-first:14.83 13:14:05 INFO - PROCESS | 1963 | Values: 87.0 84.0 92.0 130.0 87.0 84.0 88.0 84.0 87.0 84.0 13:14:05 INFO - PROCESS | 1963 | 13:14:05 INFO - PROCESS | 1963 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.50 stddev:0.67 (0.7%) stddev-sans-first:0.53 13:14:05 INFO - PROCESS | 1963 | Values: 93.0 94.0 94.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 13:14:05 INFO - PROCESS | 1963 | 13:14:05 INFO - PROCESS | 1963 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.50 stddev:1.05 (1.2%) stddev-sans-first:1.05 13:14:05 INFO - PROCESS | 1963 | Values: 84.0 85.0 83.0 85.0 84.0 86.0 85.0 86.0 86.0 86.0 13:14:05 INFO - PROCESS | 1963 | 13:14:05 INFO - PROCESS | 1963 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:1.78 (3.2%) stddev-sans-first:1.87 13:14:05 INFO - PROCESS | 1963 | Values: 56.0 55.0 53.0 52.0 55.0 58.0 57.0 56.0 56.0 56.0 13:14:05 INFO - PROCESS | 1963 | 13:14:05 INFO - PROCESS | 1963 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.00 stddev:3.33 (4.7%) stddev-sans-first:3.21 13:14:05 INFO - PROCESS | 1963 | Values: 67.0 74.0 66.0 77.0 71.0 69.0 71.0 70.0 71.0 74.0 13:14:05 INFO - PROCESS | 1963 | 13:14:05 INFO - PROCESS | 1963 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:85.50 stddev:8.72 (10.2%) stddev-sans-first:9.10 13:14:05 INFO - PROCESS | 1963 | Values: 83.0 85.0 86.0 83.0 80.0 83.0 86.0 89.0 89.0 111.0 13:14:05 INFO - PROCESS | 1963 | 13:14:05 INFO - PROCESS | 1963 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:136.00 stddev:2.64 (1.9%) stddev-sans-first:2.47 13:14:05 INFO - PROCESS | 1963 | Values: 132.0 136.0 135.0 133.0 133.0 134.0 137.0 136.0 140.0 139.0 13:14:05 INFO - PROCESS | 1963 | 13:14:05 INFO - PROCESS | 1963 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:166.50 stddev:24.09 (14.5%) stddev-sans-first:24.29 13:14:05 INFO - PROCESS | 1963 | Values: 154.0 169.0 215.0 152.0 205.0 208.0 164.0 162.0 161.0 163.0 13:14:05 INFO - PROCESS | 1963 | 13:14:05 INFO - PROCESS | 1963 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:67.00 stddev:6.04 (9.0%) stddev-sans-first:6.28 13:14:05 INFO - PROCESS | 1963 | Values: 65.0 69.0 64.0 85.0 66.0 67.0 69.0 66.0 66.0 67.0 13:14:05 INFO - PROCESS | 1963 | -------- Summary: end -------- 13:14:05 INFO - PROCESS | 1963 | 13:14:06 INFO - TEST-INFO | 1963: exit 0 13:14:06 INFO - TEST-OK | kraken | took 58714ms 13:14:06 INFO - SUITE-END | took 1175s 13:14:06 INFO - Completed test suite (00:19:35) 13:14:06 INFO - javascript benchmark 13:14:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2823.3929705113396, 3275.83620818959, 3290.3912776136403, 3333.4166520858844, 3344.6488118747516, 5641.125625528045, 5673.943260567393, 5742.913856292159, 5752.079667253241, 5763.10671845864, 5632.859178520539, 5676.602637815345, 5703.3441154267275, 5727.742251598677, 5781.39295373986, 5125.82059627914, 5149.613778966574, 5154.304168937202, 5163.81926632568, 5243.370795504545, 5173.741312934357, 5207.010667973092, 5213.582913366921, 5293.841184764444, 5296.390915044781, 5290.576753859682, 5297.576193904479, 5306.177542480922, 5306.840794776143, 5344.625876188668, 5261.0793111205385, 5276.525112739833, 5299.54953828925, 5333.4399888011785, 5376.4085950545405, 5194.428612852583, 5301.0, 5308.097623403992, 5317.893642127175, 5343.225232341328, 5583.162525621149, 5664.20701101846, 5673.716314184274, 5868.9413105868825, 5871.031279838821, 6126.853582554517, 6182.474489668383, 6201.286852011986, 6255.030470277069, 6261.405166509175, 6253.249610046778, 6254.718537665816, 6284.088807122987, 6296.401841825019, 6308.2745484269435, 5719.7140142992685, 5788.392218817048, 5917.053271476543, 5951.345352011362, 5956.463918247378, 6149.446549810538, 6199.876002479925, 6207.720652570645, 6223.626582405071, 6254.593451425642, 6194.34959329273, 6208.565400422018, 6212.161358216673, 6215.223097112861, 6234.470070044006, 4713.457952335525, 5245.475452454801, 6210.689465526705, 6247.843803904848, 6278.6860656966965, 6092.055731361646, 6133.248135464543, 6145.525073982301, 6203.844903877439, 6205.379462053758, 6140.881395918401, 6205.9760139577365, 6211.534134939898, 6213.689315534296, 6214.502839772807, 4962.60299176065, 4963.801447942042, 4968.552830245295, 4968.801247950041, 4992.700437973734, 4434.246178149658, 4444.9776551392715, 4445.555444455593, 4445.644348452116, 4476.149531588988, 5622.746976386073, 5672.829815105553, 5714.685692286881, 5826.883462330729, 5853.414658534112, 6222.502199824004, 6258.061290806416, 6264.686765661699, 6266.122742816009, 6271.4669253114, 5886.558508111909, 5905.940940590625, 5906.704664766745, 5920.585559010914, 5957.821265362046, 5361.27622770921, 5399.0, 5458.181272809111, 5477.561795056386, 5487.807926722546, 6178.598391104564, 6215.409536094064, 6238.937610623836, 6244.313125556185, 6254.8123556294295, 6222.657753823583, 6229.844253893689, 6233.0, 6249.093881387264, 6255.280642725963, 6245.5628106032145, 6245.750169993149, 6301.023341382093, 6311.305756366704, 6320.557560970872, 6071.757129714939, 6117.755289788359, 6118.990366589463, 6125.998614523495, 6241.812745617639, 6145.35473775265, 6198.659073750807, 6243.719032643633, 6244.812655620339, 6252.09344645033, 6100.23747031621, 6162.753489860355, 6171.352008039091, 6176.81469555914, 6191.473724733448, 6031.638101713911, 6087.421694938974, 6184.752609895734, 6190.1952746142715, 6213.068039794067, 5993.101034844808, 6016.548758843017, 6045.75816967334, 6078.574499784972, 6122.6938653068055, 6213.471854892385, 6221.875562488815, 6233.127362169391, 6239.407256310643, 6241.78153764616, 5901.527877769854, 5999.5500337473995, 6085.361037091218, 6085.4523092921845, 6106.023036314168], "value": 5714.937270046578, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.615519506797, 510.77015343095593, 518.0829931022091, 524.4860037163578, 556.3462931056008, 30369.240768980788, 40973.385399219, 42480.0, 42525.574744252546, 42602.14795704084, 43611.3458298125, 43901.12197756043, 43982.78008609961, 44001.33997990024, 44113.558864411345, 9643.951780241088, 9850.655227067055, 9868.161206297473, 9868.753281167956, 9875.70372888811, 8724.302055835518, 8952.283817294634, 8970.686025989091, 9079.636814527412, 9084.000759916404, 12026.398680066006, 12319.815202771966, 12331.568395106173, 12337.93831030848, 12344.62966111018, 11934.582289619864, 12028.939855300667, 12030.33833139177, 12043.27740335574, 12048.819267710991, 8639.43843650167, 8862.0, 11902.88097119035, 11987.280763154238, 11994.040476761926, 40298.19403611941, 40669.389959150634, 40699.796501017605, 43093.784531077144, 43172.0, 3395.6604339566093, 3423.2639982403653, 3427.4687423449404, 3460.1003739028033, 3701.9814900925594, 29460.852695736383, 30408.69591304103, 31689.798509905915, 31838.522422163685, 32110.87611933571, 3124.297033167542, 3158.3999040182293, 3170.6036745406823, 3299.5050742388594, 3413.573303337083, 526685.0, 529076.0, 531139.0, 531708.0, 532953.0, 63206.0, 63614.681926590994, 63646.0, 63733.72532549323, 63737.68131159314, 65756.34243657599, 65935.0, 65943.0, 66021.66989165024, 66156.66921665361, 14710.485133020293, 17091.48725538236, 17321.307147714204, 17327.826721732872, 17353.913230433765, 13327.0, 13378.732425351438, 13383.130096543693, 13383.197008179346, 13383.732325353438, 13020.89322407587, 13606.863931360758, 15328.616784580474, 17369.2183851727, 17723.46829595114, 5467.835964921059, 6298.842528936813, 6302.590331628429, 6345.206849143857, 6363.809085727436, 877.526135886614, 983.5721461164273, 1032.6540608895955, 1033.963811266602, 1073.9248252622242, 28701.712982869903, 30238.84880575627, 30659.080227593207, 30714.078577642707, 31102.844485777878, 1089.515165751233, 1139.794836929344, 1141.3209140561353, 1147.3746807989667, 1203.151777996528, 15471.381144754308, 15785.68428631421, 15850.365985360457, 16109.436169734237, 16323.020618762912, 681226.0, 684825.0, 685982.0, 688735.0, 688991.0, 49872.75063624659, 50640.0, 57889.13166302509, 58773.706131469924, 59472.0, 1340.9865901341057, 1365.7473367427058, 1393.6167553922346, 1395.9948836837664, 1399.6290982889543, 30051.05325408295, 31696.0, 32043.239358596515, 32248.83875580607, 32354.514682280256, 51759.482405176976, 52338.73830630975, 52399.73800131128, 52428.47571524236, 52505.0, 441395.0, 452348.0, 452894.0, 453221.0, 453273.0, 26136.8693156533, 26378.86810565935, 26388.208353749418, 26416.207513774618, 26423.943042278093, 46607.30089048599, 46904.29643555281, 47187.52812471968, 47641.761791190824, 47810.521894781996, 38088.857334280015, 38390.0, 38980.80509597434, 39501.40747888727, 40590.59409405986, 38404.80797595994, 38721.6127838718, 39148.80425597854, 39814.2037159261, 39958.2008359837, 36840.63159368479, 38179.61820381872, 38678.0, 38841.805790971994, 38842.61157388503, 28198.0, 32671.673283266864, 34383.14042148966, 34500.82749586236, 34540.48189277213, 20394.0, 21386.465338366666, 22206.222782202545, 26227.60658590161, 26646.934122635652], "value": 20235.78767356196, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.59513357205986, 371.9907002324942, 374.69979172272224, 385.5219527785546, 405.6450605719995, 14892.77660835087, 15165.241737913102, 16751.999999999985, 20730.792692073075, 21276.680849787266, 20038.499037524034, 20413.775173489565, 20606.587868242663, 20818.89590552045, 21426.89286553565, 5991.430814072667, 6016.157737916695, 6138.600990935597, 6244.906326405107, 6252.218472690914, 5986.191864098335, 6165.044418115177, 6170.1670274513035, 6171.567990240685, 6186.381361863822, 4174.519930208035, 4401.789507885325, 6226.688665566726, 6804.863902721942, 6868.690908909111, 6660.300668429793, 6752.527323087385, 6861.519693621449, 6919.342662447085, 6922.06552115463, 5956.315023772278, 5961.374055724174, 5962.5528085393335, 5968.134620480006, 5976.880462390772, 25322.87338563314, 25332.0, 25442.491150177077, 25570.849311781014, 26230.86884565584, 2375.7267914189915, 2455.7667021633097, 2493.30187547487, 2691.609716591103, 2813.5779633055, 15131.394744210218, 15796.526104216891, 15991.92004039984, 16546.503604891754, 16630.168491575372, 1872.5318670332417, 1973.4671638657483, 1976.3379267945256, 1976.8616196866226, 1981.504623844039, 116831.0, 118228.40885795516, 118258.0, 121482.39258803737, 121578.17632735516, 10761.677149685365, 10868.891311086945, 11269.94365028186, 11321.377324247082, 11389.715257118472, 12934.611961641165, 12972.156809807333, 13695.589132326046, 14022.298885055707, 14117.647058823612, 7766.145723970359, 8470.788230294293, 8547.487150770974, 8875.201231889161, 8913.019567847532, 7437.367823734935, 8108.39187060961, 8388.951381077366, 8933.19601235892, 8970.37207395476, 5625.943740562624, 6600.141981542369, 6732.495062870206, 6743.730250790011, 6883.174019117738, 1586.4526738275276, 1664.625459271654, 1785.3215778004535, 1802.4862914069427, 1886.3114963038392, 380.1920918049146, 395.0479344779126, 406.37215502048815, 423.4748911349904, 794.9705131854263, 11212.719682008015, 11784.469698863571, 11797.29216247028, 11934.940325298317, 12203.20679155852, 427.74976638666107, 437.8445651793631, 439.89222640453295, 441.15298626636934, 442.9579189976947, 5979.222701048836, 6053.4551890330085, 6061.121137435047, 6152.907706384408, 6237.220347456568, 564850.0, 613822.0, 630849.0, 649402.0, 651269.0, 138484.0, 138756.0, 138956.0, 140500.0, 142422.0, 898.2544488074882, 942.7501712046313, 952.8523078922778, 1031.9845202321972, 1036.0985942230157, 17492.737608935622, 19275.61448771045, 19810.108545115218, 19941.900290498455, 20352.59294814125, 55101.72449137729, 55637.0, 56594.717026414604, 57169.714151428976, 57588.13617795653, 74757.6262118686, 74965.25034749582, 78198.0, 78707.60646196733, 79396.20603793889, 5612.943870561242, 6813.557118787263, 7053.365197132282, 8046.798830029296, 8190.180981901762, 12151.149419540901, 12452.31512266834, 12800.61598152057, 12834.29411382383, 13022.934885325512, 10556.366618002945, 10696.304740191863, 10749.301295415773, 10762.569497220024, 10993.450327483433, 10489.632862849763, 10721.839172412576, 10796.514156863117, 10819.945900270763, 11116.722081948015, 9297.488638124969, 11020.614278500214, 11103.777924441627, 11458.0, 11553.480093395985, 7234.638268086469, 7259.52813067149, 7299.6350182489605, 7403.851922961619, 7453.813654658677, 10213.795724085328, 10857.457127143452, 11057.336559806437, 11065.0, 11313.321200727654], "value": 9117.525481825736, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1538.8845836562255, 1547.4815936661219, 1768.9380871669493, 1899.8860068395888, 1930.2279088364662, 8672.783180420485, 9150.084991500864, 9177.77055573611, 9180.678676246333, 9180.724578262663, 7934.44458887878, 8223.38324625654, 8237.794055148624, 8687.13128687131, 8913.777155571113, 2347.1784875293683, 2402.9639555406598, 2405.56699794037, 2406.831521793475, 2408.927732168038, 2196.5826492966285, 2406.9879650601724, 2410.927672169838, 2453.5706251406023, 2456.778889899909, 2081.157131361801, 2227.7883601057874, 2232.8660280383147, 2364.988175059122, 2446.804255659552, 2424.248482970276, 2454.791342735861, 2455.1161581830524, 2458.2748089313695, 2460.987695061513, 2423.854568725882, 2449.204008697163, 2457.4225057111566, 2459.323685986368, 2463.027104293794, 8926.37515373924, 9149.634014639407, 9158.908410915872, 9159.221466175382, 9191.402558833654, 5307.522322990911, 5476.205950137208, 5477.5070243677865, 5479.506844383985, 5488.670679759187, 3178.6503484616674, 3524.1542029912894, 3614.548181477315, 3739.9626003739886, 3741.925161496782, 1091.476091476096, 1092.9398883061428, 1100.2408338246585, 1118.6476259978162, 1119.770447058351, 12094.395280236042, 12190.81713774294, 12192.939035304767, 12195.45120469572, 12214.145009849313, 4740.715557066587, 4813.711177329372, 4817.867801066746, 4927.236278376858, 4944.456109827916, 10221.182305415548, 10232.59069637221, 10238.59045638181, 10239.283250172566, 10240.436775977392, 5467.917981230285, 5471.37079235885, 5471.8084867029465, 5475.616706830563, 5509.338879334506, 4948.356713627278, 4968.22992436173, 4976.800927962913, 4982.6512144149565, 5004.149294619923, 3996.080901392696, 4000.7799571023875, 4071.6539094176733, 4098.836046558164, 4112.424260603518, 1307.078509650694, 1307.9476820927057, 1308.149702693257, 1324.43711422645, 1326.1645163546905, 643.6492111799081, 770.8283409218069, 881.8897637795276, 939.5208443693765, 945.2937447906457, 5955.821325360246, 5990.251218597676, 6031.095335699592, 6063.181470501514, 6101.420365065401, 913.0641092879719, 957.899420560845, 963.2534785541261, 977.154761131616, 1003.7390278527636, 3370.5112758649857, 3753.11801726594, 3784.829682664287, 3949.4865667463046, 4163.708540402143, 10770.353778773298, 11138.49876755548, 11164.274322169033, 11176.994070533528, 11241.943790280997, 11078.667639970814, 11079.778404431867, 11087.667369978752, 11087.944560277147, 11096.0, 6538.705758240891, 8241.175882411831, 8265.256126948483, 8357.707480238163, 8399.999999999878, 5912.408759124053, 5941.346451890202, 6012.8797424052145, 6104.694765261808, 6173.135760993375, 9914.30599858032, 10157.0, 10377.481125943521, 10455.68632941013, 10458.111060559937, 10617.1506279499, 10636.468176590985, 10637.680869573926, 10644.604963883374, 10644.946775266384, 7695.115061767969, 7696.114946780968, 7887.84224315522, 7889.487183333065, 7900.249476299742, 8421.24208821209, 8488.10874858131, 8495.95752021236, 8569.143085691381, 8597.097304783158, 7644.464887458047, 7697.615119243904, 7731.884021739791, 7743.109542402696, 7940.126586075412, 7488.625568721651, 7506.587137707478, 7541.132769731551, 7566.772996810105, 7667.884981725167, 7095.929040709527, 7246.058012458347, 7249.311315425026, 7252.818679533054, 7257.419406447577, 5005.549500544968, 5013.623978201576, 5059.544640982329, 5076.7207803571155, 5098.592112631055, 4414.713043652152, 5076.492350764894, 5101.540861322499, 5210.296609957607, 5230.947690523046], "value": 4694.419272162182, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.50895277268893, 303.7676177724041, 312.10426077158553, 314.15492325644004, 314.69160222981475, 5314.681119132854, 5549.306336707911, 5560.277163968689, 5598.63608865424, 5664.546836253095, 5331.386890507592, 5454.509094181523, 5465.207544905987, 5493.285872836525, 5535.723213839312, 3831.386978083507, 3857.3828187490008, 4256.361545768129, 4257.126439653237, 4269.444972153624, 3441.4321636929876, 4246.617804397603, 4271.807768650403, 4293.184294983943, 4309.870703878889, 4216.451861258032, 4221.585768767452, 4240.469941257343, 4259.829606815723, 4269.167512335096, 4198.9370159447635, 4215.810288537024, 4230.7038507304505, 4232.280512312914, 4233.809478573472, 3201.943358691626, 3618.5115009473648, 3669.412893936984, 3674.393725035366, 3697.500837386945, 4541.182587134314, 5067.9239811402485, 5435.9886841868765, 5459.0, 5501.559875210014, 4904.0, 4919.508049195088, 4947.724046938412, 4966.261808367079, 4972.403311602595, 5656.943430565683, 5780.71096445176, 5913.438223368773, 5943.821685349447, 5956.404359564052, 3797.5063241778394, 3858.0354911272184, 4035.7376770509823, 4073.5722749111214, 4084.65280451162, 6105.267367915834, 6122.265328160604, 6130.540209484307, 6178.567500274982, 6193.4425901669065, 3864.42033694948, 3878.1274213302345, 4152.730072545275, 4167.395727619478, 4167.8332866685, 3880.1075752577067, 4177.979110104491, 4216.7259128156575, 4223.429836972031, 4226.091390351089, 4133.9793301033305, 4911.607071434277, 4921.384826896638, 4922.187839006596, 4932.679375840559, 5145.099607568661, 5928.7332070056955, 5930.733117009745, 5936.7328470218945, 5947.524198064145, 1297.8702129786946, 1338.788396501168, 1366.071071671273, 1432.3196481671123, 1441.819772528434, 721.6319676964786, 809.5304723260494, 859.7705281447465, 879.7712594725417, 883.5245140615189, 4216.494020717533, 4591.724496530219, 4603.976980115078, 4612.169809434267, 4641.6518761092375, 4194.706370554093, 4538.636909047268, 4880.731559764247, 5019.447860735316, 5064.645474816727, 3909.4917660703927, 4426.822927082945, 4450.732956022649, 4577.267637178035, 4582.885427864263, 2165.6318425867325, 2252.583272094635, 2411.481531470742, 2680.4267902813126, 2687.8924843006453, 4480.171168333869, 4772.665913386029, 5158.174692049254, 5213.322268105122, 5223.895522089537, 4707.105649926503, 5023.949760502422, 5078.822241221614, 5124.282600435942, 5149.356330458692, 5401.756920938567, 6349.68251587428, 6397.45621622158, 6403.871922561522, 6417.2299324081405, 5022.4977502249485, 5069.88462538241, 6188.4739797117745, 6195.411435913581, 6207.765204526458, 4782.760861956958, 5280.524752772269, 5639.6334238274385, 6074.420650630779, 6177.938220617736, 5536.394445610727, 6304.71628776697, 6319.842003949938, 6323.336049714898, 6327.240731112296, 3779.848806047837, 3895.8831235062994, 3914.9804250978564, 3925.4896863407575, 3968.265870813909, 5466.032228397853, 5723.027085395576, 6038.9165737820385, 6062.636241825505, 6097.0, 5658.434156584309, 5831.533477321889, 5906.822795316148, 5908.527317814651, 5910.876933382644, 5522.355245537926, 5852.824415267549, 5899.643082091057, 5959.0, 6011.489023433057, 5455.563554915518, 5763.164341170591, 5765.769369225184, 5766.971165144148, 5822.427944454888, 4919.778609962632, 5067.36336252325, 5169.974150129226, 5397.8110766123, 5505.587080968863, 5072.746362681925, 5787.334456537384, 5787.479126878601, 5793.797217097382, 5797.2173756542325], "value": 4151.74160413417, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.1952194020756, 717.974870879519, 765.0903881167235, 786.1745167574046, 805.4482679364636, 15033.924830375847, 15711.685766284667, 16307.0, 16345.918270408662, 16395.67208655826, 14907.478238261663, 14922.179280139588, 14925.925370373134, 15163.848361516382, 15184.240787960585, 682.2086379799433, 840.7729912923522, 867.9826403471927, 871.1636828644508, 872.2542226396434, 691.1636919327619, 700.3941590524211, 852.9402941794077, 871.5511511571545, 881.6253092435721, 917.3440989692368, 920.2178148573726, 921.0, 921.6037104045258, 922.446532080753, 713.636045616734, 910.8451563234199, 912.4297314178639, 912.6851236323424, 914.4787471141452, 547.1819629653693, 552.4696291560067, 552.5358698693117, 553.2033871225423, 650.9414152726278, 15590.22048897562, 15709.528714138594, 15963.521094367188, 15978.201089945573, 15986.600334991603, 13066.673333166651, 14148.0, 14277.214753188571, 14282.571522854227, 14360.856391436057, 12307.876921230763, 12493.475375445534, 12500.249985000839, 12695.984321254278, 13348.99882508806, 4572.1312950539295, 4627.907441851178, 4659.370984917026, 4707.270373092176, 4819.42166939966, 116669.0, 120637.0, 123068.0, 124452.0, 125560.0, 10624.096951759188, 11104.222704410613, 11184.720381990515, 11303.208775385645, 11434.828477572843, 22479.100835966707, 22715.886420567793, 22897.542049159256, 23097.769022309898, 23137.0, 8042.638081286356, 8098.830479383744, 8198.262156405952, 8285.25432711059, 8359.456635318686, 3974.682025437958, 4269.701120921506, 4400.44994375703, 4549.112922979987, 4550.977245113753, 3436.8281585921104, 3550.840212190458, 3553.09396103997, 3554.4845997330244, 3554.9466757998653, 638.0939066525544, 645.2676212498753, 654.3881470824793, 658.9127938900756, 661.6823924516259, 524.4781442464772, 619.553921176761, 621.5555877547575, 634.5336177909234, 635.6503922842418, 8698.782170496135, 9198.540072996324, 9252.352335336596, 9254.4910029949, 9334.0, 608.1334098909036, 611.1779656362186, 620.3579295429209, 632.2602555010649, 639.8912184928573, 4214.494260688737, 4498.0, 4504.864854054384, 4550.226461501553, 4594.724316541018, 146207.0, 147595.52404476033, 156943.0, 159292.0, 166330.0, 134751.0, 138153.0, 142075.28962355328, 144222.557774423, 144258.0, 102539.48730256301, 116211.99999999831, 118411.0, 119119.0, 119890.0, 9166.908330916605, 9790.410850253671, 9817.232375979112, 10028.849567256351, 10179.440130792582, 56391.87216255734, 60022.79954400975, 61404.07893881506, 62323.376766233574, 63515.6824215876, 66851.66574167098, 78490.0, 83865.58067209624, 90760.54619726859, 91556.08443915742, 11046.116310694964, 11318.151138664469, 11378.54485820558, 11488.770224595293, 12897.742045158857, 13703.314834258048, 14139.293035348397, 14402.639934001734, 14796.852031479548, 15694.450694225647, 11815.586454474053, 13305.800412994007, 14100.224487653277, 14119.43522259098, 14449.133052016912, 12480.875191247971, 13492.86507134916, 13624.250666213453, 14243.0, 14476.782848257495, 12734.554290599785, 13700.93149534246, 14494.710105798036, 14501.564953051426, 14523.201223932785, 10712.0, 11232.382218978035, 11840.407979600814, 12103.394830258629, 12126.818097728717, 9403.388779729295, 10302.024825600984, 10862.340475208717, 11484.540618375171, 11744.177907546731], "value": 7887.381711213721, "unit": "score"}], "name": "dromaeo_css", "value": 7384.135617841684, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 114.0, 115.0, 114.0, 114.0, 115.0, 114.0, 113.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 110.0, 110.0, 146.0, 103.0, 109.0, 109.0, 109.0, 134.0, 107.0], "value": 118.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 184.0, 187.0, 184.0, 181.0, 184.0, 183.0, 185.0, 186.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 75.0, 113.0, 77.0, 57.0, 57.0, 58.0, 82.0, 58.0], "value": 71.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 99.0, 72.0, 68.0, 69.0, 91.0, 68.0, 68.0, 89.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 92.0, 130.0, 87.0, 84.0, 88.0, 84.0, 87.0, 84.0], "value": 90.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 83.0, 85.0, 84.0, 86.0, 85.0, 86.0, 86.0, 86.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 53.0, 52.0, 55.0, 58.0, 57.0, 56.0, 56.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 66.0, 77.0, 71.0, 69.0, 71.0, 70.0, 71.0, 74.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 86.0, 83.0, 80.0, 83.0, 86.0, 89.0, 89.0, 111.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 136.0, 135.0, 133.0, 133.0, 134.0, 137.0, 136.0, 140.0, 139.0], "value": 135.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 169.0, 215.0, 152.0, 205.0, 208.0, 164.0, 162.0, 161.0, 163.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 64.0, 85.0, 66.0, 67.0, 69.0, 66.0, 66.0, 67.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1429.5, "alertThreshold": 2.0}]} 13:14:06 INFO - Return code: 0 13:14:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:14:06 INFO - # TBPL SUCCESS # 13:14:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:14:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:14:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:14:06 INFO - 2016-09-27 13:14:06.926 screenresolution[1967:21108] starting screenresolution argv=screenresolution get 13:14:06 INFO - 2016-09-27 13:14:06.929 screenresolution[1967:21108] Display 0: 1600x1200x32@60 13:14:06 INFO - 2016-09-27 13:14:06.934 screenresolution[1968:21111] starting screenresolution argv=screenresolution list 13:14:06 INFO - Available Modes on Display 0 13:14:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:14:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:14:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:14:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:14:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:14:07 INFO - Intel Iris: 13:14:07 INFO - Chipset Model: Intel Iris 13:14:07 INFO - Type: GPU 13:14:07 INFO - Bus: Built-In 13:14:07 INFO - VRAM (Dynamic, Max): 1536 MB 13:14:07 INFO - Vendor: Intel (0x8086) 13:14:07 INFO - Device ID: 0x0a2e 13:14:07 INFO - Revision ID: 0x0009 13:14:07 INFO - Displays: 13:14:07 INFO - Display: 13:14:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:14:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:14:07 INFO - Display Serial Number: 1600x1200 60 13:14:07 INFO - Main Display: Yes 13:14:07 INFO - Mirror: Off 13:14:07 INFO - Online: Yes 13:14:07 INFO - Rotation: Supported 13:14:07 INFO - Return code: 0 13:14:07 INFO - Running post-action listener: _resource_record_post_action 13:14:07 INFO - [mozharness: 2016-09-27 20:14:07.169147Z] Finished run-tests step (success) 13:14:07 INFO - Running post-run listener: _resource_record_post_run 13:14:07 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 880640; Write bytes: 662801920; Read time: 7; Write time: 1872 13:14:07 INFO - TinderboxPrint: CPU usage
53.6% 13:14:07 INFO - TinderboxPrint: I/O read bytes / time
880,640 / 7 13:14:07 INFO - TinderboxPrint: I/O write bytes / time
662,801,920 / 1,872 13:14:07 INFO - TinderboxPrint: CPU idle
2,243.4 (46.4%) 13:14:07 INFO - TinderboxPrint: CPU system
969.9 (20.1%) 13:14:07 INFO - TinderboxPrint: CPU user
1,620.4 (33.5%) 13:14:07 INFO - TinderboxPrint: Swap in / out
363,192,320 / 0 13:14:07 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 354089472; Write bytes: 355031040; Read time: 27001; Write time: 715 13:14:07 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 880640; Write bytes: 297588224; Read time: 7; Write time: 1120 13:14:07 INFO - Running post-run listener: _upload_blobber_files 13:14:07 INFO - Blob upload gear active. 13:14:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:14:07 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 13:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:14:08 INFO - (blobuploader) - INFO - Open directory for files ... 13:14:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:14:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:14:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:09 INFO - (blobuploader) - INFO - Done attempting. 13:14:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:14:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:14:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:11 INFO - (blobuploader) - INFO - Done attempting. 13:14:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:14:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:14:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:13 INFO - (blobuploader) - INFO - Done attempting. 13:14:13 INFO - (blobuploader) - INFO - Iteration through files over. 13:14:13 INFO - Return code: 0 13:14:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:14:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:14:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1df8dc3088aa0165a77d6ec92aff3c9a740a42d2e7d945921e9e22239594fcaf0b46098076adc2236117f609a0b40c7541ce1c878c8c5cd6aca6f29b2a126faa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/316165b4469bcf5bab3dd3f522a2ab858892f5f60656218d2aa6b32840aee912431f8f281a636f3eb77d365fb58040cc4290e53c944b010674be3afb06c50826", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82c97071e943857ad04dcdcd9f55e28acfb43925d568f2fff10e021fb185f37e705a509d96b824d61b8b39dcc5ace03d84186e4a666d2a461cc6c48ad7171ebc"} 13:14:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:14:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:14:13 INFO - Contents: 13:14:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1df8dc3088aa0165a77d6ec92aff3c9a740a42d2e7d945921e9e22239594fcaf0b46098076adc2236117f609a0b40c7541ce1c878c8c5cd6aca6f29b2a126faa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/316165b4469bcf5bab3dd3f522a2ab858892f5f60656218d2aa6b32840aee912431f8f281a636f3eb77d365fb58040cc4290e53c944b010674be3afb06c50826", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82c97071e943857ad04dcdcd9f55e28acfb43925d568f2fff10e021fb185f37e705a509d96b824d61b8b39dcc5ace03d84186e4a666d2a461cc6c48ad7171ebc"} 13:14:13 INFO - Running post-run listener: copy_logs_to_upload_dir 13:14:13 INFO - Copying logs to upload dir... 13:14:13 INFO - mkdir: /builds/slave/test/build/upload/logs 13:14:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.850623 ========= master_lag: 1.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-27 13:14:15.262476) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 13:14:15.269342) ========= 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.uR62rkhhVY/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.sHD85xq9Sc/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1df8dc3088aa0165a77d6ec92aff3c9a740a42d2e7d945921e9e22239594fcaf0b46098076adc2236117f609a0b40c7541ce1c878c8c5cd6aca6f29b2a126faa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/316165b4469bcf5bab3dd3f522a2ab858892f5f60656218d2aa6b32840aee912431f8f281a636f3eb77d365fb58040cc4290e53c944b010674be3afb06c50826", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82c97071e943857ad04dcdcd9f55e28acfb43925d568f2fff10e021fb185f37e705a509d96b824d61b8b39dcc5ace03d84186e4a666d2a461cc6c48ad7171ebc"} build_url:https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/QByTarQdRg67LgTCCFx9rg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1df8dc3088aa0165a77d6ec92aff3c9a740a42d2e7d945921e9e22239594fcaf0b46098076adc2236117f609a0b40c7541ce1c878c8c5cd6aca6f29b2a126faa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/316165b4469bcf5bab3dd3f522a2ab858892f5f60656218d2aa6b32840aee912431f8f281a636f3eb77d365fb58040cc4290e53c944b010674be3afb06c50826", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/82c97071e943857ad04dcdcd9f55e28acfb43925d568f2fff10e021fb185f37e705a509d96b824d61b8b39dcc5ace03d84186e4a666d2a461cc6c48ad7171ebc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 13:14:15.302287) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 13:14:15.302616) ========= 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.uR62rkhhVY/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.sHD85xq9Sc/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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.005262 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 13:14:15.357947) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 13:14:15.358304) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 13:14:15.358676) ========= ========= Total master_lag: 1.49 =========